{"level":"warn","ts":"2026-05-04T18:07:55.892546Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T18:07:55.892645Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.215:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.215:2380","--initial-cluster=instance=https://199.19.213.215:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.215:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.215: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-05-04T18:07:55.892702Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T18:07:55.892712Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.215:2380"]}
{"level":"info","ts":"2026-05-04T18:07:55.892729Z","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-05-04T18:07:55.893325Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.215:2379"]}
{"level":"info","ts":"2026-05-04T18:07:55.893393Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.215:2380"],"listen-peer-urls":["https://199.19.213.215:2380"],"advertise-client-urls":["https://199.19.213.215:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.215:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.215: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-05-04T18:07:55.898849Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.28221ms"}
{"level":"info","ts":"2026-05-04T18:07:55.905353Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e6e5712872899056","cluster-id":"5d812b997db5c8f"}
{"level":"info","ts":"2026-05-04T18:07:55.905418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-04T18:07:55.905439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 became follower at term 0"}
{"level":"info","ts":"2026-05-04T18:07:55.905455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e6e5712872899056 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-04T18:07:55.905468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 became follower at term 1"}
{"level":"info","ts":"2026-05-04T18:07:55.905505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 switched to configuration voters=(16637828816924414038)"}
{"level":"warn","ts":"2026-05-04T18:07:55.919494Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-04T18:07:55.921111Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-04T18:07:55.923002Z","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-05-04T18:07:55.926674Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e6e5712872899056","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-04T18:07:55.926882Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e6e5712872899056","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-04T18:07:55.927074Z","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-05-04T18:07:55.927229Z","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-05-04T18:07:55.927256Z","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-05-04T18:07:55.928828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 switched to configuration voters=(16637828816924414038)"}
{"level":"info","ts":"2026-05-04T18:07:55.93019Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5d812b997db5c8f","local-member-id":"e6e5712872899056","added-peer-id":"e6e5712872899056","added-peer-peer-urls":["https://199.19.213.215:2380"]}
{"level":"info","ts":"2026-05-04T18:07:55.931917Z","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-05-04T18:07:55.932158Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e6e5712872899056","initial-advertise-peer-urls":["https://199.19.213.215:2380"],"listen-peer-urls":["https://199.19.213.215:2380"],"advertise-client-urls":["https://199.19.213.215:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.215:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-04T18:07:55.932205Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-04T18:07:55.932447Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.215:2380"}
{"level":"info","ts":"2026-05-04T18:07:55.932595Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.215:2380"}
{"level":"info","ts":"2026-05-04T18:07:56.406527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-04T18:07:56.406591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-04T18:07:56.406636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 received MsgPreVoteResp from e6e5712872899056 at term 1"}
{"level":"info","ts":"2026-05-04T18:07:56.406669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 became candidate at term 2"}
{"level":"info","ts":"2026-05-04T18:07:56.4067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 received MsgVoteResp from e6e5712872899056 at term 2"}
{"level":"info","ts":"2026-05-04T18:07:56.406732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e6e5712872899056 became leader at term 2"}
{"level":"info","ts":"2026-05-04T18:07:56.406758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e6e5712872899056 elected leader e6e5712872899056 at term 2"}
{"level":"info","ts":"2026-05-04T18:07:56.407823Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T18:07:56.407832Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e6e5712872899056","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.215:2379]}","request-path":"/0/members/e6e5712872899056/attributes","cluster-id":"5d812b997db5c8f","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-04T18:07:56.407836Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:07:56.408046Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T18:07:56.408156Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-04T18:07:56.408208Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-04T18:07:56.408776Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5d812b997db5c8f","local-member-id":"e6e5712872899056","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:07:56.40885Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:07:56.408873Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T18:07:56.410946Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.215:2379"}
{"level":"info","ts":"2026-05-04T18:07:56.411173Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-04T18:08:16.071906Z","caller":"traceutil/trace.go:171","msg":"trace[963275486] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"100.278802ms","start":"2026-05-04T18:08:15.971599Z","end":"2026-05-04T18:08:16.071878Z","steps":["trace[963275486] 'process raft request'  (duration: 100.083548ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:16.09571Z","caller":"traceutil/trace.go:171","msg":"trace[1358688164] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"122.178694ms","start":"2026-05-04T18:08:15.973495Z","end":"2026-05-04T18:08:16.095673Z","steps":["trace[1358688164] 'process raft request'  (duration: 121.95025ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:27.210019Z","caller":"traceutil/trace.go:171","msg":"trace[2118782982] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"109.341883ms","start":"2026-05-04T18:08:27.10066Z","end":"2026-05-04T18:08:27.210001Z","steps":["trace[2118782982] 'process raft request'  (duration: 101.612728ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:27.213444Z","caller":"traceutil/trace.go:171","msg":"trace[1227290587] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"111.382521ms","start":"2026-05-04T18:08:27.102027Z","end":"2026-05-04T18:08:27.213409Z","steps":["trace[1227290587] 'process raft request'  (duration: 111.155596ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:27.213587Z","caller":"traceutil/trace.go:171","msg":"trace[1444789484] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"108.444195ms","start":"2026-05-04T18:08:27.105129Z","end":"2026-05-04T18:08:27.213573Z","steps":["trace[1444789484] 'process raft request'  (duration: 108.22757ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:27.213893Z","caller":"traceutil/trace.go:171","msg":"trace[1763721676] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"105.372378ms","start":"2026-05-04T18:08:27.108508Z","end":"2026-05-04T18:08:27.213881Z","steps":["trace[1763721676] 'process raft request'  (duration: 105.019292ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:27.214092Z","caller":"traceutil/trace.go:171","msg":"trace[1199466628] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"105.256916ms","start":"2026-05-04T18:08:27.108828Z","end":"2026-05-04T18:08:27.214085Z","steps":["trace[1199466628] 'process raft request'  (duration: 104.94614ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:27.214173Z","caller":"traceutil/trace.go:171","msg":"trace[2084230362] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"101.26337ms","start":"2026-05-04T18:08:27.112886Z","end":"2026-05-04T18:08:27.214149Z","steps":["trace[2084230362] 'process raft request'  (duration: 101.054576ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:27.327878Z","caller":"traceutil/trace.go:171","msg":"trace[2027797900] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"100.371873ms","start":"2026-05-04T18:08:27.227468Z","end":"2026-05-04T18:08:27.32784Z","steps":["trace[2027797900] 'process raft request'  (duration: 92.307662ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:33.561256Z","caller":"traceutil/trace.go:171","msg":"trace[724116719] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"158.895371ms","start":"2026-05-04T18:08:33.402334Z","end":"2026-05-04T18:08:33.561229Z","steps":["trace[724116719] 'process raft request'  (duration: 158.29922ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:33.881183Z","caller":"traceutil/trace.go:171","msg":"trace[2107251405] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"268.144643ms","start":"2026-05-04T18:08:33.612982Z","end":"2026-05-04T18:08:33.881126Z","steps":["trace[2107251405] 'process raft request'  (duration: 267.9551ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:33.885347Z","caller":"traceutil/trace.go:171","msg":"trace[408589874] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"269.560199ms","start":"2026-05-04T18:08:33.615743Z","end":"2026-05-04T18:08:33.885303Z","steps":["trace[408589874] 'process raft request'  (duration: 269.329025ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:08:34.404125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.685109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-04T18:08:34.404221Z","caller":"traceutil/trace.go:171","msg":"trace[1794468739] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:582; }","duration":"206.799461ms","start":"2026-05-04T18:08:34.1974Z","end":"2026-05-04T18:08:34.4042Z","steps":["trace[1794468739] 'range keys from in-memory index tree'  (duration: 206.553886ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:08:34.404099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.709408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-05-04T18:08:34.404096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.107912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:08:34.404344Z","caller":"traceutil/trace.go:171","msg":"trace[544279621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"239.978314ms","start":"2026-05-04T18:08:34.164334Z","end":"2026-05-04T18:08:34.404313Z","steps":["trace[544279621] 'range keys from in-memory index tree'  (duration: 239.546706ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:34.404357Z","caller":"traceutil/trace.go:171","msg":"trace[73081980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"333.414428ms","start":"2026-05-04T18:08:34.070915Z","end":"2026-05-04T18:08:34.404329Z","steps":["trace[73081980] 'range keys from in-memory index tree'  (duration: 333.035141ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:08:34.404404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:08:34.070893Z","time spent":"333.497819ms","remote":"127.0.0.1:59100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-04T18:08:34.404945Z","caller":"traceutil/trace.go:171","msg":"trace[143800594] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"108.103479ms","start":"2026-05-04T18:08:34.296826Z","end":"2026-05-04T18:08:34.404929Z","steps":["trace[143800594] 'process raft request'  (duration: 102.553105ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:08:49.924901Z","caller":"traceutil/trace.go:171","msg":"trace[282085909] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"157.349203ms","start":"2026-05-04T18:08:49.767527Z","end":"2026-05-04T18:08:49.924877Z","steps":["trace[282085909] 'process raft request'  (duration: 156.988357ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:09:51.025741Z","caller":"traceutil/trace.go:171","msg":"trace[579567016] transaction","detail":"{read_only:false; response_revision:1625; number_of_response:1; }","duration":"101.68063ms","start":"2026-05-04T18:09:50.924003Z","end":"2026-05-04T18:09:51.025684Z","steps":["trace[579567016] 'process raft request'  (duration: 77.075395ms)","trace[579567016] 'compare'  (duration: 24.304579ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:10:03.945291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.926795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2ec59dca-5f67-4f0d-99f9-5ef88a6d7783\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-04T18:10:03.945414Z","caller":"traceutil/trace.go:171","msg":"trace[2052265295] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2ec59dca-5f67-4f0d-99f9-5ef88a6d7783; range_end:; response_count:1; response_revision:1809; }","duration":"191.120828ms","start":"2026-05-04T18:10:03.754274Z","end":"2026-05-04T18:10:03.945395Z","steps":["trace[2052265295] 'range keys from in-memory index tree'  (duration: 190.728601ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:10:03.945302Z","caller":"traceutil/trace.go:171","msg":"trace[1162616372] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"175.964252ms","start":"2026-05-04T18:10:03.769308Z","end":"2026-05-04T18:10:03.945272Z","steps":["trace[1162616372] 'process raft request'  (duration: 158.104334ms)","trace[1162616372] 'compare'  (duration: 17.728626ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:10:04.36927Z","caller":"traceutil/trace.go:171","msg":"trace[986365534] linearizableReadLoop","detail":"{readStateIndex:1886; appliedIndex:1885; }","duration":"136.685311ms","start":"2026-05-04T18:10:04.232549Z","end":"2026-05-04T18:10:04.369234Z","steps":["trace[986365534] 'read index received'  (duration: 136.404786ms)","trace[986365534] 'applied index is now lower than readState.Index'  (duration: 279.485µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:10:04.369536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.982826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-04T18:10:04.369514Z","caller":"traceutil/trace.go:171","msg":"trace[635865266] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"157.229298ms","start":"2026-05-04T18:10:04.212227Z","end":"2026-05-04T18:10:04.369457Z","steps":["trace[635865266] 'process raft request'  (duration: 156.79566ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:10:04.369616Z","caller":"traceutil/trace.go:171","msg":"trace[822512286] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1813; }","duration":"137.14135ms","start":"2026-05-04T18:10:04.232449Z","end":"2026-05-04T18:10:04.369591Z","steps":["trace[822512286] 'agreement among raft nodes before linearized reading'  (duration: 136.900425ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:10:17.136929Z","caller":"traceutil/trace.go:171","msg":"trace[159276947] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"110.287438ms","start":"2026-05-04T18:10:17.026597Z","end":"2026-05-04T18:10:17.136885Z","steps":["trace[159276947] 'process raft request'  (duration: 56.572281ms)","trace[159276947] 'compare'  (duration: 53.402681ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:10:20.921933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.441729ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509464212 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1927 > 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-05-04T18:10:20.922154Z","caller":"traceutil/trace.go:171","msg":"trace[207469510] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"122.042668ms","start":"2026-05-04T18:10:20.800094Z","end":"2026-05-04T18:10:20.922136Z","steps":["trace[207469510] 'process raft request'  (duration: 121.972136ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:10:20.922172Z","caller":"traceutil/trace.go:171","msg":"trace[579059091] linearizableReadLoop","detail":"{readStateIndex:2025; appliedIndex:2024; }","duration":"262.46739ms","start":"2026-05-04T18:10:20.659666Z","end":"2026-05-04T18:10:20.922133Z","steps":["trace[579059091] 'read index received'  (duration: 94.356579ms)","trace[579059091] 'applied index is now lower than readState.Index'  (duration: 168.107781ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:10:20.922218Z","caller":"traceutil/trace.go:171","msg":"trace[2010755827] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"309.054153ms","start":"2026-05-04T18:10:20.613043Z","end":"2026-05-04T18:10:20.922097Z","steps":["trace[2010755827] 'process raft request'  (duration: 140.916922ms)","trace[2010755827] 'compare'  (duration: 167.286545ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:10:20.922443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.750095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-05-04T18:10:20.922564Z","caller":"traceutil/trace.go:171","msg":"trace[1823220466] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1949; }","duration":"262.920058ms","start":"2026-05-04T18:10:20.65962Z","end":"2026-05-04T18:10:20.92254Z","steps":["trace[1823220466] 'agreement among raft nodes before linearized reading'  (duration: 262.609323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:10:20.92263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:10:20.613019Z","time spent":"309.391129ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:1927 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T18:10:59.956112Z","caller":"traceutil/trace.go:171","msg":"trace[335302715] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"141.632925ms","start":"2026-05-04T18:10:59.814453Z","end":"2026-05-04T18:10:59.956086Z","steps":["trace[335302715] 'process raft request'  (duration: 141.464252ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:11:00.197628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.253653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:11:00.197718Z","caller":"traceutil/trace.go:171","msg":"trace[959317371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2165; }","duration":"129.396416ms","start":"2026-05-04T18:11:00.068301Z","end":"2026-05-04T18:11:00.197698Z","steps":["trace[959317371] 'range keys from in-memory index tree'  (duration: 129.16531ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:12:17.288808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.031321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:12:17.288962Z","caller":"traceutil/trace.go:171","msg":"trace[644634839] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2776; }","duration":"138.265636ms","start":"2026-05-04T18:12:17.150674Z","end":"2026-05-04T18:12:17.28894Z","steps":["trace[644634839] 'count revisions from in-memory index tree'  (duration: 137.862338ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:12:17.459341Z","caller":"traceutil/trace.go:171","msg":"trace[130937614] transaction","detail":"{read_only:false; response_revision:2777; number_of_response:1; }","duration":"116.907663ms","start":"2026-05-04T18:12:17.3424Z","end":"2026-05-04T18:12:17.459308Z","steps":["trace[130937614] 'process raft request'  (duration: 116.715249ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:12:17.736634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.439165ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T18:12:17.736794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.696874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-04T18:12:17.736856Z","caller":"traceutil/trace.go:171","msg":"trace[42186956] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2777; }","duration":"124.675989ms","start":"2026-05-04T18:12:17.612147Z","end":"2026-05-04T18:12:17.736823Z","steps":["trace[42186956] 'range keys from in-memory index tree'  (duration: 124.415084ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:12:17.736922Z","caller":"traceutil/trace.go:171","msg":"trace[85775615] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2777; }","duration":"203.918618ms","start":"2026-05-04T18:12:17.532974Z","end":"2026-05-04T18:12:17.736893Z","steps":["trace[85775615] 'range keys from in-memory index tree'  (duration: 203.333717ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:12:17.736996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.004252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-04T18:12:17.737083Z","caller":"traceutil/trace.go:171","msg":"trace[379045065] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2777; }","duration":"174.119765ms","start":"2026-05-04T18:12:17.562943Z","end":"2026-05-04T18:12:17.737063Z","steps":["trace[379045065] 'range keys from in-memory index tree'  (duration: 173.746328ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:12:17.791094Z","caller":"traceutil/trace.go:171","msg":"trace[1109325494] transaction","detail":"{read_only:false; response_revision:2778; number_of_response:1; }","duration":"147.536752ms","start":"2026-05-04T18:12:17.643526Z","end":"2026-05-04T18:12:17.791063Z","steps":["trace[1109325494] 'process raft request'  (duration: 147.377149ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:12:17.792056Z","caller":"traceutil/trace.go:171","msg":"trace[1421620454] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"146.050424ms","start":"2026-05-04T18:12:17.645943Z","end":"2026-05-04T18:12:17.791994Z","steps":["trace[1421620454] 'process raft request'  (duration: 145.807239ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:12:17.792341Z","caller":"traceutil/trace.go:171","msg":"trace[1675200354] transaction","detail":"{read_only:false; response_revision:2780; number_of_response:1; }","duration":"131.765614ms","start":"2026-05-04T18:12:17.660549Z","end":"2026-05-04T18:12:17.792314Z","steps":["trace[1675200354] 'process raft request'  (duration: 131.390467ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:18.56726Z","caller":"traceutil/trace.go:171","msg":"trace[354091929] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"103.377526ms","start":"2026-05-04T18:16:18.463827Z","end":"2026-05-04T18:16:18.567204Z","steps":["trace[354091929] 'process raft request'  (duration: 11.059678ms)","trace[354091929] 'compare'  (duration: 91.978481ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:16:23.804605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.091098ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509471553 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/monitoring/vector-l88hq\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/monitoring/vector-l88hq\" value_size:2433 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-04T18:16:23.805064Z","caller":"traceutil/trace.go:171","msg":"trace[2008988340] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"258.969402ms","start":"2026-05-04T18:16:23.546071Z","end":"2026-05-04T18:16:23.80504Z","steps":["trace[2008988340] 'process raft request'  (duration: 120.375215ms)","trace[2008988340] 'compare'  (duration: 137.939155ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:16:23.805281Z","caller":"traceutil/trace.go:171","msg":"trace[585137294] linearizableReadLoop","detail":"{readStateIndex:5226; appliedIndex:5225; }","duration":"245.001241ms","start":"2026-05-04T18:16:23.559724Z","end":"2026-05-04T18:16:23.804725Z","steps":["trace[585137294] 'read index received'  (duration: 106.720069ms)","trace[585137294] 'applied index is now lower than readState.Index'  (duration: 138.279602ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:16:23.805548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.045252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-831e6701-873d-4e2b-8dd1-d3fcc6eb6169\" ","response":"range_response_count:1 size:3601"}
{"level":"warn","ts":"2026-05-04T18:16:23.805574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.076659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-04T18:16:23.805607Z","caller":"traceutil/trace.go:171","msg":"trace[1417925762] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-831e6701-873d-4e2b-8dd1-d3fcc6eb6169; range_end:; response_count:1; response_revision:5036; }","duration":"185.152905ms","start":"2026-05-04T18:16:23.620442Z","end":"2026-05-04T18:16:23.805595Z","steps":["trace[1417925762] 'agreement among raft nodes before linearized reading'  (duration: 184.961821ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:23.805626Z","caller":"traceutil/trace.go:171","msg":"trace[263505414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5036; }","duration":"146.17126ms","start":"2026-05-04T18:16:23.659439Z","end":"2026-05-04T18:16:23.80561Z","steps":["trace[263505414] 'agreement among raft nodes before linearized reading'  (duration: 145.967636ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:16:23.806097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.894377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"}
{"level":"info","ts":"2026-05-04T18:16:23.806383Z","caller":"traceutil/trace.go:171","msg":"trace[238536911] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:5036; }","duration":"246.671873ms","start":"2026-05-04T18:16:23.559671Z","end":"2026-05-04T18:16:23.806343Z","steps":["trace[238536911] 'agreement among raft nodes before linearized reading'  (duration: 245.447299ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:23.938064Z","caller":"traceutil/trace.go:171","msg":"trace[1612398775] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"127.604681ms","start":"2026-05-04T18:16:23.810427Z","end":"2026-05-04T18:16:23.938032Z","steps":["trace[1612398775] 'process raft request'  (duration: 119.941977ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:24.364183Z","caller":"traceutil/trace.go:171","msg":"trace[1785942974] linearizableReadLoop","detail":"{readStateIndex:5228; appliedIndex:5227; }","duration":"202.94356ms","start":"2026-05-04T18:16:24.1612Z","end":"2026-05-04T18:16:24.364143Z","steps":["trace[1785942974] 'read index received'  (duration: 202.672215ms)","trace[1785942974] 'applied index is now lower than readState.Index'  (duration: 263.954µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:16:24.364561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.328646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-2742m\" ","response":"range_response_count:1 size:6445"}
{"level":"info","ts":"2026-05-04T18:16:24.364619Z","caller":"traceutil/trace.go:171","msg":"trace[1808337670] range","detail":"{range_begin:/registry/pods/openstack/keepalived-2742m; range_end:; response_count:1; response_revision:5038; }","duration":"203.464209ms","start":"2026-05-04T18:16:24.16114Z","end":"2026-05-04T18:16:24.364604Z","steps":["trace[1808337670] 'agreement among raft nodes before linearized reading'  (duration: 203.161853ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:24.365443Z","caller":"traceutil/trace.go:171","msg":"trace[2031198692] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"245.52221ms","start":"2026-05-04T18:16:24.119879Z","end":"2026-05-04T18:16:24.365401Z","steps":["trace[2031198692] 'process raft request'  (duration: 244.011022ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:24.767515Z","caller":"traceutil/trace.go:171","msg":"trace[1099697122] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"285.255978ms","start":"2026-05-04T18:16:24.482223Z","end":"2026-05-04T18:16:24.767479Z","steps":["trace[1099697122] 'process raft request'  (duration: 285.054245ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:24.857093Z","caller":"traceutil/trace.go:171","msg":"trace[850844246] linearizableReadLoop","detail":"{readStateIndex:5230; appliedIndex:5229; }","duration":"286.172406ms","start":"2026-05-04T18:16:24.570879Z","end":"2026-05-04T18:16:24.857051Z","steps":["trace[850844246] 'read index received'  (duration: 197.220632ms)","trace[850844246] 'applied index is now lower than readState.Index'  (duration: 88.949324ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:16:24.857494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.612953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-05-04T18:16:24.857519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.593003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-04T18:16:24.857594Z","caller":"traceutil/trace.go:171","msg":"trace[1036102407] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5039; }","duration":"244.750386ms","start":"2026-05-04T18:16:24.612787Z","end":"2026-05-04T18:16:24.857537Z","steps":["trace[1036102407] 'agreement among raft nodes before linearized reading'  (duration: 244.490241ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:24.857657Z","caller":"traceutil/trace.go:171","msg":"trace[2115976299] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5039; }","duration":"286.807778ms","start":"2026-05-04T18:16:24.570819Z","end":"2026-05-04T18:16:24.857627Z","steps":["trace[2115976299] 'agreement among raft nodes before linearized reading'  (duration: 286.40946ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:38.877742Z","caller":"traceutil/trace.go:171","msg":"trace[1820523602] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"113.016637ms","start":"2026-05-04T18:16:38.764704Z","end":"2026-05-04T18:16:38.877721Z","steps":["trace[1820523602] 'process raft request'  (duration: 112.804222ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:38.954958Z","caller":"traceutil/trace.go:171","msg":"trace[1218272554] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"131.843342ms","start":"2026-05-04T18:16:38.823074Z","end":"2026-05-04T18:16:38.954918Z","steps":["trace[1218272554] 'process raft request'  (duration: 71.512987ms)","trace[1218272554] 'compare'  (duration: 60.046429ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:16:39.405562Z","caller":"traceutil/trace.go:171","msg":"trace[845088755] linearizableReadLoop","detail":"{readStateIndex:5495; appliedIndex:5494; }","duration":"145.333845ms","start":"2026-05-04T18:16:39.260189Z","end":"2026-05-04T18:16:39.405523Z","steps":["trace[845088755] 'read index received'  (duration: 145.040229ms)","trace[845088755] 'applied index is now lower than readState.Index'  (duration: 292.176µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:16:39.40596Z","caller":"traceutil/trace.go:171","msg":"trace[1769584877] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"174.600216ms","start":"2026-05-04T18:16:39.231344Z","end":"2026-05-04T18:16:39.405944Z","steps":["trace[1769584877] 'process raft request'  (duration: 173.984654ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:16:39.406379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.16741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-05-04T18:16:39.406429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.463743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-cf56b6468-wt8fl\" ","response":"range_response_count:1 size:7666"}
{"level":"info","ts":"2026-05-04T18:16:39.406485Z","caller":"traceutil/trace.go:171","msg":"trace[2065130973] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-cf56b6468-wt8fl; range_end:; response_count:1; response_revision:5297; }","duration":"106.600385ms","start":"2026-05-04T18:16:39.299868Z","end":"2026-05-04T18:16:39.406468Z","steps":["trace[2065130973] 'agreement among raft nodes before linearized reading'  (duration: 106.356431ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:39.40649Z","caller":"traceutil/trace.go:171","msg":"trace[213617819] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5297; }","duration":"146.335393ms","start":"2026-05-04T18:16:39.260128Z","end":"2026-05-04T18:16:39.406464Z","steps":["trace[213617819] 'agreement among raft nodes before linearized reading'  (duration: 146.018247ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:16:39.406512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.362906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-04T18:16:39.406626Z","caller":"traceutil/trace.go:171","msg":"trace[1990779321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5297; }","duration":"128.5593ms","start":"2026-05-04T18:16:39.278043Z","end":"2026-05-04T18:16:39.406602Z","steps":["trace[1990779321] 'agreement among raft nodes before linearized reading'  (duration: 128.02765ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:16:39.676298Z","caller":"traceutil/trace.go:171","msg":"trace[1672028457] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"265.14577ms","start":"2026-05-04T18:16:39.41111Z","end":"2026-05-04T18:16:39.676256Z","steps":["trace[1672028457] 'process raft request'  (duration: 252.604483ms)","trace[1672028457] 'compare'  (duration: 12.182669ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:16:39.748321Z","caller":"traceutil/trace.go:171","msg":"trace[472276772] linearizableReadLoop","detail":"{readStateIndex:5498; appliedIndex:5495; }","duration":"262.771104ms","start":"2026-05-04T18:16:39.485522Z","end":"2026-05-04T18:16:39.748293Z","steps":["trace[472276772] 'read index received'  (duration: 178.262553ms)","trace[472276772] 'applied index is now lower than readState.Index'  (duration: 84.50699ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:16:39.74853Z","caller":"traceutil/trace.go:171","msg":"trace[312486093] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"336.91682ms","start":"2026-05-04T18:16:39.411592Z","end":"2026-05-04T18:16:39.748509Z","steps":["trace[312486093] 'process raft request'  (duration: 336.473711ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:16:39.748935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.392287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.215\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-04T18:16:39.748983Z","caller":"traceutil/trace.go:171","msg":"trace[1088029842] range","detail":"{range_begin:/registry/masterleases/199.19.213.215; range_end:; response_count:1; response_revision:5300; }","duration":"263.52161ms","start":"2026-05-04T18:16:39.485452Z","end":"2026-05-04T18:16:39.748974Z","steps":["trace[1088029842] 'agreement among raft nodes before linearized reading'  (duration: 263.305275ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:16:39.749046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:16:39.411584Z","time spent":"337.331258ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5253 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-04T18:16:39.748673Z","caller":"traceutil/trace.go:171","msg":"trace[87408907] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"333.001895ms","start":"2026-05-04T18:16:39.415632Z","end":"2026-05-04T18:16:39.748633Z","steps":["trace[87408907] 'process raft request'  (duration: 332.593927ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:16:39.749288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:16:39.415599Z","time spent":"333.558926ms","remote":"127.0.0.1:59268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7957,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/memcached-memcached-cf56b6468-wt8fl\" mod_revision:5274 > success:<request_put:<key:\"/registry/pods/openstack/memcached-memcached-cf56b6468-wt8fl\" value_size:7889 >> failure:<request_range:<key:\"/registry/pods/openstack/memcached-memcached-cf56b6468-wt8fl\" > >"}
{"level":"info","ts":"2026-05-04T18:16:47.268506Z","caller":"traceutil/trace.go:171","msg":"trace[1441787253] transaction","detail":"{read_only:false; response_revision:5500; number_of_response:1; }","duration":"102.765643ms","start":"2026-05-04T18:16:47.165705Z","end":"2026-05-04T18:16:47.268471Z","steps":["trace[1441787253] 'process raft request'  (duration: 102.508858ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:17:56.496787Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2993}
{"level":"info","ts":"2026-05-04T18:17:56.562027Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2993,"took":"63.981957ms","hash":3296486203,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":34222080,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-05-04T18:17:56.562115Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3296486203,"revision":2993,"compact-revision":-1}
{"level":"info","ts":"2026-05-04T18:22:53.940312Z","caller":"traceutil/trace.go:171","msg":"trace[800560308] transaction","detail":"{read_only:false; response_revision:8293; number_of_response:1; }","duration":"219.228515ms","start":"2026-05-04T18:22:53.721051Z","end":"2026-05-04T18:22:53.94028Z","steps":["trace[800560308] 'process raft request'  (duration: 219.046032ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:22:54.00854Z","caller":"traceutil/trace.go:171","msg":"trace[758027399] transaction","detail":"{read_only:false; response_revision:8294; number_of_response:1; }","duration":"283.648819ms","start":"2026-05-04T18:22:53.724867Z","end":"2026-05-04T18:22:54.008516Z","steps":["trace[758027399] 'process raft request'  (duration: 281.448588ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:22:56.513125Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6111}
{"level":"info","ts":"2026-05-04T18:22:56.61598Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6111,"took":"100.964536ms","hash":3574627997,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":23904256,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-05-04T18:22:56.616053Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3574627997,"revision":6111,"compact-revision":2993}
{"level":"warn","ts":"2026-05-04T18:23:06.484291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.409598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:23:06.484388Z","caller":"traceutil/trace.go:171","msg":"trace[1043572532] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:8358; }","duration":"234.625343ms","start":"2026-05-04T18:23:06.249742Z","end":"2026-05-04T18:23:06.484368Z","steps":["trace[1043572532] 'count revisions from in-memory index tree'  (duration: 234.279285ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:23:07.408291Z","caller":"traceutil/trace.go:171","msg":"trace[2104507313] transaction","detail":"{read_only:false; response_revision:8364; number_of_response:1; }","duration":"197.949088ms","start":"2026-05-04T18:23:07.210313Z","end":"2026-05-04T18:23:07.408262Z","steps":["trace[2104507313] 'process raft request'  (duration: 197.768735ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:23:35.741172Z","caller":"traceutil/trace.go:171","msg":"trace[463856060] linearizableReadLoop","detail":"{readStateIndex:8872; appliedIndex:8871; }","duration":"233.851848ms","start":"2026-05-04T18:23:35.507291Z","end":"2026-05-04T18:23:35.741143Z","steps":["trace[463856060] 'read index received'  (duration: 233.595134ms)","trace[463856060] 'applied index is now lower than readState.Index'  (duration: 255.864µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:23:35.746434Z","caller":"traceutil/trace.go:171","msg":"trace[2092478497] transaction","detail":"{read_only:false; response_revision:8569; number_of_response:1; }","duration":"253.69185ms","start":"2026-05-04T18:23:35.492695Z","end":"2026-05-04T18:23:35.746386Z","steps":["trace[2092478497] 'process raft request'  (duration: 248.279798ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:23:35.746806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.491334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-05-04T18:23:35.746861Z","caller":"traceutil/trace.go:171","msg":"trace[2144255361] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:8569; }","duration":"239.621786ms","start":"2026-05-04T18:23:35.507227Z","end":"2026-05-04T18:23:35.746849Z","steps":["trace[2144255361] 'agreement among raft nodes before linearized reading'  (duration: 239.433403ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:23:35.747089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.755191ms","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-05-04T18:23:35.747163Z","caller":"traceutil/trace.go:171","msg":"trace[319274864] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8569; }","duration":"199.842382ms","start":"2026-05-04T18:23:35.547291Z","end":"2026-05-04T18:23:35.747134Z","steps":["trace[319274864] 'agreement among raft nodes before linearized reading'  (duration: 199.686959ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:23:35.935817Z","caller":"traceutil/trace.go:171","msg":"trace[753692903] linearizableReadLoop","detail":"{readStateIndex:8873; appliedIndex:8872; }","duration":"184.73471ms","start":"2026-05-04T18:23:35.751017Z","end":"2026-05-04T18:23:35.935752Z","steps":["trace[753692903] 'read index received'  (duration: 129.094902ms)","trace[753692903] 'applied index is now lower than readState.Index'  (duration: 55.637758ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:23:35.935991Z","caller":"traceutil/trace.go:171","msg":"trace[879467339] transaction","detail":"{read_only:false; response_revision:8570; number_of_response:1; }","duration":"185.240891ms","start":"2026-05-04T18:23:35.75073Z","end":"2026-05-04T18:23:35.935971Z","steps":["trace[879467339] 'process raft request'  (duration: 129.435359ms)","trace[879467339] 'compare'  (duration: 55.21083ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:23:35.936411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.364463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-794ba87d-2c32-4522-b58a-c91fe1551ec3\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-05-04T18:23:35.936465Z","caller":"traceutil/trace.go:171","msg":"trace[1710592896] range","detail":"{range_begin:/registry/persistentvolumes/pvc-794ba87d-2c32-4522-b58a-c91fe1551ec3; range_end:; response_count:1; response_revision:8570; }","duration":"185.450925ms","start":"2026-05-04T18:23:35.750997Z","end":"2026-05-04T18:23:35.936447Z","steps":["trace[1710592896] 'agreement among raft nodes before linearized reading'  (duration: 185.231241ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:23:35.937086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.46405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-04T18:23:35.937201Z","caller":"traceutil/trace.go:171","msg":"trace[351878250] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8570; }","duration":"166.632823ms","start":"2026-05-04T18:23:35.770541Z","end":"2026-05-04T18:23:35.937173Z","steps":["trace[351878250] 'agreement among raft nodes before linearized reading'  (duration: 165.943771ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:23:38.996395Z","caller":"traceutil/trace.go:171","msg":"trace[1075760031] transaction","detail":"{read_only:false; response_revision:8587; number_of_response:1; }","duration":"132.427403ms","start":"2026-05-04T18:23:38.863926Z","end":"2026-05-04T18:23:38.996353Z","steps":["trace[1075760031] 'process raft request'  (duration: 53.429068ms)","trace[1075760031] 'compare'  (duration: 78.492366ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:23:39.040522Z","caller":"traceutil/trace.go:171","msg":"trace[1771942519] transaction","detail":"{read_only:false; response_revision:8588; number_of_response:1; }","duration":"176.160361ms","start":"2026-05-04T18:23:38.864333Z","end":"2026-05-04T18:23:39.040494Z","steps":["trace[1771942519] 'process raft request'  (duration: 175.827575ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:23:48.393811Z","caller":"traceutil/trace.go:171","msg":"trace[855446497] transaction","detail":"{read_only:false; response_revision:8679; number_of_response:1; }","duration":"132.295062ms","start":"2026-05-04T18:23:48.26149Z","end":"2026-05-04T18:23:48.393786Z","steps":["trace[855446497] 'process raft request'  (duration: 131.796922ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:23:48.499244Z","caller":"traceutil/trace.go:171","msg":"trace[368072369] transaction","detail":"{read_only:false; response_revision:8681; number_of_response:1; }","duration":"100.813263ms","start":"2026-05-04T18:23:48.398396Z","end":"2026-05-04T18:23:48.499209Z","steps":["trace[368072369] 'process raft request'  (duration: 100.757432ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:23:48.499418Z","caller":"traceutil/trace.go:171","msg":"trace[796183805] transaction","detail":"{read_only:false; response_revision:8680; number_of_response:1; }","duration":"101.505826ms","start":"2026-05-04T18:23:48.397873Z","end":"2026-05-04T18:23:48.499378Z","steps":["trace[796183805] 'process raft request'  (duration: 69.274474ms)","trace[796183805] 'compare'  (duration: 31.838075ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:23:48.841648Z","caller":"traceutil/trace.go:171","msg":"trace[1747940618] transaction","detail":"{read_only:false; response_revision:8683; number_of_response:1; }","duration":"128.183913ms","start":"2026-05-04T18:23:48.713437Z","end":"2026-05-04T18:23:48.84162Z","steps":["trace[1747940618] 'process raft request'  (duration: 121.276035ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:24:03.847002Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023aa.wal"}
{"level":"info","ts":"2026-05-04T18:25:01.485473Z","caller":"traceutil/trace.go:171","msg":"trace[1862944691] transaction","detail":"{read_only:false; response_revision:9416; number_of_response:1; }","duration":"129.605923ms","start":"2026-05-04T18:25:01.355833Z","end":"2026-05-04T18:25:01.485439Z","steps":["trace[1862944691] 'process raft request'  (duration: 129.376199ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:25:35.234537Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e6e5712872899056","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T18:25:35.239406Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-04T18:25:35.239488Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-04T18:27:56.51911Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8308}
{"level":"info","ts":"2026-05-04T18:27:56.600997Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8308,"took":"80.097784ms","hash":3802378640,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":26288128,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-04T18:27:56.601073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3802378640,"revision":8308,"compact-revision":6111}
{"level":"info","ts":"2026-05-04T18:29:05.595903Z","caller":"traceutil/trace.go:171","msg":"trace[1434982570] transaction","detail":"{read_only:false; response_revision:11365; number_of_response:1; }","duration":"116.628527ms","start":"2026-05-04T18:29:05.479235Z","end":"2026-05-04T18:29:05.595863Z","steps":["trace[1434982570] 'process raft request'  (duration: 116.391302ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:32:56.524802Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10762}
{"level":"info","ts":"2026-05-04T18:32:56.603588Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10762,"took":"75.113919ms","hash":3572631233,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":26656768,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-05-04T18:32:56.60366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3572631233,"revision":10762,"compact-revision":8308}
{"level":"info","ts":"2026-05-04T18:37:54.793934Z","caller":"traceutil/trace.go:171","msg":"trace[405749767] transaction","detail":"{read_only:false; response_revision:14690; number_of_response:1; }","duration":"151.328441ms","start":"2026-05-04T18:37:54.642576Z","end":"2026-05-04T18:37:54.793905Z","steps":["trace[405749767] 'process raft request'  (duration: 151.150067ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:37:56.530147Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12862}
{"level":"info","ts":"2026-05-04T18:37:56.606376Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12862,"took":"73.638466ms","hash":839346679,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":24854528,"current-db-size-in-use":"25 MB"}
{"level":"info","ts":"2026-05-04T18:37:56.606474Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":839346679,"revision":12862,"compact-revision":10762}
{"level":"info","ts":"2026-05-04T18:38:04.561927Z","caller":"traceutil/trace.go:171","msg":"trace[464086798] linearizableReadLoop","detail":"{readStateIndex:15372; appliedIndex:15371; }","duration":"204.963394ms","start":"2026-05-04T18:38:04.356933Z","end":"2026-05-04T18:38:04.561896Z","steps":["trace[464086798] 'read index received'  (duration: 204.77432ms)","trace[464086798] 'applied index is now lower than readState.Index'  (duration: 187.974µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:38:04.562011Z","caller":"traceutil/trace.go:171","msg":"trace[681546244] transaction","detail":"{read_only:false; response_revision:14858; number_of_response:1; }","duration":"232.037031ms","start":"2026-05-04T18:38:04.329926Z","end":"2026-05-04T18:38:04.561963Z","steps":["trace[681546244] 'process raft request'  (duration: 231.802606ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:38:04.562193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.240738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-05-04T18:38:04.562209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.640798ms","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-05-04T18:38:04.562262Z","caller":"traceutil/trace.go:171","msg":"trace[477055278] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14858; }","duration":"205.355131ms","start":"2026-05-04T18:38:04.356871Z","end":"2026-05-04T18:38:04.562226Z","steps":["trace[477055278] 'agreement among raft nodes before linearized reading'  (duration: 205.193018ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:38:04.562296Z","caller":"traceutil/trace.go:171","msg":"trace[617256825] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14858; }","duration":"203.75746ms","start":"2026-05-04T18:38:04.358513Z","end":"2026-05-04T18:38:04.562271Z","steps":["trace[617256825] 'agreement among raft nodes before linearized reading'  (duration: 203.628918ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:38:04.562464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.925948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T18:38:04.562582Z","caller":"traceutil/trace.go:171","msg":"trace[322591285] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:14858; }","duration":"162.063242ms","start":"2026-05-04T18:38:04.400499Z","end":"2026-05-04T18:38:04.562562Z","steps":["trace[322591285] 'agreement among raft nodes before linearized reading'  (duration: 161.857627ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:38:04.748828Z","caller":"traceutil/trace.go:171","msg":"trace[485033623] transaction","detail":"{read_only:false; response_revision:14859; number_of_response:1; }","duration":"181.105788ms","start":"2026-05-04T18:38:04.567695Z","end":"2026-05-04T18:38:04.7488Z","steps":["trace[485033623] 'process raft request'  (duration: 173.845532ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:38:04.748978Z","caller":"traceutil/trace.go:171","msg":"trace[1969901705] transaction","detail":"{read_only:false; response_revision:14860; number_of_response:1; }","duration":"180.085368ms","start":"2026-05-04T18:38:04.568885Z","end":"2026-05-04T18:38:04.74897Z","steps":["trace[1969901705] 'process raft request'  (duration: 179.68039ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:38:04.749041Z","caller":"traceutil/trace.go:171","msg":"trace[1308313721] transaction","detail":"{read_only:false; response_revision:14861; number_of_response:1; }","duration":"168.358988ms","start":"2026-05-04T18:38:04.580639Z","end":"2026-05-04T18:38:04.748998Z","steps":["trace[1308313721] 'process raft request'  (duration: 168.070843ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:39:44.550365Z","caller":"traceutil/trace.go:171","msg":"trace[288426181] transaction","detail":"{read_only:false; response_revision:15951; number_of_response:1; }","duration":"127.658279ms","start":"2026-05-04T18:39:44.422677Z","end":"2026-05-04T18:39:44.550336Z","steps":["trace[288426181] 'process raft request'  (duration: 127.425825ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:39:44.723551Z","caller":"traceutil/trace.go:171","msg":"trace[275109583] linearizableReadLoop","detail":"{readStateIndex:16501; appliedIndex:16499; }","duration":"213.454855ms","start":"2026-05-04T18:39:44.510064Z","end":"2026-05-04T18:39:44.723519Z","steps":["trace[275109583] 'read index received'  (duration: 40.1092ms)","trace[275109583] 'applied index is now lower than readState.Index'  (duration: 173.344005ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:39:44.723648Z","caller":"traceutil/trace.go:171","msg":"trace[380604396] transaction","detail":"{read_only:false; response_revision:15952; number_of_response:1; }","duration":"242.713493ms","start":"2026-05-04T18:39:44.480859Z","end":"2026-05-04T18:39:44.723573Z","steps":["trace[380604396] 'process raft request'  (duration: 208.295909ms)","trace[380604396] 'compare'  (duration: 33.967046ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:39:44.723857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.63977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"info","ts":"2026-05-04T18:39:44.723913Z","caller":"traceutil/trace.go:171","msg":"trace[289452395] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15952; }","duration":"212.761972ms","start":"2026-05-04T18:39:44.511137Z","end":"2026-05-04T18:39:44.723899Z","steps":["trace[289452395] 'agreement among raft nodes before linearized reading'  (duration: 212.559929ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:39:44.723975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.994485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T18:39:44.724122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.292131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:39:44.724139Z","caller":"traceutil/trace.go:171","msg":"trace[1671595815] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15952; }","duration":"136.21848ms","start":"2026-05-04T18:39:44.587897Z","end":"2026-05-04T18:39:44.724116Z","steps":["trace[1671595815] 'agreement among raft nodes before linearized reading'  (duration: 135.980926ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:39:44.724236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.397474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T18:39:44.724298Z","caller":"traceutil/trace.go:171","msg":"trace[1384125785] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15952; }","duration":"136.907222ms","start":"2026-05-04T18:39:44.587374Z","end":"2026-05-04T18:39:44.724282Z","steps":["trace[1384125785] 'agreement among raft nodes before linearized reading'  (duration: 136.792ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:39:44.724324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.024996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"}
{"level":"warn","ts":"2026-05-04T18:39:44.724324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.148772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-05-04T18:39:44.724406Z","caller":"traceutil/trace.go:171","msg":"trace[899150414] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15952; }","duration":"136.124677ms","start":"2026-05-04T18:39:44.588259Z","end":"2026-05-04T18:39:44.724383Z","steps":["trace[899150414] 'agreement among raft nodes before linearized reading'  (duration: 135.916583ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:39:44.724154Z","caller":"traceutil/trace.go:171","msg":"trace[1632979800] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15952; }","duration":"136.360413ms","start":"2026-05-04T18:39:44.587785Z","end":"2026-05-04T18:39:44.724145Z","steps":["trace[1632979800] 'agreement among raft nodes before linearized reading'  (duration: 136.311872ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:39:44.72441Z","caller":"traceutil/trace.go:171","msg":"trace[1552904331] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15952; }","duration":"212.257093ms","start":"2026-05-04T18:39:44.512134Z","end":"2026-05-04T18:39:44.724391Z","steps":["trace[1552904331] 'agreement among raft nodes before linearized reading'  (duration: 212.016939ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:39:44.723699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.624218ms","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-05-04T18:39:44.724612Z","caller":"traceutil/trace.go:171","msg":"trace[1738264431] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15952; }","duration":"214.589316ms","start":"2026-05-04T18:39:44.510003Z","end":"2026-05-04T18:39:44.724592Z","steps":["trace[1738264431] 'agreement among raft nodes before linearized reading'  (duration: 213.632109ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:42:56.53753Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14702}
{"level":"info","ts":"2026-05-04T18:42:56.61688Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14702,"took":"75.778689ms","hash":299110791,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":32256000,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-04T18:42:56.616967Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":299110791,"revision":14702,"compact-revision":12862}
{"level":"warn","ts":"2026-05-04T18:45:25.778753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.308454ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509511518 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:18558 > 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:18"}
{"level":"info","ts":"2026-05-04T18:45:25.778901Z","caller":"traceutil/trace.go:171","msg":"trace[625104728] transaction","detail":"{read_only:false; response_revision:18574; number_of_response:1; }","duration":"159.513563ms","start":"2026-05-04T18:45:25.619367Z","end":"2026-05-04T18:45:25.77888Z","steps":["trace[625104728] 'process raft request'  (duration: 33.961785ms)","trace[625104728] 'compare'  (duration: 125.019649ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:45:26.674194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.601243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-q898n\" ","response":"range_response_count:1 size:20771"}
{"level":"info","ts":"2026-05-04T18:45:26.674327Z","caller":"traceutil/trace.go:171","msg":"trace[1786674240] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-q898n; range_end:; response_count:1; response_revision:18578; }","duration":"361.807697ms","start":"2026-05-04T18:45:26.312496Z","end":"2026-05-04T18:45:26.674304Z","steps":["trace[1786674240] 'range keys from in-memory index tree'  (duration: 361.350788ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:45:26.674368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:45:26.312464Z","time spent":"361.894679ms","remote":"127.0.0.1:59268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20794,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-q898n\" "}
{"level":"warn","ts":"2026-05-04T18:45:26.67545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.965629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-rvgt9\" ","response":"range_response_count:1 size:22015"}
{"level":"info","ts":"2026-05-04T18:45:26.675485Z","caller":"traceutil/trace.go:171","msg":"trace[235589621] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-rvgt9; range_end:; response_count:1; response_revision:18578; }","duration":"262.064691ms","start":"2026-05-04T18:45:26.413409Z","end":"2026-05-04T18:45:26.675473Z","steps":["trace[235589621] 'range keys from in-memory index tree'  (duration: 261.782866ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:46:36.682183Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e6e5712872899056","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T18:46:36.690257Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-04T18:46:36.690371Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-04T18:47:56.544567Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17473}
{"level":"info","ts":"2026-05-04T18:47:56.655365Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17473,"took":"106.91598ms","hash":1974872315,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":35155968,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-05-04T18:47:56.655466Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1974872315,"revision":17473,"compact-revision":14702}
{"level":"info","ts":"2026-05-04T18:50:53.472822Z","caller":"traceutil/trace.go:171","msg":"trace[401416578] transaction","detail":"{read_only:false; response_revision:21074; number_of_response:1; }","duration":"107.322105ms","start":"2026-05-04T18:50:53.365466Z","end":"2026-05-04T18:50:53.472788Z","steps":["trace[401416578] 'process raft request'  (duration: 74.658594ms)","trace[401416578] 'compare'  (duration: 32.410136ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:50:53.732976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.044227ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509518579 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:21033 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:50:53.733097Z","caller":"traceutil/trace.go:171","msg":"trace[1279870069] linearizableReadLoop","detail":"{readStateIndex:21791; appliedIndex:21790; }","duration":"176.395176ms","start":"2026-05-04T18:50:53.556685Z","end":"2026-05-04T18:50:53.73308Z","steps":["trace[1279870069] 'read index received'  (duration: 20.098045ms)","trace[1279870069] 'applied index is now lower than readState.Index'  (duration: 156.296081ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:50:53.73318Z","caller":"traceutil/trace.go:171","msg":"trace[893614043] transaction","detail":"{read_only:false; response_revision:21075; number_of_response:1; }","duration":"311.061303ms","start":"2026-05-04T18:50:53.422108Z","end":"2026-05-04T18:50:53.733169Z","steps":["trace[893614043] 'process raft request'  (duration: 154.742571ms)","trace[893614043] 'compare'  (duration: 155.933445ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:50:53.733299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.778657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-04T18:50:53.733342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:50:53.422087Z","time spent":"311.124384ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:21033 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-05-04T18:50:53.733359Z","caller":"traceutil/trace.go:171","msg":"trace[1857855154] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:21075; }","duration":"113.870128ms","start":"2026-05-04T18:50:53.619472Z","end":"2026-05-04T18:50:53.733342Z","steps":["trace[1857855154] 'agreement among raft nodes before linearized reading'  (duration: 113.755906ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:50:53.733379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.659501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:50:53.733452Z","caller":"traceutil/trace.go:171","msg":"trace[491518314] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:21075; }","duration":"176.780194ms","start":"2026-05-04T18:50:53.556653Z","end":"2026-05-04T18:50:53.733433Z","steps":["trace[491518314] 'agreement among raft nodes before linearized reading'  (duration: 176.605551ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:52:56.552157Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19861}
{"level":"info","ts":"2026-05-04T18:52:56.667176Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19861,"took":"110.546435ms","hash":2720212101,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":30441472,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-04T18:52:56.667234Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2720212101,"revision":19861,"compact-revision":17473}
{"level":"info","ts":"2026-05-04T18:54:45.472545Z","caller":"traceutil/trace.go:171","msg":"trace[535074032] transaction","detail":"{read_only:false; response_revision:23490; number_of_response:1; }","duration":"108.572859ms","start":"2026-05-04T18:54:45.363928Z","end":"2026-05-04T18:54:45.472501Z","steps":["trace[535074032] 'process raft request'  (duration: 95.487375ms)","trace[535074032] 'compare'  (duration: 12.608955ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:54:45.732376Z","caller":"traceutil/trace.go:171","msg":"trace[1701894146] linearizableReadLoop","detail":"{readStateIndex:24283; appliedIndex:24281; }","duration":"159.593093ms","start":"2026-05-04T18:54:45.572761Z","end":"2026-05-04T18:54:45.732355Z","steps":["trace[1701894146] 'read index received'  (duration: 154.947847ms)","trace[1701894146] 'applied index is now lower than readState.Index'  (duration: 4.644446ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:54:45.732457Z","caller":"traceutil/trace.go:171","msg":"trace[206722157] transaction","detail":"{read_only:false; response_revision:23492; number_of_response:1; }","duration":"163.906343ms","start":"2026-05-04T18:54:45.568503Z","end":"2026-05-04T18:54:45.732409Z","steps":["trace[206722157] 'process raft request'  (duration: 163.74644ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:54:45.732477Z","caller":"traceutil/trace.go:171","msg":"trace[1234286855] transaction","detail":"{read_only:false; response_revision:23491; number_of_response:1; }","duration":"242.822807ms","start":"2026-05-04T18:54:45.489592Z","end":"2026-05-04T18:54:45.732415Z","steps":["trace[1234286855] 'process raft request'  (duration: 238.189321ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:54:45.732677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.886658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-05-04T18:54:45.73275Z","caller":"traceutil/trace.go:171","msg":"trace[1362556156] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:23492; }","duration":"160.006491ms","start":"2026-05-04T18:54:45.572724Z","end":"2026-05-04T18:54:45.732731Z","steps":["trace[1362556156] 'agreement among raft nodes before linearized reading'  (duration: 159.748005ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:54:45.886812Z","caller":"traceutil/trace.go:171","msg":"trace[1484446495] transaction","detail":"{read_only:false; response_revision:23494; number_of_response:1; }","duration":"149.108437ms","start":"2026-05-04T18:54:45.737678Z","end":"2026-05-04T18:54:45.886786Z","steps":["trace[1484446495] 'process raft request'  (duration: 148.943774ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:57:56.559092Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22088}
{"level":"info","ts":"2026-05-04T18:57:56.667349Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22088,"took":"104.761737ms","hash":1609540034,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":42946560,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-05-04T18:57:56.667409Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1609540034,"revision":22088,"compact-revision":19861}
{"level":"warn","ts":"2026-05-04T18:58:17.357001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.842655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11714"}
{"level":"info","ts":"2026-05-04T18:58:17.357127Z","caller":"traceutil/trace.go:171","msg":"trace[350801210] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25618; }","duration":"123.007788ms","start":"2026-05-04T18:58:17.2341Z","end":"2026-05-04T18:58:17.357107Z","steps":["trace[350801210] 'range keys from in-memory index tree'  (duration: 122.631962ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:18.272522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.095176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:18.272619Z","caller":"traceutil/trace.go:171","msg":"trace[520791198] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:25623; }","duration":"179.189268ms","start":"2026-05-04T18:58:18.093392Z","end":"2026-05-04T18:58:18.272581Z","steps":["trace[520791198] 'count revisions from in-memory index tree'  (duration: 179.010865ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.03113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.44145ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509530669 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25612 > 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:18"}
{"level":"info","ts":"2026-05-04T18:58:19.031231Z","caller":"traceutil/trace.go:171","msg":"trace[1434890169] linearizableReadLoop","detail":"{readStateIndex:26475; appliedIndex:26474; }","duration":"239.335682ms","start":"2026-05-04T18:58:18.791879Z","end":"2026-05-04T18:58:19.031215Z","steps":["trace[1434890169] 'read index received'  (duration: 88.562455ms)","trace[1434890169] 'applied index is now lower than readState.Index'  (duration: 150.771797ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:19.031301Z","caller":"traceutil/trace.go:171","msg":"trace[2029166993] transaction","detail":"{read_only:false; response_revision:25627; number_of_response:1; }","duration":"284.822843ms","start":"2026-05-04T18:58:18.746466Z","end":"2026-05-04T18:58:19.031289Z","steps":["trace[2029166993] 'process raft request'  (duration: 133.979804ms)","trace[2029166993] 'compare'  (duration: 150.274267ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:19.031515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.634469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-04T18:58:19.031571Z","caller":"traceutil/trace.go:171","msg":"trace[1373468207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25627; }","duration":"239.72946ms","start":"2026-05-04T18:58:18.791828Z","end":"2026-05-04T18:58:19.031558Z","steps":["trace[1373468207] 'agreement among raft nodes before linearized reading'  (duration: 239.554736ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.296352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.436497ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509530670 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25616 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:58:19.296463Z","caller":"traceutil/trace.go:171","msg":"trace[1320405550] linearizableReadLoop","detail":"{readStateIndex:26476; appliedIndex:26475; }","duration":"265.191514ms","start":"2026-05-04T18:58:19.031255Z","end":"2026-05-04T18:58:19.296446Z","steps":["trace[1320405550] 'read index received'  (duration: 157.670086ms)","trace[1320405550] 'applied index is now lower than readState.Index'  (duration: 107.520128ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:19.296723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.196468ms","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-05-04T18:58:19.296837Z","caller":"traceutil/trace.go:171","msg":"trace[1246845959] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25628; }","duration":"347.35702ms","start":"2026-05-04T18:58:18.949456Z","end":"2026-05-04T18:58:19.296813Z","steps":["trace[1246845959] 'agreement among raft nodes before linearized reading'  (duration: 347.076355ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.296883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:18.94944Z","time spent":"347.432411ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-04T18:58:19.296905Z","caller":"traceutil/trace.go:171","msg":"trace[2032280033] transaction","detail":"{read_only:false; response_revision:25628; number_of_response:1; }","duration":"328.116461ms","start":"2026-05-04T18:58:18.968746Z","end":"2026-05-04T18:58:19.296862Z","steps":["trace[2032280033] 'process raft request'  (duration: 220.076913ms)","trace[2032280033] 'compare'  (duration: 107.261554ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:19.297422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:18.968717Z","time spent":"328.264543ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25616 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:19.297867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.749466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-04T18:58:19.297922Z","caller":"traceutil/trace.go:171","msg":"trace[525360263] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25628; }","duration":"470.832967ms","start":"2026-05-04T18:58:18.827077Z","end":"2026-05-04T18:58:19.29791Z","steps":["trace[525360263] 'agreement among raft nodes before linearized reading'  (duration: 469.600984ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.297959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:18.827065Z","time spent":"470.884689ms","remote":"127.0.0.1:59170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":2649,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-05-04T18:58:19.298212Z","caller":"traceutil/trace.go:171","msg":"trace[950157199] transaction","detail":"{read_only:false; response_revision:25629; number_of_response:1; }","duration":"262.151289ms","start":"2026-05-04T18:58:19.036045Z","end":"2026-05-04T18:58:19.298196Z","steps":["trace[950157199] 'process raft request'  (duration: 260.843194ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.298425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.618926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:19.298498Z","caller":"traceutil/trace.go:171","msg":"trace[1989030857] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:25630; }","duration":"233.724168ms","start":"2026-05-04T18:58:19.064756Z","end":"2026-05-04T18:58:19.29848Z","steps":["trace[1989030857] 'agreement among raft nodes before linearized reading'  (duration: 233.587405ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:19.298433Z","caller":"traceutil/trace.go:171","msg":"trace[1981358239] transaction","detail":"{read_only:false; response_revision:25630; number_of_response:1; }","duration":"131.676081ms","start":"2026-05-04T18:58:19.166743Z","end":"2026-05-04T18:58:19.298419Z","steps":["trace[1981358239] 'process raft request'  (duration: 131.393655ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.298583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.296691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T18:58:19.298644Z","caller":"traceutil/trace.go:171","msg":"trace[1652996532] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:25630; }","duration":"208.421003ms","start":"2026-05-04T18:58:19.090205Z","end":"2026-05-04T18:58:19.298626Z","steps":["trace[1652996532] 'agreement among raft nodes before linearized reading'  (duration: 208.306861ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.298893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.290332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-04T18:58:19.298986Z","caller":"traceutil/trace.go:171","msg":"trace[1289277846] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25630; }","duration":"155.439134ms","start":"2026-05-04T18:58:19.143527Z","end":"2026-05-04T18:58:19.298966Z","steps":["trace[1289277846] 'agreement among raft nodes before linearized reading'  (duration: 154.935814ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:19.493096Z","caller":"traceutil/trace.go:171","msg":"trace[398892875] linearizableReadLoop","detail":"{readStateIndex:26480; appliedIndex:26479; }","duration":"108.966946ms","start":"2026-05-04T18:58:19.384105Z","end":"2026-05-04T18:58:19.493071Z","steps":["trace[398892875] 'read index received'  (duration: 93.61686ms)","trace[398892875] 'applied index is now lower than readState.Index'  (duration: 15.348866ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:19.493148Z","caller":"traceutil/trace.go:171","msg":"trace[1469024348] transaction","detail":"{read_only:false; response_revision:25632; number_of_response:1; }","duration":"190.848906ms","start":"2026-05-04T18:58:19.302273Z","end":"2026-05-04T18:58:19.493122Z","steps":["trace[1469024348] 'process raft request'  (duration: 175.441999ms)","trace[1469024348] 'compare'  (duration: 15.196783ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:19.493346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.240551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-04T18:58:19.493386Z","caller":"traceutil/trace.go:171","msg":"trace[1157581109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25632; }","duration":"109.337823ms","start":"2026-05-04T18:58:19.384039Z","end":"2026-05-04T18:58:19.493376Z","steps":["trace[1157581109] 'agreement among raft nodes before linearized reading'  (duration: 109.17556ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.493395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.65983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-04T18:58:19.493475Z","caller":"traceutil/trace.go:171","msg":"trace[1364985760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25632; }","duration":"108.763032ms","start":"2026-05-04T18:58:19.384694Z","end":"2026-05-04T18:58:19.493457Z","steps":["trace[1364985760] 'agreement among raft nodes before linearized reading'  (duration: 108.568038ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:19.863344Z","caller":"traceutil/trace.go:171","msg":"trace[1934364191] transaction","detail":"{read_only:false; response_revision:25633; number_of_response:1; }","duration":"366.384277ms","start":"2026-05-04T18:58:19.496897Z","end":"2026-05-04T18:58:19.863281Z","steps":["trace[1934364191] 'process raft request'  (duration: 366.174432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.863513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:19.496875Z","time spent":"366.558169ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25619 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-04T18:58:19.885021Z","caller":"traceutil/trace.go:171","msg":"trace[643711457] transaction","detail":"{read_only:false; response_revision:25634; number_of_response:1; }","duration":"388.093751ms","start":"2026-05-04T18:58:19.496907Z","end":"2026-05-04T18:58:19.885Z","steps":["trace[643711457] 'process raft request'  (duration: 387.948409ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.885205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:19.49689Z","time spent":"388.244324ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25620 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-04T18:58:19.885396Z","caller":"traceutil/trace.go:171","msg":"trace[644390978] transaction","detail":"{read_only:false; response_revision:25635; number_of_response:1; }","duration":"378.824288ms","start":"2026-05-04T18:58:19.506548Z","end":"2026-05-04T18:58:19.885372Z","steps":["trace[644390978] 'process raft request'  (duration: 378.406951ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:19.885421Z","caller":"traceutil/trace.go:171","msg":"trace[567531395] linearizableReadLoop","detail":"{readStateIndex:26483; appliedIndex:26480; }","duration":"256.672426ms","start":"2026-05-04T18:58:19.628726Z","end":"2026-05-04T18:58:19.885399Z","steps":["trace[567531395] 'read index received'  (duration: 234.303658ms)","trace[567531395] 'applied index is now lower than readState.Index'  (duration: 22.367588ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:19.885465Z","caller":"traceutil/trace.go:171","msg":"trace[409253694] transaction","detail":"{read_only:false; response_revision:25636; number_of_response:1; }","duration":"156.972173ms","start":"2026-05-04T18:58:19.728468Z","end":"2026-05-04T18:58:19.88544Z","steps":["trace[409253694] 'process raft request'  (duration: 156.774839ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:19.885516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:19.506532Z","time spent":"378.92875ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25621 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:19.885639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.903251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.215\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-05-04T18:58:19.885679Z","caller":"traceutil/trace.go:171","msg":"trace[990704102] range","detail":"{range_begin:/registry/masterleases/199.19.213.215; range_end:; response_count:1; response_revision:25637; }","duration":"256.994863ms","start":"2026-05-04T18:58:19.628674Z","end":"2026-05-04T18:58:19.885669Z","steps":["trace[990704102] 'agreement among raft nodes before linearized reading'  (duration: 256.829739ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:19.885886Z","caller":"traceutil/trace.go:171","msg":"trace[1532465203] transaction","detail":"{read_only:false; response_revision:25637; number_of_response:1; }","duration":"100.612999ms","start":"2026-05-04T18:58:19.784966Z","end":"2026-05-04T18:58:19.885579Z","steps":["trace[1532465203] 'process raft request'  (duration: 100.385695ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:20.104261Z","caller":"traceutil/trace.go:171","msg":"trace[551655821] linearizableReadLoop","detail":"{readStateIndex:26486; appliedIndex:26485; }","duration":"107.094712ms","start":"2026-05-04T18:58:19.997135Z","end":"2026-05-04T18:58:20.104229Z","steps":["trace[551655821] 'read index received'  (duration: 29.42817ms)","trace[551655821] 'applied index is now lower than readState.Index'  (duration: 77.664632ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:20.104548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.375507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T18:58:20.104632Z","caller":"traceutil/trace.go:171","msg":"trace[157998383] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25637; }","duration":"107.51803ms","start":"2026-05-04T18:58:19.997093Z","end":"2026-05-04T18:58:20.104611Z","steps":["trace[157998383] 'agreement among raft nodes before linearized reading'  (duration: 107.323896ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:20.168723Z","caller":"traceutil/trace.go:171","msg":"trace[323093343] transaction","detail":"{read_only:false; response_revision:25638; number_of_response:1; }","duration":"116.418376ms","start":"2026-05-04T18:58:20.052271Z","end":"2026-05-04T18:58:20.16869Z","steps":["trace[323093343] 'process raft request'  (duration: 116.014698ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:21.146878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.207783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:21.147008Z","caller":"traceutil/trace.go:171","msg":"trace[1130356529] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25642; }","duration":"183.401837ms","start":"2026-05-04T18:58:20.963583Z","end":"2026-05-04T18:58:21.146985Z","steps":["trace[1130356529] 'range keys from in-memory index tree'  (duration: 183.114862ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:21.147069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.833458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackservers/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackservers0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:21.147151Z","caller":"traceutil/trace.go:171","msg":"trace[112468026] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackservers/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackservers0; response_count:0; response_revision:25642; }","duration":"211.977301ms","start":"2026-05-04T18:58:20.935157Z","end":"2026-05-04T18:58:21.147134Z","steps":["trace[112468026] 'count revisions from in-memory index tree'  (duration: 211.744947ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:21.147376Z","caller":"traceutil/trace.go:171","msg":"trace[1943800005] transaction","detail":"{read_only:false; response_revision:25643; number_of_response:1; }","duration":"110.091197ms","start":"2026-05-04T18:58:21.037252Z","end":"2026-05-04T18:58:21.147344Z","steps":["trace[1943800005] 'process raft request'  (duration: 70.703301ms)","trace[1943800005] 'compare'  (duration: 38.617552ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:21.687534Z","caller":"traceutil/trace.go:171","msg":"trace[1420274035] linearizableReadLoop","detail":"{readStateIndex:26493; appliedIndex:26492; }","duration":"383.294812ms","start":"2026-05-04T18:58:21.304208Z","end":"2026-05-04T18:58:21.687503Z","steps":["trace[1420274035] 'read index received'  (duration: 383.113179ms)","trace[1420274035] 'applied index is now lower than readState.Index'  (duration: 180.453µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:21.687789Z","caller":"traceutil/trace.go:171","msg":"trace[265529346] transaction","detail":"{read_only:false; response_revision:25644; number_of_response:1; }","duration":"385.295829ms","start":"2026-05-04T18:58:21.302437Z","end":"2026-05-04T18:58:21.687732Z","steps":["trace[265529346] 'process raft request'  (duration: 384.867761ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:21.688006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:21.302411Z","time spent":"385.464293ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25628 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:21.687989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.7373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-05-04T18:58:21.688078Z","caller":"traceutil/trace.go:171","msg":"trace[1047940489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25644; }","duration":"383.881373ms","start":"2026-05-04T18:58:21.304177Z","end":"2026-05-04T18:58:21.688058Z","steps":["trace[1047940489] 'agreement among raft nodes before linearized reading'  (duration: 383.577458ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:21.688137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:21.304164Z","time spent":"383.962664ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-04T18:58:21.900498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.109301ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509530710 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25630 > 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-05-04T18:58:21.900788Z","caller":"traceutil/trace.go:171","msg":"trace[1560703734] transaction","detail":"{read_only:false; response_revision:25646; number_of_response:1; }","duration":"207.751572ms","start":"2026-05-04T18:58:21.693018Z","end":"2026-05-04T18:58:21.90077Z","steps":["trace[1560703734] 'process raft request'  (duration: 207.618689ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:21.900795Z","caller":"traceutil/trace.go:171","msg":"trace[2129334432] linearizableReadLoop","detail":"{readStateIndex:26494; appliedIndex:26493; }","duration":"213.152013ms","start":"2026-05-04T18:58:21.687615Z","end":"2026-05-04T18:58:21.900767Z","steps":["trace[2129334432] 'read index received'  (duration: 74.676305ms)","trace[2129334432] 'applied index is now lower than readState.Index'  (duration: 138.473318ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:21.901106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.192878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-04T18:58:21.901203Z","caller":"traceutil/trace.go:171","msg":"trace[1759772865] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25646; }","duration":"247.347241ms","start":"2026-05-04T18:58:21.653837Z","end":"2026-05-04T18:58:21.901184Z","steps":["trace[1759772865] 'agreement among raft nodes before linearized reading'  (duration: 247.071256ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:21.901349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.51685ms","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-05-04T18:58:21.90149Z","caller":"traceutil/trace.go:171","msg":"trace[588646339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25646; }","duration":"403.697043ms","start":"2026-05-04T18:58:21.497783Z","end":"2026-05-04T18:58:21.90148Z","steps":["trace[588646339] 'agreement among raft nodes before linearized reading'  (duration: 403.491279ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:21.901173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.605879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"}
{"level":"info","ts":"2026-05-04T18:58:21.90159Z","caller":"traceutil/trace.go:171","msg":"trace[1495568980] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:25646; }","duration":"368.084767ms","start":"2026-05-04T18:58:21.533482Z","end":"2026-05-04T18:58:21.901567Z","steps":["trace[1495568980] 'agreement among raft nodes before linearized reading'  (duration: 367.432795ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:21.901638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:21.533446Z","time spent":"368.178239ms","remote":"127.0.0.1:59248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1657,"request content":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" "}
{"level":"info","ts":"2026-05-04T18:58:21.901432Z","caller":"traceutil/trace.go:171","msg":"trace[2095472268] transaction","detail":"{read_only:false; response_revision:25645; number_of_response:1; }","duration":"596.966615ms","start":"2026-05-04T18:58:21.304451Z","end":"2026-05-04T18:58:21.901417Z","steps":["trace[2095472268] 'process raft request'  (duration: 457.854485ms)","trace[2095472268] 'compare'  (duration: 137.888567ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:21.901636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.56599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-04T18:58:21.901732Z","caller":"traceutil/trace.go:171","msg":"trace[2009026174] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25646; }","duration":"548.729753ms","start":"2026-05-04T18:58:21.352981Z","end":"2026-05-04T18:58:21.901711Z","steps":["trace[2009026174] 'agreement among raft nodes before linearized reading'  (duration: 548.462978ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:21.901785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:21.352962Z","time spent":"548.812755ms","remote":"127.0.0.1:59372","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-05-04T18:58:21.901782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:21.304422Z","time spent":"597.264369ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25630 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:21.901803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:21.497745Z","time spent":"403.813515ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-04T18:58:22.101229Z","caller":"traceutil/trace.go:171","msg":"trace[2010657113] transaction","detail":"{read_only:false; response_revision:25647; number_of_response:1; }","duration":"209.397562ms","start":"2026-05-04T18:58:21.8918Z","end":"2026-05-04T18:58:22.101197Z","steps":["trace[2010657113] 'process raft request'  (duration: 129.153304ms)","trace[2010657113] 'compare'  (duration: 80.113326ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:22.103226Z","caller":"traceutil/trace.go:171","msg":"trace[2112762840] linearizableReadLoop","detail":"{readStateIndex:26497; appliedIndex:26495; }","duration":"202.31034ms","start":"2026-05-04T18:58:21.900888Z","end":"2026-05-04T18:58:22.103199Z","steps":["trace[2112762840] 'read index received'  (duration: 121.006741ms)","trace[2112762840] 'applied index is now lower than readState.Index'  (duration: 81.302619ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:22.103555Z","caller":"traceutil/trace.go:171","msg":"trace[528324420] transaction","detail":"{read_only:false; response_revision:25648; number_of_response:1; }","duration":"211.668014ms","start":"2026-05-04T18:58:21.891874Z","end":"2026-05-04T18:58:22.103542Z","steps":["trace[528324420] 'process raft request'  (duration: 211.095894ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:22.103723Z","caller":"traceutil/trace.go:171","msg":"trace[1081156252] transaction","detail":"{read_only:false; response_revision:25649; number_of_response:1; }","duration":"197.878166ms","start":"2026-05-04T18:58:21.905835Z","end":"2026-05-04T18:58:22.103713Z","steps":["trace[1081156252] 'process raft request'  (duration: 197.287016ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:22.104016Z","caller":"traceutil/trace.go:171","msg":"trace[1364494388] transaction","detail":"{read_only:false; response_revision:25650; number_of_response:1; }","duration":"197.381798ms","start":"2026-05-04T18:58:21.906626Z","end":"2026-05-04T18:58:22.104008Z","steps":["trace[1364494388] 'process raft request'  (duration: 196.537752ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:22.10429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.389936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-04T18:58:22.104331Z","caller":"traceutil/trace.go:171","msg":"trace[239046361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25650; }","duration":"213.474539ms","start":"2026-05-04T18:58:21.890846Z","end":"2026-05-04T18:58:22.104321Z","steps":["trace[239046361] 'agreement among raft nodes before linearized reading'  (duration: 213.322706ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:22.10439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.9877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-04T18:58:22.104479Z","caller":"traceutil/trace.go:171","msg":"trace[1812607889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25650; }","duration":"236.138553ms","start":"2026-05-04T18:58:21.868324Z","end":"2026-05-04T18:58:22.104462Z","steps":["trace[1812607889] 'agreement among raft nodes before linearized reading'  (duration: 235.882497ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:22.104778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.977168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-04T18:58:22.10482Z","caller":"traceutil/trace.go:171","msg":"trace[827096725] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25650; }","duration":"200.042498ms","start":"2026-05-04T18:58:21.904768Z","end":"2026-05-04T18:58:22.104811Z","steps":["trace[827096725] 'agreement among raft nodes before linearized reading'  (duration: 199.937806ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:22.105024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.185681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-0cce04d1-32e8-433d-b7dc-de72eab793c9\" ","response":"range_response_count:1 size:1294"}
{"level":"info","ts":"2026-05-04T18:58:22.105062Z","caller":"traceutil/trace.go:171","msg":"trace[1696414109] range","detail":"{range_begin:/registry/persistentvolumes/pvc-0cce04d1-32e8-433d-b7dc-de72eab793c9; range_end:; response_count:1; response_revision:25650; }","duration":"200.237992ms","start":"2026-05-04T18:58:21.904814Z","end":"2026-05-04T18:58:22.105051Z","steps":["trace[1696414109] 'agreement among raft nodes before linearized reading'  (duration: 200.14071ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:22.10511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.822922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:22.105152Z","caller":"traceutil/trace.go:171","msg":"trace[290845847] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:25650; }","duration":"246.959934ms","start":"2026-05-04T18:58:21.858177Z","end":"2026-05-04T18:58:22.105137Z","steps":["trace[290845847] 'agreement among raft nodes before linearized reading'  (duration: 246.894593ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:23.069565Z","caller":"traceutil/trace.go:171","msg":"trace[1600928544] linearizableReadLoop","detail":"{readStateIndex:26504; appliedIndex:26503; }","duration":"317.811188ms","start":"2026-05-04T18:58:22.751728Z","end":"2026-05-04T18:58:23.069539Z","steps":["trace[1600928544] 'read index received'  (duration: 317.38685ms)","trace[1600928544] 'applied index is now lower than readState.Index'  (duration: 422.898µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:23.069692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.9464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T18:58:23.069727Z","caller":"traceutil/trace.go:171","msg":"trace[970880360] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:25655; }","duration":"318.035642ms","start":"2026-05-04T18:58:22.751679Z","end":"2026-05-04T18:58:23.069715Z","steps":["trace[970880360] 'agreement among raft nodes before linearized reading'  (duration: 317.952261ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:23.069796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:22.751661Z","time spent":"318.123863ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":31,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true "}
{"level":"info","ts":"2026-05-04T18:58:23.069697Z","caller":"traceutil/trace.go:171","msg":"trace[930241002] transaction","detail":"{read_only:false; response_revision:25655; number_of_response:1; }","duration":"378.260188ms","start":"2026-05-04T18:58:22.691395Z","end":"2026-05-04T18:58:23.069656Z","steps":["trace[930241002] 'process raft request'  (duration: 377.79762ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:23.070025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:22.691379Z","time spent":"378.531863ms","remote":"127.0.0.1:50730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418362,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" mod_revision:25065 > success:<request_put:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" value_size:418294 >> failure:<request_range:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" > >"}
{"level":"info","ts":"2026-05-04T18:58:23.087004Z","caller":"traceutil/trace.go:171","msg":"trace[1584249739] transaction","detail":"{read_only:false; response_revision:25656; number_of_response:1; }","duration":"282.961827ms","start":"2026-05-04T18:58:22.804025Z","end":"2026-05-04T18:58:23.086987Z","steps":["trace[1584249739] 'process raft request'  (duration: 282.875285ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:23.554469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.663314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:23.554556Z","caller":"traceutil/trace.go:171","msg":"trace[1827161286] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25656; }","duration":"424.793387ms","start":"2026-05-04T18:58:23.129734Z","end":"2026-05-04T18:58:23.554527Z","steps":["trace[1827161286] 'count revisions from in-memory index tree'  (duration: 424.571163ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:23.554589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:23.129712Z","time spent":"424.867268ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":144,"response count":0,"response size":29,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true "}
{"level":"warn","ts":"2026-05-04T18:58:23.554615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.228163ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509530738 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25643 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:58:23.554915Z","caller":"traceutil/trace.go:171","msg":"trace[1035332712] transaction","detail":"{read_only:false; response_revision:25657; number_of_response:1; }","duration":"402.439709ms","start":"2026-05-04T18:58:23.152443Z","end":"2026-05-04T18:58:23.554882Z","steps":["trace[1035332712] 'process raft request'  (duration: 195.854659ms)","trace[1035332712] 'compare'  (duration: 206.08367ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:23.555109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:23.15243Z","time spent":"402.550011ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25643 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T18:58:23.798441Z","caller":"traceutil/trace.go:171","msg":"trace[2065326263] transaction","detail":"{read_only:false; response_revision:25658; number_of_response:1; }","duration":"105.816127ms","start":"2026-05-04T18:58:23.69256Z","end":"2026-05-04T18:58:23.798376Z","steps":["trace[2065326263] 'process raft request'  (duration: 76.547071ms)","trace[2065326263] 'compare'  (duration: 28.718276ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:24.363233Z","caller":"traceutil/trace.go:171","msg":"trace[724840649] linearizableReadLoop","detail":"{readStateIndex:26509; appliedIndex:26508; }","duration":"292.799231ms","start":"2026-05-04T18:58:24.070412Z","end":"2026-05-04T18:58:24.363212Z","steps":["trace[724840649] 'read index received'  (duration: 195.938211ms)","trace[724840649] 'applied index is now lower than readState.Index'  (duration: 96.85999ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:24.363342Z","caller":"traceutil/trace.go:171","msg":"trace[90990806] transaction","detail":"{read_only:false; response_revision:25660; number_of_response:1; }","duration":"380.377947ms","start":"2026-05-04T18:58:23.982942Z","end":"2026-05-04T18:58:24.36332Z","steps":["trace[90990806] 'process raft request'  (duration: 283.385835ms)","trace[90990806] 'compare'  (duration: 96.776318ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:24.363736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:23.982923Z","time spent":"380.741124ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25646 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:24.363427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.008585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:24.364004Z","caller":"traceutil/trace.go:171","msg":"trace[307568356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25660; }","duration":"293.637917ms","start":"2026-05-04T18:58:24.070351Z","end":"2026-05-04T18:58:24.363989Z","steps":["trace[307568356] 'agreement among raft nodes before linearized reading'  (duration: 293.036966ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:24.736113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.056438ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509530747 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25647 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:58:24.736391Z","caller":"traceutil/trace.go:171","msg":"trace[1300675349] linearizableReadLoop","detail":"{readStateIndex:26513; appliedIndex:26509; }","duration":"372.799696ms","start":"2026-05-04T18:58:24.363575Z","end":"2026-05-04T18:58:24.736375Z","steps":["trace[1300675349] 'read index received'  (duration: 110.422033ms)","trace[1300675349] 'applied index is now lower than readState.Index'  (duration: 262.376503ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:24.736467Z","caller":"traceutil/trace.go:171","msg":"trace[695874443] transaction","detail":"{read_only:false; response_revision:25661; number_of_response:1; }","duration":"629.141285ms","start":"2026-05-04T18:58:24.107315Z","end":"2026-05-04T18:58:24.736456Z","steps":["trace[695874443] 'process raft request'  (duration: 366.664431ms)","trace[695874443] 'compare'  (duration: 261.824812ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:24.736523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.107291Z","time spent":"629.202936ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25647 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-05-04T18:58:24.736636Z","caller":"traceutil/trace.go:171","msg":"trace[1763604307] transaction","detail":"{read_only:false; response_revision:25662; number_of_response:1; }","duration":"626.212361ms","start":"2026-05-04T18:58:24.110415Z","end":"2026-05-04T18:58:24.736627Z","steps":["trace[1763604307] 'process raft request'  (duration: 625.822423ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:24.736685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.110392Z","time spent":"626.266891ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25648 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:24.736958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.289176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-05-04T18:58:24.736942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.675287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-04T18:58:24.737032Z","caller":"traceutil/trace.go:171","msg":"trace[1696763229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25664; }","duration":"613.800709ms","start":"2026-05-04T18:58:24.123206Z","end":"2026-05-04T18:58:24.737007Z","steps":["trace[1696763229] 'agreement among raft nodes before linearized reading'  (duration: 613.581235ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:24.737091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.7344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-05-04T18:58:24.7371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.123191Z","time spent":"613.894331ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-04T18:58:24.737127Z","caller":"traceutil/trace.go:171","msg":"trace[1388339739] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25664; }","duration":"626.809962ms","start":"2026-05-04T18:58:24.11031Z","end":"2026-05-04T18:58:24.73712Z","steps":["trace[1388339739] 'agreement among raft nodes before linearized reading'  (duration: 626.73368ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:24.737153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.110297Z","time spent":"626.850412ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-04T18:58:24.73731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.789511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-05-04T18:58:24.737383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.932584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:24.737422Z","caller":"traceutil/trace.go:171","msg":"trace[965843262] transaction","detail":"{read_only:false; response_revision:25664; number_of_response:1; }","duration":"465.509898ms","start":"2026-05-04T18:58:24.271901Z","end":"2026-05-04T18:58:24.737411Z","steps":["trace[965843262] 'process raft request'  (duration: 464.436198ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:24.737441Z","caller":"traceutil/trace.go:171","msg":"trace[1261998640] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:25664; }","duration":"597.042116ms","start":"2026-05-04T18:58:24.140382Z","end":"2026-05-04T18:58:24.737425Z","steps":["trace[1261998640] 'agreement among raft nodes before linearized reading'  (duration: 596.945404ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:24.73746Z","caller":"traceutil/trace.go:171","msg":"trace[599644787] transaction","detail":"{read_only:false; response_revision:25663; number_of_response:1; }","duration":"529.288119ms","start":"2026-05-04T18:58:24.208134Z","end":"2026-05-04T18:58:24.737422Z","steps":["trace[599644787] 'process raft request'  (duration: 528.158498ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:24.737474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.271875Z","time spent":"465.571269ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25653 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:24.737482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.140356Z","time spent":"597.116657ms","remote":"127.0.0.1:41094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true "}
{"level":"info","ts":"2026-05-04T18:58:24.737546Z","caller":"traceutil/trace.go:171","msg":"trace[1831288855] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25664; }","duration":"626.976774ms","start":"2026-05-04T18:58:24.110429Z","end":"2026-05-04T18:58:24.737406Z","steps":["trace[1831288855] 'agreement among raft nodes before linearized reading'  (duration: 626.634648ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:24.736987Z","caller":"traceutil/trace.go:171","msg":"trace[2056578647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25664; }","duration":"616.339686ms","start":"2026-05-04T18:58:24.120638Z","end":"2026-05-04T18:58:24.736978Z","steps":["trace[2056578647] 'agreement among raft nodes before linearized reading'  (duration: 616.221314ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:24.73766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.120628Z","time spent":"617.0231ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-04T18:58:24.737553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.208105Z","time spent":"529.400502ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:25611 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:414 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:24.737771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.110396Z","time spent":"627.22977ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-04T18:58:24.73753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.139593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:24.739532Z","caller":"traceutil/trace.go:171","msg":"trace[1141486121] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:25664; }","duration":"488.190402ms","start":"2026-05-04T18:58:24.251308Z","end":"2026-05-04T18:58:24.739498Z","steps":["trace[1141486121] 'agreement among raft nodes before linearized reading'  (duration: 486.125443ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:24.73972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.251284Z","time spent":"488.393556ms","remote":"127.0.0.1:50752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "}
{"level":"info","ts":"2026-05-04T18:58:24.886468Z","caller":"traceutil/trace.go:171","msg":"trace[750013819] transaction","detail":"{read_only:false; response_revision:25665; number_of_response:1; }","duration":"210.728079ms","start":"2026-05-04T18:58:24.675712Z","end":"2026-05-04T18:58:24.88644Z","steps":["trace[750013819] 'process raft request'  (duration: 198.838935ms)","trace[750013819] 'compare'  (duration: 11.609718ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:24.886445Z","caller":"traceutil/trace.go:171","msg":"trace[1551680400] linearizableReadLoop","detail":"{readStateIndex:26514; appliedIndex:26513; }","duration":"149.989963ms","start":"2026-05-04T18:58:24.736424Z","end":"2026-05-04T18:58:24.886414Z","steps":["trace[1551680400] 'read index received'  (duration: 138.202872ms)","trace[1551680400] 'applied index is now lower than readState.Index'  (duration: 11.785471ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:24.886555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.275596ms","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:6"}
{"level":"info","ts":"2026-05-04T18:58:24.886594Z","caller":"traceutil/trace.go:171","msg":"trace[2015549813] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:25665; }","duration":"501.368588ms","start":"2026-05-04T18:58:24.385215Z","end":"2026-05-04T18:58:24.886584Z","steps":["trace[2015549813] 'agreement among raft nodes before linearized reading'  (duration: 501.255396ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:24.886618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.385173Z","time spent":"501.43782ms","remote":"127.0.0.1:44140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-04T18:58:24.886692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.400972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:24.886776Z","caller":"traceutil/trace.go:171","msg":"trace[763858323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25665; }","duration":"521.561575ms","start":"2026-05-04T18:58:24.365194Z","end":"2026-05-04T18:58:24.886756Z","steps":["trace[763858323] 'agreement among raft nodes before linearized reading'  (duration: 521.393632ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:24.88682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.365179Z","time spent":"521.632436ms","remote":"127.0.0.1:59100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-04T18:58:25.177442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.977201ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509530754 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25651 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:58:25.177682Z","caller":"traceutil/trace.go:171","msg":"trace[374982405] transaction","detail":"{read_only:false; response_revision:25666; number_of_response:1; }","duration":"435.964307ms","start":"2026-05-04T18:58:24.741684Z","end":"2026-05-04T18:58:25.177648Z","steps":["trace[374982405] 'process raft request'  (duration: 292.708779ms)","trace[374982405] 'compare'  (duration: 142.241868ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:25.177773Z","caller":"traceutil/trace.go:171","msg":"trace[1885615744] transaction","detail":"{read_only:false; response_revision:25668; number_of_response:1; }","duration":"435.526478ms","start":"2026-05-04T18:58:24.742219Z","end":"2026-05-04T18:58:25.177745Z","steps":["trace[1885615744] 'process raft request'  (duration: 435.437757ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:25.17781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.741666Z","time spent":"436.081128ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25651 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-04T18:58:25.177865Z","caller":"traceutil/trace.go:171","msg":"trace[1075869107] transaction","detail":"{read_only:false; response_revision:25669; number_of_response:1; }","duration":"435.586899ms","start":"2026-05-04T18:58:24.74227Z","end":"2026-05-04T18:58:25.177857Z","steps":["trace[1075869107] 'process raft request'  (duration: 435.412676ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:25.177885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.742203Z","time spent":"435.62957ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25649 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:25.177957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.742225Z","time spent":"435.687141ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25650 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-04T18:58:25.178039Z","caller":"traceutil/trace.go:171","msg":"trace[941910649] transaction","detail":"{read_only:false; response_revision:25667; number_of_response:1; }","duration":"436.314632ms","start":"2026-05-04T18:58:24.741716Z","end":"2026-05-04T18:58:25.178031Z","steps":["trace[941910649] 'process raft request'  (duration: 435.873864ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:25.178106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.741695Z","time spent":"436.384763ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25652 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-04T18:58:25.177799Z","caller":"traceutil/trace.go:171","msg":"trace[139234492] linearizableReadLoop","detail":"{readStateIndex:26518; appliedIndex:26514; }","duration":"291.242031ms","start":"2026-05-04T18:58:24.886549Z","end":"2026-05-04T18:58:25.177791Z","steps":["trace[139234492] 'read index received'  (duration: 147.856631ms)","trace[139234492] 'applied index is now lower than readState.Index'  (duration: 143.38449ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:25.178289Z","caller":"traceutil/trace.go:171","msg":"trace[1976984588] transaction","detail":"{read_only:false; response_revision:25670; number_of_response:1; }","duration":"287.814108ms","start":"2026-05-04T18:58:24.890406Z","end":"2026-05-04T18:58:25.17822Z","steps":["trace[1976984588] 'process raft request'  (duration: 287.311929ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:25.178341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.384612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:25.178437Z","caller":"traceutil/trace.go:171","msg":"trace[1851515813] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:25670; }","duration":"300.531206ms","start":"2026-05-04T18:58:24.877886Z","end":"2026-05-04T18:58:25.178417Z","steps":["trace[1851515813] 'agreement among raft nodes before linearized reading'  (duration: 299.928975ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:25.178522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:24.877864Z","time spent":"300.642357ms","remote":"127.0.0.1:50700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "}
{"level":"info","ts":"2026-05-04T18:58:25.430018Z","caller":"traceutil/trace.go:171","msg":"trace[259090410] transaction","detail":"{read_only:false; response_revision:25671; number_of_response:1; }","duration":"329.307194ms","start":"2026-05-04T18:58:25.100696Z","end":"2026-05-04T18:58:25.430003Z","steps":["trace[259090410] 'process raft request'  (duration: 315.998175ms)","trace[259090410] 'compare'  (duration: 12.997563ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:25.430117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:25.100672Z","time spent":"329.393135ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25656 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-04T18:58:30.538689Z","caller":"traceutil/trace.go:171","msg":"trace[1714231985] transaction","detail":"{read_only:false; response_revision:25706; number_of_response:1; }","duration":"122.241853ms","start":"2026-05-04T18:58:30.416421Z","end":"2026-05-04T18:58:30.538663Z","steps":["trace[1714231985] 'process raft request'  (duration: 122.07599ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:30.82879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.203203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T18:58:30.828885Z","caller":"traceutil/trace.go:171","msg":"trace[1048076904] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:25706; }","duration":"100.346616ms","start":"2026-05-04T18:58:30.728508Z","end":"2026-05-04T18:58:30.828855Z","steps":["trace[1048076904] 'count revisions from in-memory index tree'  (duration: 100.127461ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:30.913826Z","caller":"traceutil/trace.go:171","msg":"trace[1631766679] transaction","detail":"{read_only:false; response_revision:25708; number_of_response:1; }","duration":"156.791079ms","start":"2026-05-04T18:58:30.756992Z","end":"2026-05-04T18:58:30.913783Z","steps":["trace[1631766679] 'process raft request'  (duration: 156.517324ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:30.913832Z","caller":"traceutil/trace.go:171","msg":"trace[786657172] transaction","detail":"{read_only:false; response_revision:25709; number_of_response:1; }","duration":"156.734329ms","start":"2026-05-04T18:58:30.757067Z","end":"2026-05-04T18:58:30.913801Z","steps":["trace[786657172] 'process raft request'  (duration: 156.629887ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:30.914143Z","caller":"traceutil/trace.go:171","msg":"trace[266677979] transaction","detail":"{read_only:false; response_revision:25710; number_of_response:1; }","duration":"145.836625ms","start":"2026-05-04T18:58:30.768295Z","end":"2026-05-04T18:58:30.914132Z","steps":["trace[266677979] 'process raft request'  (duration: 145.459068ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.393062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.786973ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509530861 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25695 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:58:31.393202Z","caller":"traceutil/trace.go:171","msg":"trace[1020412966] linearizableReadLoop","detail":"{readStateIndex:26562; appliedIndex:26561; }","duration":"218.757357ms","start":"2026-05-04T18:58:31.174427Z","end":"2026-05-04T18:58:31.393184Z","steps":["trace[1020412966] 'read index received'  (duration: 66.991µs)","trace[1020412966] 'applied index is now lower than readState.Index'  (duration: 218.688986ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:31.393228Z","caller":"traceutil/trace.go:171","msg":"trace[136678591] transaction","detail":"{read_only:false; response_revision:25711; number_of_response:1; }","duration":"487.235744ms","start":"2026-05-04T18:58:30.905956Z","end":"2026-05-04T18:58:31.393192Z","steps":["trace[136678591] 'process raft request'  (duration: 218.224008ms)","trace[136678591] 'compare'  (duration: 268.572998ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:31.393319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.89597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:31.393357Z","caller":"traceutil/trace.go:171","msg":"trace[1737245781] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25711; }","duration":"218.978402ms","start":"2026-05-04T18:58:31.174367Z","end":"2026-05-04T18:58:31.393346Z","steps":["trace[1737245781] 'agreement among raft nodes before linearized reading'  (duration: 218.90948ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.393378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:30.905933Z","time spent":"487.368617ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:25695 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:31.39368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.985196ms","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-05-04T18:58:31.393721Z","caller":"traceutil/trace.go:171","msg":"trace[404952707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25711; }","duration":"193.061767ms","start":"2026-05-04T18:58:31.200651Z","end":"2026-05-04T18:58:31.393713Z","steps":["trace[404952707] 'agreement among raft nodes before linearized reading'  (duration: 192.938144ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.875961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:31.394043Z","caller":"traceutil/trace.go:171","msg":"trace[810694440] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:25711; }","duration":"118.948943ms","start":"2026-05-04T18:58:31.275085Z","end":"2026-05-04T18:58:31.394034Z","steps":["trace[810694440] 'agreement among raft nodes before linearized reading'  (duration: 118.875572ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.394103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.228332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T18:58:31.394153Z","caller":"traceutil/trace.go:171","msg":"trace[750180596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25711; }","duration":"184.328544ms","start":"2026-05-04T18:58:31.209811Z","end":"2026-05-04T18:58:31.394139Z","steps":["trace[750180596] 'agreement among raft nodes before linearized reading'  (duration: 184.178792ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.394191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.160213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-04T18:58:31.394308Z","caller":"traceutil/trace.go:171","msg":"trace[743768444] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25711; }","duration":"183.308916ms","start":"2026-05-04T18:58:31.210977Z","end":"2026-05-04T18:58:31.394286Z","steps":["trace[743768444] 'agreement among raft nodes before linearized reading'  (duration: 183.039111ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.394305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.254044ms","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-05-04T18:58:31.394385Z","caller":"traceutil/trace.go:171","msg":"trace[730381032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25711; }","duration":"184.449626ms","start":"2026-05-04T18:58:31.209915Z","end":"2026-05-04T18:58:31.394364Z","steps":["trace[730381032] 'agreement among raft nodes before linearized reading'  (duration: 184.10741ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.905678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.719138ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509530866 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25697 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:58:31.906114Z","caller":"traceutil/trace.go:171","msg":"trace[2127326262] transaction","detail":"{read_only:false; response_revision:25717; number_of_response:1; }","duration":"318.52ms","start":"2026-05-04T18:58:31.587571Z","end":"2026-05-04T18:58:31.906091Z","steps":["trace[2127326262] 'process raft request'  (duration: 318.468859ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.906204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:31.587543Z","time spent":"318.617853ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25701 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-04T18:58:31.906372Z","caller":"traceutil/trace.go:171","msg":"trace[271098300] linearizableReadLoop","detail":"{readStateIndex:26566; appliedIndex:26562; }","duration":"506.673447ms","start":"2026-05-04T18:58:31.399676Z","end":"2026-05-04T18:58:31.90635Z","steps":["trace[271098300] 'read index received'  (duration: 7.828795ms)","trace[271098300] 'applied index is now lower than readState.Index'  (duration: 498.839822ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:31.906382Z","caller":"traceutil/trace.go:171","msg":"trace[972357251] transaction","detail":"{read_only:false; response_revision:25714; number_of_response:1; }","duration":"507.243089ms","start":"2026-05-04T18:58:31.399106Z","end":"2026-05-04T18:58:31.906349Z","steps":["trace[972357251] 'process raft request'  (duration: 506.752629ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:31.90642Z","caller":"traceutil/trace.go:171","msg":"trace[1456812145] transaction","detail":"{read_only:false; response_revision:25715; number_of_response:1; }","duration":"507.260109ms","start":"2026-05-04T18:58:31.399136Z","end":"2026-05-04T18:58:31.906396Z","steps":["trace[1456812145] 'process raft request'  (duration: 506.81808ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:31.906432Z","caller":"traceutil/trace.go:171","msg":"trace[1588989359] transaction","detail":"{read_only:false; response_revision:25713; number_of_response:1; }","duration":"507.31807ms","start":"2026-05-04T18:58:31.399064Z","end":"2026-05-04T18:58:31.906382Z","steps":["trace[1588989359] 'process raft request'  (duration: 326.798756ms)","trace[1588989359] 'compare'  (duration: 178.791711ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:31.906522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:31.399081Z","time spent":"507.364371ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25698 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:31.906512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.807879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:31.906582Z","caller":"traceutil/trace.go:171","msg":"trace[558948211] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25717; }","duration":"506.905402ms","start":"2026-05-04T18:58:31.399657Z","end":"2026-05-04T18:58:31.906563Z","steps":["trace[558948211] 'agreement among raft nodes before linearized reading'  (duration: 506.77645ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.906624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:31.399649Z","time spent":"506.964153ms","remote":"127.0.0.1:59278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"warn","ts":"2026-05-04T18:58:31.906664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:31.399046Z","time spent":"507.475003ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25697 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-05-04T18:58:31.906426Z","caller":"traceutil/trace.go:171","msg":"trace[1221603785] transaction","detail":"{read_only:false; response_revision:25716; number_of_response:1; }","duration":"450.971977ms","start":"2026-05-04T18:58:31.455418Z","end":"2026-05-04T18:58:31.90639Z","steps":["trace[1221603785] 'process raft request'  (duration: 450.586649ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.907151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:31.455386Z","time spent":"451.535667ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25700 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:31.907287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:31.399093Z","time spent":"507.385621ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25699 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:31.952582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.471567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T18:58:31.9527Z","caller":"traceutil/trace.go:171","msg":"trace[636358197] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:25718; }","duration":"161.651341ms","start":"2026-05-04T18:58:31.791024Z","end":"2026-05-04T18:58:31.952676Z","steps":["trace[636358197] 'agreement among raft nodes before linearized reading'  (duration: 161.389846ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:31.952717Z","caller":"traceutil/trace.go:171","msg":"trace[1201965734] transaction","detail":"{read_only:false; response_revision:25718; number_of_response:1; }","duration":"125.675238ms","start":"2026-05-04T18:58:31.827017Z","end":"2026-05-04T18:58:31.952692Z","steps":["trace[1201965734] 'process raft request'  (duration: 125.21277ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.952838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.68984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:31.952882Z","caller":"traceutil/trace.go:171","msg":"trace[2076787126] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:25718; }","duration":"451.753131ms","start":"2026-05-04T18:58:31.501117Z","end":"2026-05-04T18:58:31.952871Z","steps":["trace[2076787126] 'agreement among raft nodes before linearized reading'  (duration: 451.654279ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:31.952908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:31.501067Z","time spent":"451.831822ms","remote":"127.0.0.1:41522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-05-04T18:58:31.953884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.825675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-05-04T18:58:31.953955Z","caller":"traceutil/trace.go:171","msg":"trace[1491845790] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25718; }","duration":"220.960898ms","start":"2026-05-04T18:58:31.73298Z","end":"2026-05-04T18:58:31.953941Z","steps":["trace[1491845790] 'agreement among raft nodes before linearized reading'  (duration: 219.420069ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:41.126775Z","caller":"traceutil/trace.go:171","msg":"trace[289659706] linearizableReadLoop","detail":"{readStateIndex:26692; appliedIndex:26691; }","duration":"237.639511ms","start":"2026-05-04T18:58:40.889114Z","end":"2026-05-04T18:58:41.126753Z","steps":["trace[289659706] 'read index received'  (duration: 237.547739ms)","trace[289659706] 'applied index is now lower than readState.Index'  (duration: 90.042µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:41.126899Z","caller":"traceutil/trace.go:171","msg":"trace[784778415] transaction","detail":"{read_only:false; response_revision:25838; number_of_response:1; }","duration":"256.3605ms","start":"2026-05-04T18:58:40.870494Z","end":"2026-05-04T18:58:41.126854Z","steps":["trace[784778415] 'process raft request'  (duration: 256.095216ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:41.126976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.838634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e525e927-3b22-4b49-8342-c9b72a755fc5\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-05-04T18:58:41.127003Z","caller":"traceutil/trace.go:171","msg":"trace[288175086] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e525e927-3b22-4b49-8342-c9b72a755fc5; range_end:; response_count:1; response_revision:25838; }","duration":"237.918436ms","start":"2026-05-04T18:58:40.889076Z","end":"2026-05-04T18:58:41.126994Z","steps":["trace[288175086] 'agreement among raft nodes before linearized reading'  (duration: 237.763413ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:41.200093Z","caller":"traceutil/trace.go:171","msg":"trace[1302754988] transaction","detail":"{read_only:false; response_revision:25839; number_of_response:1; }","duration":"251.823805ms","start":"2026-05-04T18:58:40.948242Z","end":"2026-05-04T18:58:41.200066Z","steps":["trace[1302754988] 'process raft request'  (duration: 251.640942ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:41.200256Z","caller":"traceutil/trace.go:171","msg":"trace[1045375590] transaction","detail":"{read_only:false; response_revision:25840; number_of_response:1; }","duration":"249.102904ms","start":"2026-05-04T18:58:40.951126Z","end":"2026-05-04T18:58:41.200229Z","steps":["trace[1045375590] 'process raft request'  (duration: 248.89479ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:41.461813Z","caller":"traceutil/trace.go:171","msg":"trace[1659195082] linearizableReadLoop","detail":"{readStateIndex:26695; appliedIndex:26692; }","duration":"269.295753ms","start":"2026-05-04T18:58:41.192491Z","end":"2026-05-04T18:58:41.461787Z","steps":["trace[1659195082] 'read index received'  (duration: 7.47854ms)","trace[1659195082] 'applied index is now lower than readState.Index'  (duration: 261.815923ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:41.461923Z","caller":"traceutil/trace.go:171","msg":"trace[1634105197] transaction","detail":"{read_only:false; response_revision:25841; number_of_response:1; }","duration":"293.159508ms","start":"2026-05-04T18:58:41.168714Z","end":"2026-05-04T18:58:41.461873Z","steps":["trace[1634105197] 'process raft request'  (duration: 292.649457ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:41.46196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.443696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:41.462043Z","caller":"traceutil/trace.go:171","msg":"trace[660158767] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:25841; }","duration":"269.575558ms","start":"2026-05-04T18:58:41.192447Z","end":"2026-05-04T18:58:41.462022Z","steps":["trace[660158767] 'agreement among raft nodes before linearized reading'  (duration: 269.421336ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:41.473198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.635691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:41.473258Z","caller":"traceutil/trace.go:171","msg":"trace[594708486] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:25842; }","duration":"199.746513ms","start":"2026-05-04T18:58:41.273497Z","end":"2026-05-04T18:58:41.473243Z","steps":["trace[594708486] 'agreement among raft nodes before linearized reading'  (duration: 199.661311ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:41.93562Z","caller":"traceutil/trace.go:171","msg":"trace[39798587] transaction","detail":"{read_only:false; response_revision:25845; number_of_response:1; }","duration":"124.394375ms","start":"2026-05-04T18:58:41.811199Z","end":"2026-05-04T18:58:41.935594Z","steps":["trace[39798587] 'process raft request'  (duration: 124.059739ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.15434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.022765ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509531199 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25821 > 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:18"}
{"level":"info","ts":"2026-05-04T18:58:42.15445Z","caller":"traceutil/trace.go:171","msg":"trace[1146319681] linearizableReadLoop","detail":"{readStateIndex:26700; appliedIndex:26699; }","duration":"205.591912ms","start":"2026-05-04T18:58:41.948838Z","end":"2026-05-04T18:58:42.15443Z","steps":["trace[1146319681] 'read index received'  (duration: 79.356093ms)","trace[1146319681] 'applied index is now lower than readState.Index'  (duration: 126.234599ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:42.154532Z","caller":"traceutil/trace.go:171","msg":"trace[162636276] transaction","detail":"{read_only:false; response_revision:25846; number_of_response:1; }","duration":"205.780825ms","start":"2026-05-04T18:58:41.94874Z","end":"2026-05-04T18:58:42.15452Z","steps":["trace[162636276] 'process raft request'  (duration: 79.475355ms)","trace[162636276] 'compare'  (duration: 125.899643ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:42.154754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.903628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-04T18:58:42.154858Z","caller":"traceutil/trace.go:171","msg":"trace[1245545427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25846; }","duration":"206.056801ms","start":"2026-05-04T18:58:41.948777Z","end":"2026-05-04T18:58:42.154833Z","steps":["trace[1245545427] 'agreement among raft nodes before linearized reading'  (duration: 205.808536ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:42.192398Z","caller":"traceutil/trace.go:171","msg":"trace[1730117607] transaction","detail":"{read_only:false; response_revision:25848; number_of_response:1; }","duration":"167.388437ms","start":"2026-05-04T18:58:42.024963Z","end":"2026-05-04T18:58:42.192351Z","steps":["trace[1730117607] 'process raft request'  (duration: 167.335106ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:42.192623Z","caller":"traceutil/trace.go:171","msg":"trace[1117020900] transaction","detail":"{read_only:false; response_revision:25847; number_of_response:1; }","duration":"241.859059ms","start":"2026-05-04T18:58:41.950746Z","end":"2026-05-04T18:58:42.192605Z","steps":["trace[1117020900] 'process raft request'  (duration: 241.363669ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:42.416449Z","caller":"traceutil/trace.go:171","msg":"trace[1735804552] transaction","detail":"{read_only:false; response_revision:25849; number_of_response:1; }","duration":"286.813569ms","start":"2026-05-04T18:58:42.129609Z","end":"2026-05-04T18:58:42.416423Z","steps":["trace[1735804552] 'process raft request'  (duration: 275.287214ms)","trace[1735804552] 'compare'  (duration: 10.975755ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:42.416741Z","caller":"traceutil/trace.go:171","msg":"trace[300983377] linearizableReadLoop","detail":"{readStateIndex:26703; appliedIndex:26700; }","duration":"262.203639ms","start":"2026-05-04T18:58:42.154493Z","end":"2026-05-04T18:58:42.416696Z","steps":["trace[300983377] 'read index received'  (duration: 37.629693ms)","trace[300983377] 'applied index is now lower than readState.Index'  (duration: 224.572156ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:42.416966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.415162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:42.416978Z","caller":"traceutil/trace.go:171","msg":"trace[1604062479] transaction","detail":"{read_only:false; response_revision:25850; number_of_response:1; }","duration":"257.217275ms","start":"2026-05-04T18:58:42.159725Z","end":"2026-05-04T18:58:42.416942Z","steps":["trace[1604062479] 'process raft request'  (duration: 256.612504ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.417014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.25265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e525e927-3b22-4b49-8342-c9b72a755fc5\" ","response":"range_response_count:1 size:3764"}
{"level":"warn","ts":"2026-05-04T18:58:42.417089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.61374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-04T18:58:42.417099Z","caller":"traceutil/trace.go:171","msg":"trace[1450536718] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e525e927-3b22-4b49-8342-c9b72a755fc5; range_end:; response_count:1; response_revision:25850; }","duration":"285.375253ms","start":"2026-05-04T18:58:42.131703Z","end":"2026-05-04T18:58:42.417078Z","steps":["trace[1450536718] 'agreement among raft nodes before linearized reading'  (duration: 285.113827ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:42.41714Z","caller":"traceutil/trace.go:171","msg":"trace[1121628916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25850; }","duration":"465.707453ms","start":"2026-05-04T18:58:41.951419Z","end":"2026-05-04T18:58:42.417126Z","steps":["trace[1121628916] 'agreement among raft nodes before linearized reading'  (duration: 465.55908ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.417176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:41.951402Z","time spent":"465.766873ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-04T18:58:42.417012Z","caller":"traceutil/trace.go:171","msg":"trace[1005295818] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25850; }","duration":"346.510635ms","start":"2026-05-04T18:58:42.070489Z","end":"2026-05-04T18:58:42.416999Z","steps":["trace[1005295818] 'agreement among raft nodes before linearized reading'  (duration: 346.404012ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.417228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.693931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" ","response":"range_response_count:1 size:1258"}
{"level":"warn","ts":"2026-05-04T18:58:42.417285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:42.070478Z","time spent":"346.77869ms","remote":"127.0.0.1:59088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-04T18:58:42.417302Z","caller":"traceutil/trace.go:171","msg":"trace[1849834528] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila-nodes; range_end:; response_count:1; response_revision:25850; }","duration":"466.779213ms","start":"2026-05-04T18:58:41.950507Z","end":"2026-05-04T18:58:42.417286Z","steps":["trace[1849834528] 'agreement among raft nodes before linearized reading'  (duration: 466.535678ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.417343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.564665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-04T18:58:42.417353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:41.950502Z","time spent":"466.840524ms","remote":"127.0.0.1:59278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":1281,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" "}
{"level":"info","ts":"2026-05-04T18:58:42.417388Z","caller":"traceutil/trace.go:171","msg":"trace[1423460222] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25850; }","duration":"445.645847ms","start":"2026-05-04T18:58:41.971728Z","end":"2026-05-04T18:58:42.417374Z","steps":["trace[1423460222] 'agreement among raft nodes before linearized reading'  (duration: 445.577636ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.417423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:41.971708Z","time spent":"445.708078ms","remote":"127.0.0.1:41498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "}
{"level":"warn","ts":"2026-05-04T18:58:42.417634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.253733ms","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-05-04T18:58:42.417674Z","caller":"traceutil/trace.go:171","msg":"trace[2090581169] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25850; }","duration":"458.323114ms","start":"2026-05-04T18:58:41.959341Z","end":"2026-05-04T18:58:42.417664Z","steps":["trace[2090581169] 'agreement among raft nodes before linearized reading'  (duration: 458.222483ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.417705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:41.959333Z","time spent":"458.366275ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-04T18:58:42.417704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.908423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:42.417745Z","caller":"traceutil/trace.go:171","msg":"trace[1788052441] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:25850; }","duration":"102.982285ms","start":"2026-05-04T18:58:42.31475Z","end":"2026-05-04T18:58:42.417732Z","steps":["trace[1788052441] 'agreement among raft nodes before linearized reading'  (duration: 102.906543ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:42.676059Z","caller":"traceutil/trace.go:171","msg":"trace[769091909] linearizableReadLoop","detail":"{readStateIndex:26705; appliedIndex:26704; }","duration":"254.645878ms","start":"2026-05-04T18:58:42.421393Z","end":"2026-05-04T18:58:42.676039Z","steps":["trace[769091909] 'read index received'  (duration: 251.070751ms)","trace[769091909] 'applied index is now lower than readState.Index'  (duration: 3.574357ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:42.676144Z","caller":"traceutil/trace.go:171","msg":"trace[1465773107] transaction","detail":"{read_only:false; response_revision:25851; number_of_response:1; }","duration":"255.028105ms","start":"2026-05-04T18:58:42.42109Z","end":"2026-05-04T18:58:42.676118Z","steps":["trace[1465773107] 'process raft request'  (duration: 251.257125ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.676251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.845052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-manila.18ac71d6b56123a7\" ","response":"range_response_count:1 size:742"}
{"level":"info","ts":"2026-05-04T18:58:42.676278Z","caller":"traceutil/trace.go:171","msg":"trace[1410496874] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-manila.18ac71d6b56123a7; range_end:; response_count:1; response_revision:25851; }","duration":"254.905593ms","start":"2026-05-04T18:58:42.421363Z","end":"2026-05-04T18:58:42.676268Z","steps":["trace[1410496874] 'agreement among raft nodes before linearized reading'  (duration: 254.780991ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.677014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.215079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/endpoints/\" range_end:\"/registry/openstack.k-orc.cloud/endpoints0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:42.677057Z","caller":"traceutil/trace.go:171","msg":"trace[599861655] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/endpoints/; range_end:/registry/openstack.k-orc.cloud/endpoints0; response_count:0; response_revision:25852; }","duration":"209.264199ms","start":"2026-05-04T18:58:42.467779Z","end":"2026-05-04T18:58:42.677044Z","steps":["trace[599861655] 'agreement among raft nodes before linearized reading'  (duration: 209.195558ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.677119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.69223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T18:58:42.677149Z","caller":"traceutil/trace.go:171","msg":"trace[392804302] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:25852; }","duration":"109.7546ms","start":"2026-05-04T18:58:42.567387Z","end":"2026-05-04T18:58:42.677142Z","steps":["trace[392804302] 'agreement among raft nodes before linearized reading'  (duration: 109.697719ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.676996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.01251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-04T18:58:42.67716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.371299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1442"}
{"level":"info","ts":"2026-05-04T18:58:42.677194Z","caller":"traceutil/trace.go:171","msg":"trace[45221807] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25852; }","duration":"251.246454ms","start":"2026-05-04T18:58:42.425934Z","end":"2026-05-04T18:58:42.677181Z","steps":["trace[45221807] 'agreement among raft nodes before linearized reading'  (duration: 250.943238ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:42.677209Z","caller":"traceutil/trace.go:171","msg":"trace[280942616] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25852; }","duration":"250.443909ms","start":"2026-05-04T18:58:42.426747Z","end":"2026-05-04T18:58:42.67719Z","steps":["trace[280942616] 'agreement among raft nodes before linearized reading'  (duration: 250.293716ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.677188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.81028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-04T18:58:42.677277Z","caller":"traceutil/trace.go:171","msg":"trace[1933041014] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25852; }","duration":"102.931562ms","start":"2026-05-04T18:58:42.574325Z","end":"2026-05-04T18:58:42.677256Z","steps":["trace[1933041014] 'agreement among raft nodes before linearized reading'  (duration: 102.584796ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.677239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.834503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"info","ts":"2026-05-04T18:58:42.677402Z","caller":"traceutil/trace.go:171","msg":"trace[1951418056] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:25852; }","duration":"147.038957ms","start":"2026-05-04T18:58:42.530302Z","end":"2026-05-04T18:58:42.677341Z","steps":["trace[1951418056] 'agreement among raft nodes before linearized reading'  (duration: 146.63578ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:42.6774Z","caller":"traceutil/trace.go:171","msg":"trace[1989731084] transaction","detail":"{read_only:false; response_revision:25852; number_of_response:1; }","duration":"251.57923ms","start":"2026-05-04T18:58:42.425778Z","end":"2026-05-04T18:58:42.677357Z","steps":["trace[1989731084] 'process raft request'  (duration: 250.950969ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:42.78292Z","caller":"traceutil/trace.go:171","msg":"trace[393106224] transaction","detail":"{read_only:false; response_revision:25853; number_of_response:1; }","duration":"103.944472ms","start":"2026-05-04T18:58:42.678953Z","end":"2026-05-04T18:58:42.782898Z","steps":["trace[393106224] 'process raft request'  (duration: 102.75002ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:42.783154Z","caller":"traceutil/trace.go:171","msg":"trace[959446761] linearizableReadLoop","detail":"{readStateIndex:26707; appliedIndex:26706; }","duration":"103.245329ms","start":"2026-05-04T18:58:42.679898Z","end":"2026-05-04T18:58:42.783143Z","steps":["trace[959446761] 'read index received'  (duration: 101.772202ms)","trace[959446761] 'applied index is now lower than readState.Index'  (duration: 1.472037ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:42.783401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.483313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b96be6a2-3400-4511-af37-a2c90ceff30e\" ","response":"range_response_count:1 size:1324"}
{"level":"info","ts":"2026-05-04T18:58:42.783443Z","caller":"traceutil/trace.go:171","msg":"trace[214928561] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b96be6a2-3400-4511-af37-a2c90ceff30e; range_end:; response_count:1; response_revision:25854; }","duration":"103.538914ms","start":"2026-05-04T18:58:42.679893Z","end":"2026-05-04T18:58:42.783432Z","steps":["trace[214928561] 'agreement among raft nodes before linearized reading'  (duration: 103.383701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.783687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.886501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-05-04T18:58:42.783767Z","caller":"traceutil/trace.go:171","msg":"trace[1804033217] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25854; }","duration":"102.983024ms","start":"2026-05-04T18:58:42.68076Z","end":"2026-05-04T18:58:42.783743Z","steps":["trace[1804033217] 'agreement among raft nodes before linearized reading'  (duration: 102.77607ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:42.783877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.225831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"}
{"level":"info","ts":"2026-05-04T18:58:42.783941Z","caller":"traceutil/trace.go:171","msg":"trace[273156004] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25854; }","duration":"101.314113ms","start":"2026-05-04T18:58:42.682613Z","end":"2026-05-04T18:58:42.783927Z","steps":["trace[273156004] 'agreement among raft nodes before linearized reading'  (duration: 101.15264ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:48.309026Z","caller":"traceutil/trace.go:171","msg":"trace[1966697812] transaction","detail":"{read_only:false; response_revision:25918; number_of_response:1; }","duration":"118.496775ms","start":"2026-05-04T18:58:48.190494Z","end":"2026-05-04T18:58:48.308991Z","steps":["trace[1966697812] 'process raft request'  (duration: 118.287981ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:48.454404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.742603ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509531360 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25895 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:58:48.454522Z","caller":"traceutil/trace.go:171","msg":"trace[1027923322] transaction","detail":"{read_only:false; response_revision:25920; number_of_response:1; }","duration":"197.002461ms","start":"2026-05-04T18:58:48.257508Z","end":"2026-05-04T18:58:48.45451Z","steps":["trace[1027923322] 'process raft request'  (duration: 196.958971ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:48.454699Z","caller":"traceutil/trace.go:171","msg":"trace[370640523] transaction","detail":"{read_only:false; response_revision:25919; number_of_response:1; }","duration":"198.56773ms","start":"2026-05-04T18:58:48.256093Z","end":"2026-05-04T18:58:48.45466Z","steps":["trace[370640523] 'process raft request'  (duration: 82.511131ms)","trace[370640523] 'compare'  (duration: 115.598281ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:48.597424Z","caller":"traceutil/trace.go:171","msg":"trace[2079269271] linearizableReadLoop","detail":"{readStateIndex:26777; appliedIndex:26776; }","duration":"152.305886ms","start":"2026-05-04T18:58:48.445094Z","end":"2026-05-04T18:58:48.597399Z","steps":["trace[2079269271] 'read index received'  (duration: 150.635865ms)","trace[2079269271] 'applied index is now lower than readState.Index'  (duration: 1.669101ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:48.597462Z","caller":"traceutil/trace.go:171","msg":"trace[264654619] transaction","detail":"{read_only:false; response_revision:25921; number_of_response:1; }","duration":"163.016036ms","start":"2026-05-04T18:58:48.43442Z","end":"2026-05-04T18:58:48.597436Z","steps":["trace[264654619] 'process raft request'  (duration: 161.316794ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:48.597621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.509811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-05-04T18:58:48.597661Z","caller":"traceutil/trace.go:171","msg":"trace[916275338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25921; }","duration":"152.588262ms","start":"2026-05-04T18:58:48.445062Z","end":"2026-05-04T18:58:48.59765Z","steps":["trace[916275338] 'agreement among raft nodes before linearized reading'  (duration: 152.434489ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:48.902934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.619306ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509531364 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25900 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:58:48.903059Z","caller":"traceutil/trace.go:171","msg":"trace[799927669] linearizableReadLoop","detail":"{readStateIndex:26778; appliedIndex:26777; }","duration":"212.960229ms","start":"2026-05-04T18:58:48.690081Z","end":"2026-05-04T18:58:48.903041Z","steps":["trace[799927669] 'read index received'  (duration: 48.264741ms)","trace[799927669] 'applied index is now lower than readState.Index'  (duration: 164.694238ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:58:48.90332Z","caller":"traceutil/trace.go:171","msg":"trace[65319331] transaction","detail":"{read_only:false; response_revision:25922; number_of_response:1; }","duration":"300.79297ms","start":"2026-05-04T18:58:48.602451Z","end":"2026-05-04T18:58:48.903244Z","steps":["trace[65319331] 'process raft request'  (duration: 135.771536ms)","trace[65319331] 'compare'  (duration: 164.480414ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:58:48.903486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.578575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-04T18:58:48.903596Z","caller":"traceutil/trace.go:171","msg":"trace[1018467427] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25922; }","duration":"203.752768ms","start":"2026-05-04T18:58:48.699816Z","end":"2026-05-04T18:58:48.903569Z","steps":["trace[1018467427] 'agreement among raft nodes before linearized reading'  (duration: 203.428182ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:48.903472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.52713ms","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-05-04T18:58:48.903952Z","caller":"traceutil/trace.go:171","msg":"trace[738016359] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25922; }","duration":"206.035169ms","start":"2026-05-04T18:58:48.697876Z","end":"2026-05-04T18:58:48.903911Z","steps":["trace[738016359] 'agreement among raft nodes before linearized reading'  (duration: 205.360647ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:58:48.903519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:58:48.602406Z","time spent":"301.008054ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:25900 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-04T18:58:48.903656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.5655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:58:48.90418Z","caller":"traceutil/trace.go:171","msg":"trace[193191263] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:25922; }","duration":"214.13312ms","start":"2026-05-04T18:58:48.690027Z","end":"2026-05-04T18:58:48.90416Z","steps":["trace[193191263] 'agreement among raft nodes before linearized reading'  (duration: 213.5637ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:49.040147Z","caller":"traceutil/trace.go:171","msg":"trace[597786054] transaction","detail":"{read_only:false; response_revision:25923; number_of_response:1; }","duration":"135.035773ms","start":"2026-05-04T18:58:48.905086Z","end":"2026-05-04T18:58:49.040122Z","steps":["trace[597786054] 'process raft request'  (duration: 132.15663ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:49.040445Z","caller":"traceutil/trace.go:171","msg":"trace[1260497644] transaction","detail":"{read_only:false; response_revision:25924; number_of_response:1; }","duration":"132.803922ms","start":"2026-05-04T18:58:48.907618Z","end":"2026-05-04T18:58:49.040422Z","steps":["trace[1260497644] 'process raft request'  (duration: 132.438685ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:49.040472Z","caller":"traceutil/trace.go:171","msg":"trace[1106963041] transaction","detail":"{read_only:false; response_revision:25926; number_of_response:1; }","duration":"131.206562ms","start":"2026-05-04T18:58:48.909239Z","end":"2026-05-04T18:58:49.040446Z","steps":["trace[1106963041] 'process raft request'  (duration: 131.160522ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:58:49.04064Z","caller":"traceutil/trace.go:171","msg":"trace[1572578216] transaction","detail":"{read_only:false; response_revision:25925; number_of_response:1; }","duration":"131.710672ms","start":"2026-05-04T18:58:48.908856Z","end":"2026-05-04T18:58:49.040567Z","steps":["trace[1572578216] 'process raft request'  (duration: 131.442637ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:00.73566Z","caller":"traceutil/trace.go:171","msg":"trace[121425212] transaction","detail":"{read_only:false; response_revision:26016; number_of_response:1; }","duration":"237.853014ms","start":"2026-05-04T18:59:00.497775Z","end":"2026-05-04T18:59:00.735628Z","steps":["trace[121425212] 'process raft request'  (duration: 237.651571ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:00.883706Z","caller":"traceutil/trace.go:171","msg":"trace[567248617] transaction","detail":"{read_only:false; response_revision:26018; number_of_response:1; }","duration":"243.047372ms","start":"2026-05-04T18:59:00.640635Z","end":"2026-05-04T18:59:00.883682Z","steps":["trace[567248617] 'process raft request'  (duration: 243.005611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:00.884068Z","caller":"traceutil/trace.go:171","msg":"trace[132770971] transaction","detail":"{read_only:false; response_revision:26017; number_of_response:1; }","duration":"384.081887ms","start":"2026-05-04T18:59:00.499915Z","end":"2026-05-04T18:59:00.883997Z","steps":["trace[132770971] 'process raft request'  (duration: 383.580337ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:00.884374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T18:59:00.499899Z","time spent":"384.319741ms","remote":"127.0.0.1:59372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:26001 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-04T18:59:01.190833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.811233ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509531605 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26003 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-05-04T18:59:01.190929Z","caller":"traceutil/trace.go:171","msg":"trace[405976646] linearizableReadLoop","detail":"{readStateIndex:26878; appliedIndex:26877; }","duration":"102.029256ms","start":"2026-05-04T18:59:01.088886Z","end":"2026-05-04T18:59:01.190915Z","steps":["trace[405976646] 'read index received'  (duration: 44.311µs)","trace[405976646] 'applied index is now lower than readState.Index'  (duration: 101.983705ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:01.190994Z","caller":"traceutil/trace.go:171","msg":"trace[1560803652] transaction","detail":"{read_only:false; response_revision:26019; number_of_response:1; }","duration":"218.690156ms","start":"2026-05-04T18:59:00.972292Z","end":"2026-05-04T18:59:01.190983Z","steps":["trace[1560803652] 'process raft request'  (duration: 101.654399ms)","trace[1560803652] 'compare'  (duration: 116.671181ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:59:01.191517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.614797ms","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-05-04T18:59:01.191662Z","caller":"traceutil/trace.go:171","msg":"trace[187784564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26019; }","duration":"102.80972ms","start":"2026-05-04T18:59:01.088828Z","end":"2026-05-04T18:59:01.191638Z","steps":["trace[187784564] 'agreement among raft nodes before linearized reading'  (duration: 102.273841ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:01.304065Z","caller":"traceutil/trace.go:171","msg":"trace[1224808495] linearizableReadLoop","detail":"{readStateIndex:26879; appliedIndex:26878; }","duration":"113.076973ms","start":"2026-05-04T18:59:01.190948Z","end":"2026-05-04T18:59:01.304025Z","steps":["trace[1224808495] 'read index received'  (duration: 110.76313ms)","trace[1224808495] 'applied index is now lower than readState.Index'  (duration: 2.311133ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:01.304097Z","caller":"traceutil/trace.go:171","msg":"trace[840614770] transaction","detail":"{read_only:false; response_revision:26021; number_of_response:1; }","duration":"106.762405ms","start":"2026-05-04T18:59:01.197295Z","end":"2026-05-04T18:59:01.304057Z","steps":["trace[840614770] 'process raft request'  (duration: 106.50682ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:01.304181Z","caller":"traceutil/trace.go:171","msg":"trace[733911778] transaction","detail":"{read_only:false; response_revision:26020; number_of_response:1; }","duration":"115.017409ms","start":"2026-05-04T18:59:01.189121Z","end":"2026-05-04T18:59:01.304139Z","steps":["trace[733911778] 'process raft request'  (duration: 112.512212ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:01.304366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.14602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-05-04T18:59:01.304451Z","caller":"traceutil/trace.go:171","msg":"trace[1850613321] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26023; }","duration":"208.250772ms","start":"2026-05-04T18:59:01.096177Z","end":"2026-05-04T18:59:01.304428Z","steps":["trace[1850613321] 'agreement among raft nodes before linearized reading'  (duration: 208.003937ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:01.304477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.183553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-04T18:59:01.30461Z","caller":"traceutil/trace.go:171","msg":"trace[627821536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26023; }","duration":"213.370516ms","start":"2026-05-04T18:59:01.091218Z","end":"2026-05-04T18:59:01.304589Z","steps":["trace[627821536] 'agreement among raft nodes before linearized reading'  (duration: 213.03479ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:01.426391Z","caller":"traceutil/trace.go:171","msg":"trace[549285796] transaction","detail":"{read_only:false; response_revision:26024; number_of_response:1; }","duration":"115.300364ms","start":"2026-05-04T18:59:01.311061Z","end":"2026-05-04T18:59:01.426361Z","steps":["trace[549285796] 'process raft request'  (duration: 115.05425ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:01.439998Z","caller":"traceutil/trace.go:171","msg":"trace[1500970840] transaction","detail":"{read_only:false; response_revision:26025; number_of_response:1; }","duration":"127.840729ms","start":"2026-05-04T18:59:01.312127Z","end":"2026-05-04T18:59:01.439968Z","steps":["trace[1500970840] 'process raft request'  (duration: 127.651085ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:01.649315Z","caller":"traceutil/trace.go:171","msg":"trace[1840303966] transaction","detail":"{read_only:false; response_revision:26026; number_of_response:1; }","duration":"113.032883ms","start":"2026-05-04T18:59:01.536237Z","end":"2026-05-04T18:59:01.64927Z","steps":["trace[1840303966] 'process raft request'  (duration: 63.409225ms)","trace[1840303966] 'compare'  (duration: 49.418294ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:01.851797Z","caller":"traceutil/trace.go:171","msg":"trace[706691946] transaction","detail":"{read_only:false; response_revision:26027; number_of_response:1; }","duration":"197.98602ms","start":"2026-05-04T18:59:01.653767Z","end":"2026-05-04T18:59:01.851753Z","steps":["trace[706691946] 'process raft request'  (duration: 136.923879ms)","trace[706691946] 'compare'  (duration: 60.884398ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:59:02.179328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.015378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-05-04T18:59:02.179414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.922281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:59:02.17943Z","caller":"traceutil/trace.go:171","msg":"trace[968486359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26028; }","duration":"108.153831ms","start":"2026-05-04T18:59:02.071254Z","end":"2026-05-04T18:59:02.179408Z","steps":["trace[968486359] 'range keys from in-memory index tree'  (duration: 107.951097ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:02.179474Z","caller":"traceutil/trace.go:171","msg":"trace[1958956404] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:26028; }","duration":"181.036383ms","start":"2026-05-04T18:59:01.998423Z","end":"2026-05-04T18:59:02.179459Z","steps":["trace[1958956404] 'count revisions from in-memory index tree'  (duration: 180.807528ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:02.576331Z","caller":"traceutil/trace.go:171","msg":"trace[1914165828] linearizableReadLoop","detail":"{readStateIndex:26889; appliedIndex:26888; }","duration":"215.08543ms","start":"2026-05-04T18:59:02.36122Z","end":"2026-05-04T18:59:02.576305Z","steps":["trace[1914165828] 'read index received'  (duration: 19.448044ms)","trace[1914165828] 'applied index is now lower than readState.Index'  (duration: 195.636206ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:02.576399Z","caller":"traceutil/trace.go:171","msg":"trace[100249601] transaction","detail":"{read_only:false; response_revision:26030; number_of_response:1; }","duration":"217.891631ms","start":"2026-05-04T18:59:02.358457Z","end":"2026-05-04T18:59:02.576349Z","steps":["trace[100249601] 'process raft request'  (duration: 183.03765ms)","trace[100249601] 'compare'  (duration: 34.505355ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:59:02.576454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.214542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T18:59:02.576489Z","caller":"traceutil/trace.go:171","msg":"trace[350516880] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:26030; }","duration":"215.295623ms","start":"2026-05-04T18:59:02.361186Z","end":"2026-05-04T18:59:02.576482Z","steps":["trace[350516880] 'agreement among raft nodes before linearized reading'  (duration: 215.198001ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:03.333046Z","caller":"traceutil/trace.go:171","msg":"trace[512172093] transaction","detail":"{read_only:false; response_revision:26034; number_of_response:1; }","duration":"133.441354ms","start":"2026-05-04T18:59:03.199577Z","end":"2026-05-04T18:59:03.333018Z","steps":["trace[512172093] 'process raft request'  (duration: 133.22845ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:03.399616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.877084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-04T18:59:03.399798Z","caller":"traceutil/trace.go:171","msg":"trace[1130416863] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:26037; }","duration":"101.125539ms","start":"2026-05-04T18:59:03.29865Z","end":"2026-05-04T18:59:03.399776Z","steps":["trace[1130416863] 'agreement among raft nodes before linearized reading'  (duration: 100.799793ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:06.540608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.384159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9650"}
{"level":"info","ts":"2026-05-04T18:59:06.540675Z","caller":"traceutil/trace.go:171","msg":"trace[1724775557] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:26064; }","duration":"113.513142ms","start":"2026-05-04T18:59:06.427145Z","end":"2026-05-04T18:59:06.540658Z","steps":["trace[1724775557] 'range keys from in-memory index tree'  (duration: 113.218036ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:23.687799Z","caller":"traceutil/trace.go:171","msg":"trace[1433730156] transaction","detail":"{read_only:false; response_revision:26197; number_of_response:1; }","duration":"129.621592ms","start":"2026-05-04T18:59:23.558147Z","end":"2026-05-04T18:59:23.687768Z","steps":["trace[1433730156] 'process raft request'  (duration: 61.641102ms)","trace[1433730156] 'compare'  (duration: 67.849397ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:23.690987Z","caller":"traceutil/trace.go:171","msg":"trace[1555649342] linearizableReadLoop","detail":"{readStateIndex:27062; appliedIndex:27059; }","duration":"131.501007ms","start":"2026-05-04T18:59:23.559467Z","end":"2026-05-04T18:59:23.690968Z","steps":["trace[1555649342] 'read index received'  (duration: 60.281987ms)","trace[1555649342] 'applied index is now lower than readState.Index'  (duration: 71.21813ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:23.691064Z","caller":"traceutil/trace.go:171","msg":"trace[710730447] transaction","detail":"{read_only:false; response_revision:26198; number_of_response:1; }","duration":"132.830102ms","start":"2026-05-04T18:59:23.55821Z","end":"2026-05-04T18:59:23.69104Z","steps":["trace[710730447] 'process raft request'  (duration: 132.574147ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:23.691092Z","caller":"traceutil/trace.go:171","msg":"trace[137570401] transaction","detail":"{read_only:false; response_revision:26199; number_of_response:1; }","duration":"131.986396ms","start":"2026-05-04T18:59:23.559082Z","end":"2026-05-04T18:59:23.691069Z","steps":["trace[137570401] 'process raft request'  (duration: 131.819353ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:23.691179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.711921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18746"}
{"level":"info","ts":"2026-05-04T18:59:23.691211Z","caller":"traceutil/trace.go:171","msg":"trace[341556663] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26199; }","duration":"131.876554ms","start":"2026-05-04T18:59:23.559327Z","end":"2026-05-04T18:59:23.691203Z","steps":["trace[341556663] 'agreement among raft nodes before linearized reading'  (duration: 131.737251ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T18:59:34.893826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.662483ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10400674061509532249 > lease_revoke:<id:10569df42ce5194b>","response":"size:29"}
{"level":"info","ts":"2026-05-04T18:59:34.894599Z","caller":"traceutil/trace.go:171","msg":"trace[1060517161] transaction","detail":"{read_only:false; response_revision:26284; number_of_response:1; }","duration":"144.164164ms","start":"2026-05-04T18:59:34.750415Z","end":"2026-05-04T18:59:34.894579Z","steps":["trace[1060517161] 'process raft request'  (duration: 143.607784ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:35.117642Z","caller":"traceutil/trace.go:171","msg":"trace[117317182] transaction","detail":"{read_only:false; response_revision:26285; number_of_response:1; }","duration":"167.179564ms","start":"2026-05-04T18:59:34.950446Z","end":"2026-05-04T18:59:35.117626Z","steps":["trace[117317182] 'process raft request'  (duration: 79.052098ms)","trace[117317182] 'compare'  (duration: 87.464154ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:35.329528Z","caller":"traceutil/trace.go:171","msg":"trace[116410978] transaction","detail":"{read_only:false; response_revision:26287; number_of_response:1; }","duration":"221.836066ms","start":"2026-05-04T18:59:35.107662Z","end":"2026-05-04T18:59:35.329499Z","steps":["trace[116410978] 'process raft request'  (duration: 150.489453ms)","trace[116410978] 'compare'  (duration: 71.105999ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T18:59:35.32957Z","caller":"traceutil/trace.go:171","msg":"trace[617386097] linearizableReadLoop","detail":"{readStateIndex:27153; appliedIndex:27151; }","duration":"210.871981ms","start":"2026-05-04T18:59:35.11866Z","end":"2026-05-04T18:59:35.329532Z","steps":["trace[617386097] 'read index received'  (duration: 71.13841ms)","trace[617386097] 'applied index is now lower than readState.Index'  (duration: 139.726781ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T18:59:35.329747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.060454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T18:59:35.32979Z","caller":"traceutil/trace.go:171","msg":"trace[254709803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26288; }","duration":"211.158006ms","start":"2026-05-04T18:59:35.118621Z","end":"2026-05-04T18:59:35.329779Z","steps":["trace[254709803] 'agreement among raft nodes before linearized reading'  (duration: 211.038014ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T18:59:35.545246Z","caller":"traceutil/trace.go:171","msg":"trace[250154345] transaction","detail":"{read_only:false; response_revision:26289; number_of_response:1; }","duration":"156.26917ms","start":"2026-05-04T18:59:35.388948Z","end":"2026-05-04T18:59:35.545217Z","steps":["trace[250154345] 'process raft request'  (duration: 156.054746ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T19:00:00.367811Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006b8a.wal"}
{"level":"info","ts":"2026-05-04T19:02:56.564921Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25339}
{"level":"info","ts":"2026-05-04T19:02:56.705818Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25339,"took":"136.915898ms","hash":1601889801,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":38641664,"current-db-size-in-use":"39 MB"}
{"level":"info","ts":"2026-05-04T19:02:56.705896Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1601889801,"revision":25339,"compact-revision":22088}
{"level":"info","ts":"2026-05-04T19:04:15.166555Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e6e5712872899056","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T19:04:15.17188Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-05-04T19:04:15.172067Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-05-04T19:07:56.573292Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28361}
{"level":"info","ts":"2026-05-04T19:07:56.723245Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28361,"took":"146.379721ms","hash":3646082141,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":33157120,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-05-04T19:07:56.723306Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3646082141,"revision":28361,"compact-revision":25339}
{"level":"info","ts":"2026-05-04T19:12:56.578773Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30752}
{"level":"info","ts":"2026-05-04T19:12:56.715748Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30752,"took":"130.943412ms","hash":2836028518,"current-db-size-bytes":57872384,"current-db-size":"58 MB","current-db-size-in-use-bytes":30367744,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-04T19:12:56.715805Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2836028518,"revision":30752,"compact-revision":28361}
{"level":"info","ts":"2026-05-04T19:17:56.585445Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33004}
{"level":"info","ts":"2026-05-04T19:17:56.734854Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33004,"took":"144.10835ms","hash":714199418,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":30945280,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-05-04T19:17:56.734929Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":714199418,"revision":33004,"compact-revision":30752}
{"level":"info","ts":"2026-05-04T19:22:56.591374Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35300}
{"level":"info","ts":"2026-05-04T19:22:56.7287Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35300,"took":"132.579384ms","hash":838135531,"current-db-size-bytes":58916864,"current-db-size":"59 MB","current-db-size-in-use-bytes":31490048,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-04T19:22:56.728769Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":838135531,"revision":35300,"compact-revision":33004}
{"level":"info","ts":"2026-05-04T19:25:37.58264Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e6e5712872899056","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T19:25:37.587008Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-05-04T19:25:37.587143Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-05-04T19:27:56.597933Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37527}
{"level":"info","ts":"2026-05-04T19:27:56.719236Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37527,"took":"118.218918ms","hash":2223885814,"current-db-size-bytes":59760640,"current-db-size":"60 MB","current-db-size-in-use-bytes":31813632,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-04T19:27:56.719299Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2223885814,"revision":37527,"compact-revision":35300}