{"level":"warn","ts":"2026-09-07T10:47:08.39588Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-07T10:47:08.396242Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.153:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.153:2380","--initial-cluster=instance=https://162.253.55.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.153:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-09-07T10:47:08.396327Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-07T10:47:08.396341Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.153:2380"]}
{"level":"info","ts":"2026-09-07T10:47:08.396365Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-07T10:47:08.397461Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.153:2379"]}
{"level":"info","ts":"2026-09-07T10:47:08.39758Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.153:2380"],"listen-peer-urls":["https://162.253.55.153:2380"],"advertise-client-urls":["https://162.253.55.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.153:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-09-07T10:47:08.402753Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.416913ms"}
{"level":"info","ts":"2026-09-07T10:47:08.410526Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"522eb07aa35b671b","cluster-id":"49de17121e7ddda"}
{"level":"info","ts":"2026-09-07T10:47:08.410629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b switched to configuration voters=()"}
{"level":"info","ts":"2026-09-07T10:47:08.41065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became follower at term 0"}
{"level":"info","ts":"2026-09-07T10:47:08.41066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 522eb07aa35b671b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-07T10:47:08.41067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became follower at term 1"}
{"level":"info","ts":"2026-09-07T10:47:08.410707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b switched to configuration voters=(5921864600811955995)"}
{"level":"warn","ts":"2026-09-07T10:47:08.418833Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-07T10:47:08.42107Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-07T10:47:08.422802Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-09-07T10:47:08.426466Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"522eb07aa35b671b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-07T10:47:08.426734Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"522eb07aa35b671b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-07T10:47:08.426758Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-07T10:47:08.426894Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-07T10:47:08.426911Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-07T10:47:08.42822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b switched to configuration voters=(5921864600811955995)"}
{"level":"info","ts":"2026-09-07T10:47:08.429035Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49de17121e7ddda","local-member-id":"522eb07aa35b671b","added-peer-id":"522eb07aa35b671b","added-peer-peer-urls":["https://162.253.55.153:2380"]}
{"level":"info","ts":"2026-09-07T10:47:08.433754Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-07T10:47:08.433922Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.153:2380"}
{"level":"info","ts":"2026-09-07T10:47:08.433978Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.153:2380"}
{"level":"info","ts":"2026-09-07T10:47:08.434184Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"522eb07aa35b671b","initial-advertise-peer-urls":["https://162.253.55.153:2380"],"listen-peer-urls":["https://162.253.55.153:2380"],"advertise-client-urls":["https://162.253.55.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-07T10:47:08.434319Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-07T10:47:09.212796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b is starting a new election at term 1"}
{"level":"info","ts":"2026-09-07T10:47:09.212888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-07T10:47:09.212918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b received MsgPreVoteResp from 522eb07aa35b671b at term 1"}
{"level":"info","ts":"2026-09-07T10:47:09.212941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became candidate at term 2"}
{"level":"info","ts":"2026-09-07T10:47:09.212952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b received MsgVoteResp from 522eb07aa35b671b at term 2"}
{"level":"info","ts":"2026-09-07T10:47:09.212968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became leader at term 2"}
{"level":"info","ts":"2026-09-07T10:47:09.212983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 522eb07aa35b671b elected leader 522eb07aa35b671b at term 2"}
{"level":"info","ts":"2026-09-07T10:47:09.214773Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T10:47:09.215989Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-07T10:47:09.215986Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"522eb07aa35b671b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.153:2379]}","request-path":"/0/members/522eb07aa35b671b/attributes","cluster-id":"49de17121e7ddda","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-07T10:47:09.216027Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-07T10:47:09.216451Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-07T10:47:09.216515Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-07T10:47:09.21661Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49de17121e7ddda","local-member-id":"522eb07aa35b671b","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T10:47:09.21676Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T10:47:09.216844Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-07T10:47:09.220016Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-07T10:47:09.220051Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.153:2379"}
{"level":"info","ts":"2026-09-07T10:47:46.679726Z","caller":"traceutil/trace.go:171","msg":"trace[271048366] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"193.652468ms","start":"2026-09-07T10:47:46.486049Z","end":"2026-09-07T10:47:46.679702Z","steps":["trace[271048366] 'process raft request'  (duration: 193.374263ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:47:46.687254Z","caller":"traceutil/trace.go:171","msg":"trace[1661641968] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"193.990685ms","start":"2026-09-07T10:47:46.493221Z","end":"2026-09-07T10:47:46.687211Z","steps":["trace[1661641968] 'process raft request'  (duration: 193.569376ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:47:46.687437Z","caller":"traceutil/trace.go:171","msg":"trace[159933107] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"181.267164ms","start":"2026-09-07T10:47:46.50614Z","end":"2026-09-07T10:47:46.687407Z","steps":["trace[159933107] 'process raft request'  (duration: 181.022979ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:47:53.237131Z","caller":"traceutil/trace.go:171","msg":"trace[521403053] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"148.927927ms","start":"2026-09-07T10:47:53.088179Z","end":"2026-09-07T10:47:53.237107Z","steps":["trace[521403053] 'read index received'  (duration: 148.671401ms)","trace[521403053] 'applied index is now lower than readState.Index'  (duration: 255.515µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T10:47:53.237214Z","caller":"traceutil/trace.go:171","msg":"trace[1769841798] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"167.355548ms","start":"2026-09-07T10:47:53.06981Z","end":"2026-09-07T10:47:53.237165Z","steps":["trace[1769841798] 'process raft request'  (duration: 167.120063ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:47:53.237334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.129701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-09-07T10:47:53.237409Z","caller":"traceutil/trace.go:171","msg":"trace[42490371] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"149.224873ms","start":"2026-09-07T10:47:53.088173Z","end":"2026-09-07T10:47:53.237398Z","steps":["trace[42490371] 'agreement among raft nodes before linearized reading'  (duration: 149.033539ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:47:53.360864Z","caller":"traceutil/trace.go:171","msg":"trace[2105192058] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"110.02748ms","start":"2026-09-07T10:47:53.25081Z","end":"2026-09-07T10:47:53.360838Z","steps":["trace[2105192058] 'read index received'  (duration: 57.991544ms)","trace[2105192058] 'applied index is now lower than readState.Index'  (duration: 52.034936ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T10:47:53.360968Z","caller":"traceutil/trace.go:171","msg":"trace[390475608] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"118.658773ms","start":"2026-09-07T10:47:53.242277Z","end":"2026-09-07T10:47:53.360936Z","steps":["trace[390475608] 'process raft request'  (duration: 66.490424ms)","trace[390475608] 'compare'  (duration: 51.916433ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T10:47:53.361085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.225654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T10:47:53.361215Z","caller":"traceutil/trace.go:171","msg":"trace[1146485916] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:628; }","duration":"110.380698ms","start":"2026-09-07T10:47:53.250785Z","end":"2026-09-07T10:47:53.361165Z","steps":["trace[1146485916] 'agreement among raft nodes before linearized reading'  (duration: 110.155383ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:47:53.844076Z","caller":"traceutil/trace.go:171","msg":"trace[196975987] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"352.803913ms","start":"2026-09-07T10:47:53.491246Z","end":"2026-09-07T10:47:53.84405Z","steps":["trace[196975987] 'read index received'  (duration: 347.4866ms)","trace[196975987] 'applied index is now lower than readState.Index'  (duration: 5.316413ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T10:47:53.844277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.992577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-07T10:47:53.844313Z","caller":"traceutil/trace.go:171","msg":"trace[629992561] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"353.114709ms","start":"2026-09-07T10:47:53.49119Z","end":"2026-09-07T10:47:53.844305Z","steps":["trace[629992561] 'agreement among raft nodes before linearized reading'  (duration: 353.002207ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:47:53.844349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:47:53.491172Z","time spent":"353.15824ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-09-07T10:47:53.844161Z","caller":"traceutil/trace.go:171","msg":"trace[1862547074] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"365.767999ms","start":"2026-09-07T10:47:53.478385Z","end":"2026-09-07T10:47:53.844153Z","steps":["trace[1862547074] 'process raft request'  (duration: 360.338954ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:47:53.844979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:47:53.478325Z","time spent":"366.280299ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-kkcnd\" mod_revision:518 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-kkcnd\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-kkcnd\" > >"}
{"level":"warn","ts":"2026-09-07T10:47:53.855234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.890766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-07T10:47:53.855305Z","caller":"traceutil/trace.go:171","msg":"trace[2115304167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"338.007248ms","start":"2026-09-07T10:47:53.517281Z","end":"2026-09-07T10:47:53.855288Z","steps":["trace[2115304167] 'agreement among raft nodes before linearized reading'  (duration: 337.854665ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:47:53.855326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T10:47:53.517259Z","time spent":"338.061669ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-07T10:47:53.855347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.805385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-07T10:47:53.85542Z","caller":"traceutil/trace.go:171","msg":"trace[1754273063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"283.934097ms","start":"2026-09-07T10:47:53.571468Z","end":"2026-09-07T10:47:53.855402Z","steps":["trace[1754273063] 'agreement among raft nodes before linearized reading'  (duration: 283.786284ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:49:34.061574Z","caller":"traceutil/trace.go:171","msg":"trace[566879984] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"105.765523ms","start":"2026-09-07T10:49:33.95577Z","end":"2026-09-07T10:49:34.061536Z","steps":["trace[566879984] 'process raft request'  (duration: 105.544148ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:49:34.379948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.693797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T10:49:34.380035Z","caller":"traceutil/trace.go:171","msg":"trace[683920088] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1919; }","duration":"172.830669ms","start":"2026-09-07T10:49:34.207186Z","end":"2026-09-07T10:49:34.380016Z","steps":["trace[683920088] 'count revisions from in-memory index tree'  (duration: 172.596455ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:49:46.361944Z","caller":"traceutil/trace.go:171","msg":"trace[269200889] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"103.796272ms","start":"2026-09-07T10:49:46.258115Z","end":"2026-09-07T10:49:46.361912Z","steps":["trace[269200889] 'process raft request'  (duration: 82.779508ms)","trace[269200889] 'compare'  (duration: 20.798239ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T10:49:46.408992Z","caller":"traceutil/trace.go:171","msg":"trace[2015006157] transaction","detail":"{read_only:false; response_revision:2022; number_of_response:1; }","duration":"150.324894ms","start":"2026-09-07T10:49:46.258628Z","end":"2026-09-07T10:49:46.408953Z","steps":["trace[2015006157] 'process raft request'  (duration: 149.960706ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:49:46.409056Z","caller":"traceutil/trace.go:171","msg":"trace[1504448137] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"149.518736ms","start":"2026-09-07T10:49:46.259491Z","end":"2026-09-07T10:49:46.40901Z","steps":["trace[1504448137] 'process raft request'  (duration: 149.308202ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:49:46.40906Z","caller":"traceutil/trace.go:171","msg":"trace[1063911279] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"144.049501ms","start":"2026-09-07T10:49:46.264976Z","end":"2026-09-07T10:49:46.409025Z","steps":["trace[1063911279] 'process raft request'  (duration: 143.969099ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:49:46.409234Z","caller":"traceutil/trace.go:171","msg":"trace[798210075] transaction","detail":"{read_only:false; response_revision:2024; number_of_response:1; }","duration":"147.558315ms","start":"2026-09-07T10:49:46.261657Z","end":"2026-09-07T10:49:46.409215Z","steps":["trace[798210075] 'process raft request'  (duration: 147.199328ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:49:46.625236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.322096ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7429708462476332074 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/poddisruptionbudgets/openstack/rabbitmq-cluster-operator\" mod_revision:1659 > success:<request_put:<key:\"/registry/poddisruptionbudgets/openstack/rabbitmq-cluster-operator\" value_size:1638 >> failure:<request_range:<key:\"/registry/poddisruptionbudgets/openstack/rabbitmq-cluster-operator\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T10:49:46.625572Z","caller":"traceutil/trace.go:171","msg":"trace[54091022] transaction","detail":"{read_only:false; response_revision:2026; number_of_response:1; }","duration":"209.908333ms","start":"2026-09-07T10:49:46.415627Z","end":"2026-09-07T10:49:46.625535Z","steps":["trace[54091022] 'process raft request'  (duration: 102.033425ms)","trace[54091022] 'compare'  (duration: 107.190273ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T10:49:46.625773Z","caller":"traceutil/trace.go:171","msg":"trace[969680394] linearizableReadLoop","detail":"{readStateIndex:2109; appliedIndex:2106; }","duration":"116.511419ms","start":"2026-09-07T10:49:46.509245Z","end":"2026-09-07T10:49:46.625757Z","steps":["trace[969680394] 'read index received'  (duration: 8.447148ms)","trace[969680394] 'applied index is now lower than readState.Index'  (duration: 108.063331ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T10:49:46.62581Z","caller":"traceutil/trace.go:171","msg":"trace[1848138033] transaction","detail":"{read_only:false; response_revision:2027; number_of_response:1; }","duration":"208.118204ms","start":"2026-09-07T10:49:46.417673Z","end":"2026-09-07T10:49:46.625791Z","steps":["trace[1848138033] 'process raft request'  (duration: 207.654704ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:49:46.626002Z","caller":"traceutil/trace.go:171","msg":"trace[928520051] transaction","detail":"{read_only:false; response_revision:2028; number_of_response:1; }","duration":"207.213145ms","start":"2026-09-07T10:49:46.418748Z","end":"2026-09-07T10:49:46.625962Z","steps":["trace[928520051] 'process raft request'  (duration: 206.963139ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:49:46.626625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.350178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-07T10:49:46.626717Z","caller":"traceutil/trace.go:171","msg":"trace[352715788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2028; }","duration":"117.516792ms","start":"2026-09-07T10:49:46.509182Z","end":"2026-09-07T10:49:46.626699Z","steps":["trace[352715788] 'agreement among raft nodes before linearized reading'  (duration: 116.678283ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:49:49.3971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.529635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T10:49:49.397176Z","caller":"traceutil/trace.go:171","msg":"trace[1641164225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2048; }","duration":"237.654118ms","start":"2026-09-07T10:49:49.159505Z","end":"2026-09-07T10:49:49.397159Z","steps":["trace[1641164225] 'range keys from in-memory index tree'  (duration: 237.428973ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:50:29.128739Z","caller":"traceutil/trace.go:171","msg":"trace[996212289] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"202.569027ms","start":"2026-09-07T10:50:28.92614Z","end":"2026-09-07T10:50:29.12871Z","steps":["trace[996212289] 'process raft request'  (duration: 202.382953ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:50:29.139917Z","caller":"traceutil/trace.go:171","msg":"trace[574367578] transaction","detail":"{read_only:false; response_revision:2265; number_of_response:1; }","duration":"212.547007ms","start":"2026-09-07T10:50:28.927354Z","end":"2026-09-07T10:50:29.139901Z","steps":["trace[574367578] 'process raft request'  (duration: 212.21021ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:50:29.139921Z","caller":"traceutil/trace.go:171","msg":"trace[2137645706] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"213.493288ms","start":"2026-09-07T10:50:28.926404Z","end":"2026-09-07T10:50:29.139898Z","steps":["trace[2137645706] 'process raft request'  (duration: 213.084349ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:51:05.513281Z","caller":"traceutil/trace.go:171","msg":"trace[1673720878] transaction","detail":"{read_only:false; response_revision:2636; number_of_response:1; }","duration":"195.395305ms","start":"2026-09-07T10:51:05.317859Z","end":"2026-09-07T10:51:05.513254Z","steps":["trace[1673720878] 'process raft request'  (duration: 195.192271ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:51:05.5135Z","caller":"traceutil/trace.go:171","msg":"trace[109304332] linearizableReadLoop","detail":"{readStateIndex:2742; appliedIndex:2740; }","duration":"195.13332ms","start":"2026-09-07T10:51:05.318329Z","end":"2026-09-07T10:51:05.513462Z","steps":["trace[109304332] 'read index received'  (duration: 194.770422ms)","trace[109304332] 'applied index is now lower than readState.Index'  (duration: 359.787µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T10:51:05.513584Z","caller":"traceutil/trace.go:171","msg":"trace[299383630] transaction","detail":"{read_only:false; response_revision:2637; number_of_response:1; }","duration":"195.669211ms","start":"2026-09-07T10:51:05.31787Z","end":"2026-09-07T10:51:05.513539Z","steps":["trace[299383630] 'process raft request'  (duration: 195.345444ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:51:05.513767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.385435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-07T10:51:05.513868Z","caller":"traceutil/trace.go:171","msg":"trace[1960231304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2637; }","duration":"195.542629ms","start":"2026-09-07T10:51:05.318305Z","end":"2026-09-07T10:51:05.513848Z","steps":["trace[1960231304] 'agreement among raft nodes before linearized reading'  (duration: 195.262143ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:51:05.530968Z","caller":"traceutil/trace.go:171","msg":"trace[1655629533] transaction","detail":"{read_only:false; response_revision:2638; number_of_response:1; }","duration":"149.707154ms","start":"2026-09-07T10:51:05.381242Z","end":"2026-09-07T10:51:05.530949Z","steps":["trace[1655629533] 'process raft request'  (duration: 149.591581ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:55:06.794119Z","caller":"traceutil/trace.go:171","msg":"trace[2111429588] transaction","detail":"{read_only:false; response_revision:4132; number_of_response:1; }","duration":"142.872192ms","start":"2026-09-07T10:55:06.651216Z","end":"2026-09-07T10:55:06.794089Z","steps":["trace[2111429588] 'process raft request'  (duration: 142.684068ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:56:41.089667Z","caller":"traceutil/trace.go:171","msg":"trace[730247651] linearizableReadLoop","detail":"{readStateIndex:5434; appliedIndex:5433; }","duration":"113.401512ms","start":"2026-09-07T10:56:40.976232Z","end":"2026-09-07T10:56:41.089634Z","steps":["trace[730247651] 'read index received'  (duration: 113.180628ms)","trace[730247651] 'applied index is now lower than readState.Index'  (duration: 219.364µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T10:56:41.089848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.603027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T10:56:41.08989Z","caller":"traceutil/trace.go:171","msg":"trace[361988015] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:5231; }","duration":"113.745111ms","start":"2026-09-07T10:56:40.976134Z","end":"2026-09-07T10:56:41.08988Z","steps":["trace[361988015] 'agreement among raft nodes before linearized reading'  (duration: 113.637198ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:56:41.090162Z","caller":"traceutil/trace.go:171","msg":"trace[1311595969] transaction","detail":"{read_only:false; response_revision:5231; number_of_response:1; }","duration":"154.339647ms","start":"2026-09-07T10:56:40.935788Z","end":"2026-09-07T10:56:41.090128Z","steps":["trace[1311595969] 'process raft request'  (duration: 153.641472ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:56:41.200832Z","caller":"traceutil/trace.go:171","msg":"trace[1729107788] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"101.786155ms","start":"2026-09-07T10:56:41.099002Z","end":"2026-09-07T10:56:41.200788Z","steps":["trace[1729107788] 'process raft request'  (duration: 101.14775ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:56:45.28053Z","caller":"traceutil/trace.go:171","msg":"trace[1658556804] linearizableReadLoop","detail":"{readStateIndex:5586; appliedIndex:5585; }","duration":"122.726212ms","start":"2026-09-07T10:56:45.157777Z","end":"2026-09-07T10:56:45.280503Z","steps":["trace[1658556804] 'read index received'  (duration: 61.098935ms)","trace[1658556804] 'applied index is now lower than readState.Index'  (duration: 61.625106ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T10:56:45.280539Z","caller":"traceutil/trace.go:171","msg":"trace[2015298267] transaction","detail":"{read_only:false; response_revision:5378; number_of_response:1; }","duration":"123.896916ms","start":"2026-09-07T10:56:45.156576Z","end":"2026-09-07T10:56:45.280473Z","steps":["trace[2015298267] 'process raft request'  (duration: 62.391382ms)","trace[2015298267] 'compare'  (duration: 61.30052ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T10:56:45.280711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.907225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T10:56:45.280759Z","caller":"traceutil/trace.go:171","msg":"trace[1870033157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5379; }","duration":"123.026678ms","start":"2026-09-07T10:56:45.157717Z","end":"2026-09-07T10:56:45.280743Z","steps":["trace[1870033157] 'agreement among raft nodes before linearized reading'  (duration: 122.887045ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:56:58.845406Z","caller":"traceutil/trace.go:171","msg":"trace[163984309] linearizableReadLoop","detail":"{readStateIndex:5837; appliedIndex:5836; }","duration":"157.759709ms","start":"2026-09-07T10:56:58.687619Z","end":"2026-09-07T10:56:58.845379Z","steps":["trace[163984309] 'read index received'  (duration: 157.536315ms)","trace[163984309] 'applied index is now lower than readState.Index'  (duration: 222.544µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T10:56:58.845452Z","caller":"traceutil/trace.go:171","msg":"trace[481190889] transaction","detail":"{read_only:false; response_revision:5622; number_of_response:1; }","duration":"299.819334ms","start":"2026-09-07T10:56:58.545616Z","end":"2026-09-07T10:56:58.845435Z","steps":["trace[481190889] 'process raft request'  (duration: 299.59937ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:56:58.845603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.979334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-09-07T10:56:58.845644Z","caller":"traceutil/trace.go:171","msg":"trace[2120270604] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5622; }","duration":"158.032595ms","start":"2026-09-07T10:56:58.687598Z","end":"2026-09-07T10:56:58.845631Z","steps":["trace[2120270604] 'agreement among raft nodes before linearized reading'  (duration: 157.884981ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:57:06.887338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.462825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-09-07T10:57:06.887418Z","caller":"traceutil/trace.go:171","msg":"trace[241990070] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5817; }","duration":"148.612028ms","start":"2026-09-07T10:57:06.738792Z","end":"2026-09-07T10:57:06.887404Z","steps":["trace[241990070] 'range keys from in-memory index tree'  (duration: 148.21504ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T10:57:07.227796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.787162ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7429708462476341172 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5725 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T10:57:07.228183Z","caller":"traceutil/trace.go:171","msg":"trace[119172122] transaction","detail":"{read_only:false; response_revision:5819; number_of_response:1; }","duration":"164.046327ms","start":"2026-09-07T10:57:07.064054Z","end":"2026-09-07T10:57:07.228101Z","steps":["trace[119172122] 'process raft request'  (duration: 54.796775ms)","trace[119172122] 'compare'  (duration: 108.587757ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T10:57:09.247876Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3006}
{"level":"info","ts":"2026-09-07T10:57:09.335666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3006,"took":"86.443657ms","hash":1336813069,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":29818880,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-07T10:57:09.335722Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1336813069,"revision":3006,"compact-revision":-1}
{"level":"info","ts":"2026-09-07T10:57:18.983558Z","caller":"traceutil/trace.go:171","msg":"trace[1005881635] transaction","detail":"{read_only:false; response_revision:5951; number_of_response:1; }","duration":"131.118316ms","start":"2026-09-07T10:57:18.852385Z","end":"2026-09-07T10:57:18.983503Z","steps":["trace[1005881635] 'process raft request'  (duration: 130.769689ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:57:18.983626Z","caller":"traceutil/trace.go:171","msg":"trace[234939424] transaction","detail":"{read_only:false; response_revision:5952; number_of_response:1; }","duration":"130.532215ms","start":"2026-09-07T10:57:18.853051Z","end":"2026-09-07T10:57:18.983583Z","steps":["trace[234939424] 'process raft request'  (duration: 130.326181ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:57:18.98356Z","caller":"traceutil/trace.go:171","msg":"trace[1599247061] linearizableReadLoop","detail":"{readStateIndex:6176; appliedIndex:6172; }","duration":"127.00864ms","start":"2026-09-07T10:57:18.856514Z","end":"2026-09-07T10:57:18.983522Z","steps":["trace[1599247061] 'read index received'  (duration: 5.044637ms)","trace[1599247061] 'applied index is now lower than readState.Index'  (duration: 121.962403ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T10:57:18.983852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.314737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-09-07T10:57:18.983969Z","caller":"traceutil/trace.go:171","msg":"trace[694308094] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5953; }","duration":"127.48225ms","start":"2026-09-07T10:57:18.856439Z","end":"2026-09-07T10:57:18.983921Z","steps":["trace[694308094] 'agreement among raft nodes before linearized reading'  (duration: 127.208264ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T10:57:18.983851Z","caller":"traceutil/trace.go:171","msg":"trace[1892096944] transaction","detail":"{read_only:false; response_revision:5953; number_of_response:1; }","duration":"130.604476ms","start":"2026-09-07T10:57:18.853212Z","end":"2026-09-07T10:57:18.983816Z","steps":["trace[1892096944] 'process raft request'  (duration: 130.246778ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:02:09.255515Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5848}
{"level":"info","ts":"2026-09-07T11:02:09.346577Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5848,"took":"89.293177ms","hash":3267085952,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":26849280,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-07T11:02:09.346647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3267085952,"revision":5848,"compact-revision":3006}
{"level":"info","ts":"2026-09-07T11:03:32.396548Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002349.wal"}
{"level":"info","ts":"2026-09-07T11:03:35.932895Z","caller":"traceutil/trace.go:171","msg":"trace[434588781] transaction","detail":"{read_only:false; response_revision:8744; number_of_response:1; }","duration":"108.121329ms","start":"2026-09-07T11:03:35.824738Z","end":"2026-09-07T11:03:35.932859Z","steps":["trace[434588781] 'process raft request'  (duration: 107.079726ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:03:47.898591Z","caller":"traceutil/trace.go:171","msg":"trace[1913118398] transaction","detail":"{read_only:false; response_revision:8805; number_of_response:1; }","duration":"117.126813ms","start":"2026-09-07T11:03:47.781404Z","end":"2026-09-07T11:03:47.898531Z","steps":["trace[1913118398] 'process raft request'  (duration: 116.595201ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:03:48.303427Z","caller":"traceutil/trace.go:171","msg":"trace[1257799788] transaction","detail":"{read_only:false; response_revision:8808; number_of_response:1; }","duration":"237.716162ms","start":"2026-09-07T11:03:48.065677Z","end":"2026-09-07T11:03:48.303393Z","steps":["trace[1257799788] 'process raft request'  (duration: 221.541792ms)","trace[1257799788] 'compare'  (duration: 15.590616ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:03:49.031553Z","caller":"traceutil/trace.go:171","msg":"trace[990308272] transaction","detail":"{read_only:false; response_revision:8810; number_of_response:1; }","duration":"166.44276ms","start":"2026-09-07T11:03:48.865073Z","end":"2026-09-07T11:03:49.031516Z","steps":["trace[990308272] 'process raft request'  (duration: 166.219476ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:03:49.079698Z","caller":"traceutil/trace.go:171","msg":"trace[133208989] linearizableReadLoop","detail":"{readStateIndex:9128; appliedIndex:9126; }","duration":"116.340606ms","start":"2026-09-07T11:03:48.963326Z","end":"2026-09-07T11:03:49.079667Z","steps":["trace[133208989] 'read index received'  (duration: 67.95582ms)","trace[133208989] 'applied index is now lower than readState.Index'  (duration: 48.383466ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:03:49.079743Z","caller":"traceutil/trace.go:171","msg":"trace[1300158915] transaction","detail":"{read_only:false; response_revision:8811; number_of_response:1; }","duration":"160.109053ms","start":"2026-09-07T11:03:48.919592Z","end":"2026-09-07T11:03:49.079701Z","steps":["trace[1300158915] 'process raft request'  (duration: 147.109632ms)","trace[1300158915] 'compare'  (duration: 12.839998ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T11:03:49.079889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.49307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:03:49.080032Z","caller":"traceutil/trace.go:171","msg":"trace[1792350028] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8811; }","duration":"116.720815ms","start":"2026-09-07T11:03:48.963253Z","end":"2026-09-07T11:03:49.079974Z","steps":["trace[1792350028] 'agreement among raft nodes before linearized reading'  (duration: 116.520331ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:03:49.48846Z","caller":"traceutil/trace.go:171","msg":"trace[1602512248] transaction","detail":"{read_only:false; response_revision:8814; number_of_response:1; }","duration":"152.660883ms","start":"2026-09-07T11:03:49.335775Z","end":"2026-09-07T11:03:49.488435Z","steps":["trace[1602512248] 'process raft request'  (duration: 152.491359ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:04:18.064012Z","caller":"traceutil/trace.go:171","msg":"trace[136689607] transaction","detail":"{read_only:false; response_revision:9020; number_of_response:1; }","duration":"138.734091ms","start":"2026-09-07T11:04:17.925253Z","end":"2026-09-07T11:04:18.063987Z","steps":["trace[136689607] 'process raft request'  (duration: 138.546247ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:04:18.357931Z","caller":"traceutil/trace.go:171","msg":"trace[2026887878] linearizableReadLoop","detail":"{readStateIndex:9346; appliedIndex:9345; }","duration":"196.96583ms","start":"2026-09-07T11:04:18.160943Z","end":"2026-09-07T11:04:18.357909Z","steps":["trace[2026887878] 'read index received'  (duration: 196.817147ms)","trace[2026887878] 'applied index is now lower than readState.Index'  (duration: 147.843µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:04:18.358217Z","caller":"traceutil/trace.go:171","msg":"trace[1928294954] transaction","detail":"{read_only:false; response_revision:9021; number_of_response:1; }","duration":"237.659861ms","start":"2026-09-07T11:04:18.120535Z","end":"2026-09-07T11:04:18.358195Z","steps":["trace[1928294954] 'process raft request'  (duration: 237.229292ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:04:18.358393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.389859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:04:18.358493Z","caller":"traceutil/trace.go:171","msg":"trace[1010332838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9021; }","duration":"197.562023ms","start":"2026-09-07T11:04:18.160908Z","end":"2026-09-07T11:04:18.35847Z","steps":["trace[1010332838] 'agreement among raft nodes before linearized reading'  (duration: 197.331848ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:04:18.369875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.069854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-07T11:04:18.37038Z","caller":"traceutil/trace.go:171","msg":"trace[1296742781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9021; }","duration":"131.572426ms","start":"2026-09-07T11:04:18.238754Z","end":"2026-09-07T11:04:18.370326Z","steps":["trace[1296742781] 'agreement among raft nodes before linearized reading'  (duration: 131.023543ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:04:30.143995Z","caller":"traceutil/trace.go:171","msg":"trace[1985701852] linearizableReadLoop","detail":"{readStateIndex:9411; appliedIndex:9410; }","duration":"107.434963ms","start":"2026-09-07T11:04:30.036532Z","end":"2026-09-07T11:04:30.143967Z","steps":["trace[1985701852] 'read index received'  (duration: 107.271159ms)","trace[1985701852] 'applied index is now lower than readState.Index'  (duration: 162.514µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:04:30.144126Z","caller":"traceutil/trace.go:171","msg":"trace[310216204] transaction","detail":"{read_only:false; response_revision:9083; number_of_response:1; }","duration":"110.52651ms","start":"2026-09-07T11:04:30.033533Z","end":"2026-09-07T11:04:30.144059Z","steps":["trace[310216204] 'process raft request'  (duration: 110.265074ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:04:30.144228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.67683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-09-07T11:04:30.144262Z","caller":"traceutil/trace.go:171","msg":"trace[166156472] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9083; }","duration":"107.754141ms","start":"2026-09-07T11:04:30.036497Z","end":"2026-09-07T11:04:30.144251Z","steps":["trace[166156472] 'agreement among raft nodes before linearized reading'  (duration: 107.574266ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:04:30.980999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.286847ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7429708462476349761 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:9077 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T11:04:30.981211Z","caller":"traceutil/trace.go:171","msg":"trace[258096662] transaction","detail":"{read_only:false; response_revision:9087; number_of_response:1; }","duration":"293.602731ms","start":"2026-09-07T11:04:30.687575Z","end":"2026-09-07T11:04:30.981178Z","steps":["trace[258096662] 'process raft request'  (duration: 53.012467ms)","trace[258096662] 'compare'  (duration: 240.104793ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:05:32.568922Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"522eb07aa35b671b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-07T11:05:32.57498Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-07T11:05:32.575229Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-07T11:05:47.764679Z","caller":"traceutil/trace.go:171","msg":"trace[865785097] transaction","detail":"{read_only:false; response_revision:9877; number_of_response:1; }","duration":"123.474737ms","start":"2026-09-07T11:05:47.641169Z","end":"2026-09-07T11:05:47.764644Z","steps":["trace[865785097] 'process raft request'  (duration: 69.617746ms)","trace[865785097] 'compare'  (duration: 53.244017ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:05:47.764736Z","caller":"traceutil/trace.go:171","msg":"trace[65755352] transaction","detail":"{read_only:false; response_revision:9878; number_of_response:1; }","duration":"103.396748ms","start":"2026-09-07T11:05:47.661309Z","end":"2026-09-07T11:05:47.764705Z","steps":["trace[65755352] 'process raft request'  (duration: 103.205374ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:05:47.764957Z","caller":"traceutil/trace.go:171","msg":"trace[1707421738] transaction","detail":"{read_only:false; response_revision:9879; number_of_response:1; }","duration":"102.840157ms","start":"2026-09-07T11:05:47.662078Z","end":"2026-09-07T11:05:47.764918Z","steps":["trace[1707421738] 'process raft request'  (duration: 102.561971ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:06:02.617156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.598849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:06:02.617295Z","caller":"traceutil/trace.go:171","msg":"trace[1946561070] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:9958; }","duration":"212.800463ms","start":"2026-09-07T11:06:02.404468Z","end":"2026-09-07T11:06:02.617268Z","steps":["trace[1946561070] 'range keys from in-memory index tree'  (duration: 212.528268ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:06:02.618512Z","caller":"traceutil/trace.go:171","msg":"trace[191726732] transaction","detail":"{read_only:false; response_revision:9959; number_of_response:1; }","duration":"121.253049ms","start":"2026-09-07T11:06:02.4961Z","end":"2026-09-07T11:06:02.617353Z","steps":["trace[191726732] 'process raft request'  (duration: 120.962442ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:07:09.264502Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8056}
{"level":"info","ts":"2026-09-07T11:07:09.339001Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8056,"took":"72.408297ms","hash":309234468,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":28123136,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-07T11:07:09.339072Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":309234468,"revision":8056,"compact-revision":5848}
{"level":"info","ts":"2026-09-07T11:11:29.070644Z","caller":"traceutil/trace.go:171","msg":"trace[1088065200] transaction","detail":"{read_only:false; response_revision:12325; number_of_response:1; }","duration":"167.135902ms","start":"2026-09-07T11:11:28.903483Z","end":"2026-09-07T11:11:29.070619Z","steps":["trace[1088065200] 'process raft request'  (duration: 166.980489ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.617987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.740752ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7429708462476358394 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:12315 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T11:11:29.618178Z","caller":"traceutil/trace.go:171","msg":"trace[1050236707] transaction","detail":"{read_only:false; response_revision:12328; number_of_response:1; }","duration":"387.252826ms","start":"2026-09-07T11:11:29.230908Z","end":"2026-09-07T11:11:29.618161Z","steps":["trace[1050236707] 'process raft request'  (duration: 387.217625ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.61828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:29.23088Z","time spent":"387.369978ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:12318 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-07T11:11:29.618282Z","caller":"traceutil/trace.go:171","msg":"trace[1589035603] linearizableReadLoop","detail":"{readStateIndex:12760; appliedIndex:12758; }","duration":"638.571646ms","start":"2026-09-07T11:11:28.97968Z","end":"2026-09-07T11:11:29.618251Z","steps":["trace[1589035603] 'read index received'  (duration: 90.78353ms)","trace[1589035603] 'applied index is now lower than readState.Index'  (duration: 547.785266ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:11:29.61843Z","caller":"traceutil/trace.go:171","msg":"trace[1493663961] transaction","detail":"{read_only:false; response_revision:12326; number_of_response:1; }","duration":"701.324388ms","start":"2026-09-07T11:11:28.917092Z","end":"2026-09-07T11:11:29.618416Z","steps":["trace[1493663961] 'process raft request'  (duration: 381.074694ms)","trace[1493663961] 'compare'  (duration: 319.64271ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T11:11:29.618541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:28.917066Z","time spent":"701.397249ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:12315 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-07T11:11:29.618765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.099117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-09-07T11:11:29.618801Z","caller":"traceutil/trace.go:171","msg":"trace[2074222079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12328; }","duration":"639.18406ms","start":"2026-09-07T11:11:28.979607Z","end":"2026-09-07T11:11:29.618791Z","steps":["trace[2074222079] 'agreement among raft nodes before linearized reading'  (duration: 639.047727ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.618834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:28.979582Z","time spent":"639.242742ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-09-07T11:11:29.619031Z","caller":"traceutil/trace.go:171","msg":"trace[233438949] transaction","detail":"{read_only:false; response_revision:12327; number_of_response:1; }","duration":"478.535806ms","start":"2026-09-07T11:11:29.140465Z","end":"2026-09-07T11:11:29.619001Z","steps":["trace[233438949] 'process raft request'  (duration: 477.610656ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.621021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:29.140435Z","time spent":"478.898284ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:12317 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-07T11:11:29.678503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.690745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T11:11:29.678601Z","caller":"traceutil/trace.go:171","msg":"trace[591981305] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:12329; }","duration":"547.843477ms","start":"2026-09-07T11:11:29.130733Z","end":"2026-09-07T11:11:29.678576Z","steps":["trace[591981305] 'agreement among raft nodes before linearized reading'  (duration: 547.650983ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.678642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:29.130709Z","time spent":"547.923099ms","remote":"127.0.0.1:44288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":4,"response size":29,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "}
{"level":"info","ts":"2026-09-07T11:11:29.678977Z","caller":"traceutil/trace.go:171","msg":"trace[1179836186] transaction","detail":"{read_only:false; response_revision:12329; number_of_response:1; }","duration":"286.115444ms","start":"2026-09-07T11:11:29.392851Z","end":"2026-09-07T11:11:29.678967Z","steps":["trace[1179836186] 'process raft request'  (duration: 285.355528ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.679237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.581583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-07T11:11:29.679274Z","caller":"traceutil/trace.go:171","msg":"trace[129210378] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12329; }","duration":"205.648875ms","start":"2026-09-07T11:11:29.473615Z","end":"2026-09-07T11:11:29.679264Z","steps":["trace[129210378] 'agreement among raft nodes before linearized reading'  (duration: 205.482471ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.679455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.387874ms","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-09-07T11:11:29.679487Z","caller":"traceutil/trace.go:171","msg":"trace[2128541028] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:12329; }","duration":"275.449806ms","start":"2026-09-07T11:11:29.404029Z","end":"2026-09-07T11:11:29.679479Z","steps":["trace[2128541028] 'agreement among raft nodes before linearized reading'  (duration: 275.353004ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.679682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.144324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-09-07T11:11:29.679714Z","caller":"traceutil/trace.go:171","msg":"trace[885819637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12329; }","duration":"388.215386ms","start":"2026-09-07T11:11:29.291491Z","end":"2026-09-07T11:11:29.679707Z","steps":["trace[885819637] 'agreement among raft nodes before linearized reading'  (duration: 388.125384ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.679737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:29.291467Z","time spent":"388.263726ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-07T11:11:29.679967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.213495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:11:29.680111Z","caller":"traceutil/trace.go:171","msg":"trace[41917365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12329; }","duration":"519.336929ms","start":"2026-09-07T11:11:29.160692Z","end":"2026-09-07T11:11:29.680029Z","steps":["trace[41917365] 'agreement among raft nodes before linearized reading'  (duration: 519.100603ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.680304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:29.160671Z","time spent":"519.574954ms","remote":"127.0.0.1:46564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-07T11:11:29.791504Z","caller":"traceutil/trace.go:171","msg":"trace[1046015382] transaction","detail":"{read_only:false; response_revision:12331; number_of_response:1; }","duration":"107.499467ms","start":"2026-09-07T11:11:29.683959Z","end":"2026-09-07T11:11:29.791459Z","steps":["trace[1046015382] 'process raft request'  (duration: 64.398596ms)","trace[1046015382] 'compare'  (duration: 42.905957ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:11:29.791688Z","caller":"traceutil/trace.go:171","msg":"trace[1940217288] transaction","detail":"{read_only:false; response_revision:12332; number_of_response:1; }","duration":"106.146488ms","start":"2026-09-07T11:11:29.68552Z","end":"2026-09-07T11:11:29.791667Z","steps":["trace[1940217288] 'process raft request'  (duration: 105.891913ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:29.791776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.772453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-f1b43e74-c637-4b93-ad22-a7ddf5f6f8d9\" ","response":"range_response_count:1 size:1322"}
{"level":"info","ts":"2026-09-07T11:11:29.791826Z","caller":"traceutil/trace.go:171","msg":"trace[925832334] range","detail":"{range_begin:/registry/persistentvolumes/pvc-f1b43e74-c637-4b93-ad22-a7ddf5f6f8d9; range_end:; response_count:1; response_revision:12332; }","duration":"108.862175ms","start":"2026-09-07T11:11:29.68295Z","end":"2026-09-07T11:11:29.791812Z","steps":["trace[925832334] 'agreement among raft nodes before linearized reading'  (duration: 108.638211ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:30.436928Z","caller":"traceutil/trace.go:171","msg":"trace[994494458] transaction","detail":"{read_only:false; response_revision:12333; number_of_response:1; }","duration":"116.96333ms","start":"2026-09-07T11:11:30.319941Z","end":"2026-09-07T11:11:30.436905Z","steps":["trace[994494458] 'process raft request'  (duration: 116.567881ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:31.764589Z","caller":"traceutil/trace.go:171","msg":"trace[807651740] transaction","detail":"{read_only:false; response_revision:12335; number_of_response:1; }","duration":"140.404802ms","start":"2026-09-07T11:11:31.624119Z","end":"2026-09-07T11:11:31.764524Z","steps":["trace[807651740] 'process raft request'  (duration: 140.153186ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:32.154419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.166766ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7429708462476358436 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:12328 > 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:16"}
{"level":"info","ts":"2026-09-07T11:11:32.154606Z","caller":"traceutil/trace.go:171","msg":"trace[722967118] linearizableReadLoop","detail":"{readStateIndex:12772; appliedIndex:12768; }","duration":"447.717557ms","start":"2026-09-07T11:11:31.706877Z","end":"2026-09-07T11:11:32.154595Z","steps":["trace[722967118] 'read index received'  (duration: 57.337195ms)","trace[722967118] 'applied index is now lower than readState.Index'  (duration: 390.379392ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:11:32.15461Z","caller":"traceutil/trace.go:171","msg":"trace[1610738554] transaction","detail":"{read_only:false; response_revision:12336; number_of_response:1; }","duration":"529.832052ms","start":"2026-09-07T11:11:31.624751Z","end":"2026-09-07T11:11:32.154583Z","steps":["trace[1610738554] 'process raft request'  (duration: 374.40574ms)","trace[1610738554] 'compare'  (duration: 154.86853ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T11:11:32.154706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:31.624725Z","time spent":"529.932154ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:12328 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-07T11:11:32.154824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.183515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-07T11:11:32.154845Z","caller":"traceutil/trace.go:171","msg":"trace[373305335] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12338; }","duration":"359.247116ms","start":"2026-09-07T11:11:31.795591Z","end":"2026-09-07T11:11:32.154838Z","steps":["trace[373305335] 'agreement among raft nodes before linearized reading'  (duration: 359.157994ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:32.154865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:31.795559Z","time spent":"359.300378ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-07T11:11:32.154875Z","caller":"traceutil/trace.go:171","msg":"trace[1048075946] transaction","detail":"{read_only:false; response_revision:12337; number_of_response:1; }","duration":"529.885113ms","start":"2026-09-07T11:11:31.624954Z","end":"2026-09-07T11:11:32.154839Z","steps":["trace[1048075946] 'process raft request'  (duration: 529.542116ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:32.154945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:31.624936Z","time spent":"529.969725ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:12327 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-07T11:11:32.155047Z","caller":"traceutil/trace.go:171","msg":"trace[1522421037] transaction","detail":"{read_only:false; response_revision:12338; number_of_response:1; }","duration":"469.790729ms","start":"2026-09-07T11:11:31.685245Z","end":"2026-09-07T11:11:32.155035Z","steps":["trace[1522421037] 'process raft request'  (duration: 469.310329ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:32.155085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.333426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:15 size:143763"}
{"level":"info","ts":"2026-09-07T11:11:32.155105Z","caller":"traceutil/trace.go:171","msg":"trace[45732000] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:15; response_revision:12338; }","duration":"292.355548ms","start":"2026-09-07T11:11:31.862743Z","end":"2026-09-07T11:11:32.155099Z","steps":["trace[45732000] 'agreement among raft nodes before linearized reading'  (duration: 292.165934ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:32.155114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:31.685211Z","time spent":"469.860771ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:12329 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-09-07T11:11:32.15508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.151827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-09-07T11:11:32.155227Z","caller":"traceutil/trace.go:171","msg":"trace[539678249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12338; }","duration":"448.33251ms","start":"2026-09-07T11:11:31.706834Z","end":"2026-09-07T11:11:32.155167Z","steps":["trace[539678249] 'agreement among raft nodes before linearized reading'  (duration: 447.903901ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:32.15529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:31.706813Z","time spent":"448.463844ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-07T11:11:32.155314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.450131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-09-07T11:11:32.155338Z","caller":"traceutil/trace.go:171","msg":"trace[797573817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12338; }","duration":"359.508402ms","start":"2026-09-07T11:11:31.795823Z","end":"2026-09-07T11:11:32.155331Z","steps":["trace[797573817] 'agreement among raft nodes before linearized reading'  (duration: 359.44595ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:32.155355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:31.795798Z","time spent":"359.552173ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-07T11:11:32.452692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.398538ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7429708462476358444 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:12332 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-07T11:11:32.453124Z","caller":"traceutil/trace.go:171","msg":"trace[659881000] transaction","detail":"{read_only:false; response_revision:12340; number_of_response:1; }","duration":"288.673568ms","start":"2026-09-07T11:11:32.164411Z","end":"2026-09-07T11:11:32.453085Z","steps":["trace[659881000] 'process raft request'  (duration: 97.790669ms)","trace[659881000] 'compare'  (duration: 190.226465ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:11:32.453334Z","caller":"traceutil/trace.go:171","msg":"trace[1266579702] transaction","detail":"{read_only:false; response_revision:12342; number_of_response:1; }","duration":"241.811947ms","start":"2026-09-07T11:11:32.211481Z","end":"2026-09-07T11:11:32.453293Z","steps":["trace[1266579702] 'process raft request'  (duration: 241.380777ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:32.453701Z","caller":"traceutil/trace.go:171","msg":"trace[190076390] transaction","detail":"{read_only:false; response_revision:12341; number_of_response:1; }","duration":"289.106779ms","start":"2026-09-07T11:11:32.164541Z","end":"2026-09-07T11:11:32.453648Z","steps":["trace[190076390] 'process raft request'  (duration: 288.25321ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:35.301139Z","caller":"traceutil/trace.go:171","msg":"trace[1907231218] linearizableReadLoop","detail":"{readStateIndex:12794; appliedIndex:12793; }","duration":"154.507952ms","start":"2026-09-07T11:11:35.146599Z","end":"2026-09-07T11:11:35.301107Z","steps":["trace[1907231218] 'read index received'  (duration: 154.211126ms)","trace[1907231218] 'applied index is now lower than readState.Index'  (duration: 295.666µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:11:35.301334Z","caller":"traceutil/trace.go:171","msg":"trace[2028212038] transaction","detail":"{read_only:false; response_revision:12359; number_of_response:1; }","duration":"221.898772ms","start":"2026-09-07T11:11:35.079391Z","end":"2026-09-07T11:11:35.30129Z","steps":["trace[2028212038] 'process raft request'  (duration: 221.518024ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:35.301437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.235828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:11:35.301497Z","caller":"traceutil/trace.go:171","msg":"trace[865625136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12359; }","duration":"141.36444ms","start":"2026-09-07T11:11:35.160119Z","end":"2026-09-07T11:11:35.301484Z","steps":["trace[865625136] 'agreement among raft nodes before linearized reading'  (duration: 141.226787ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:35.301502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.87896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-07T11:11:35.301594Z","caller":"traceutil/trace.go:171","msg":"trace[620127511] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12359; }","duration":"155.052763ms","start":"2026-09-07T11:11:35.146519Z","end":"2026-09-07T11:11:35.301572Z","steps":["trace[620127511] 'agreement among raft nodes before linearized reading'  (duration: 154.779907ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:35.453288Z","caller":"traceutil/trace.go:171","msg":"trace[1775817391] transaction","detail":"{read_only:false; response_revision:12360; number_of_response:1; }","duration":"148.231028ms","start":"2026-09-07T11:11:35.305021Z","end":"2026-09-07T11:11:35.453252Z","steps":["trace[1775817391] 'process raft request'  (duration: 94.295996ms)","trace[1775817391] 'compare'  (duration: 53.606925ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:11:35.453419Z","caller":"traceutil/trace.go:171","msg":"trace[608606103] transaction","detail":"{read_only:false; response_revision:12361; number_of_response:1; }","duration":"119.087174ms","start":"2026-09-07T11:11:35.334311Z","end":"2026-09-07T11:11:35.453398Z","steps":["trace[608606103] 'process raft request'  (duration: 118.846249ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:36.382975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.228654ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7429708462476358537 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:12355 > 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:16"}
{"level":"info","ts":"2026-09-07T11:11:36.383154Z","caller":"traceutil/trace.go:171","msg":"trace[17276134] transaction","detail":"{read_only:false; response_revision:12366; number_of_response:1; }","duration":"159.083149ms","start":"2026-09-07T11:11:36.224025Z","end":"2026-09-07T11:11:36.383109Z","steps":["trace[17276134] 'process raft request'  (duration: 56.562169ms)","trace[17276134] 'compare'  (duration: 102.04522ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:11:36.712684Z","caller":"traceutil/trace.go:171","msg":"trace[1949162521] transaction","detail":"{read_only:false; response_revision:12368; number_of_response:1; }","duration":"102.807737ms","start":"2026-09-07T11:11:36.609847Z","end":"2026-09-07T11:11:36.712654Z","steps":["trace[1949162521] 'process raft request'  (duration: 102.626563ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:36.730478Z","caller":"traceutil/trace.go:171","msg":"trace[1362279195] linearizableReadLoop","detail":"{readStateIndex:12804; appliedIndex:12802; }","duration":"119.136936ms","start":"2026-09-07T11:11:36.611306Z","end":"2026-09-07T11:11:36.730442Z","steps":["trace[1362279195] 'read index received'  (duration: 101.152052ms)","trace[1362279195] 'applied index is now lower than readState.Index'  (duration: 17.983094ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:11:36.730627Z","caller":"traceutil/trace.go:171","msg":"trace[1104307797] transaction","detail":"{read_only:false; response_revision:12369; number_of_response:1; }","duration":"120.557976ms","start":"2026-09-07T11:11:36.609966Z","end":"2026-09-07T11:11:36.730524Z","steps":["trace[1104307797] 'process raft request'  (duration: 120.28164ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:36.730725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.392881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m2fsr\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-09-07T11:11:36.730795Z","caller":"traceutil/trace.go:171","msg":"trace[1727536156] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m2fsr; range_end:; response_count:1; response_revision:12369; }","duration":"119.501193ms","start":"2026-09-07T11:11:36.611276Z","end":"2026-09-07T11:11:36.730777Z","steps":["trace[1727536156] 'agreement among raft nodes before linearized reading'  (duration: 119.282018ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:36.730822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.67107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-07T11:11:36.730809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.226732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:11:36.730889Z","caller":"traceutil/trace.go:171","msg":"trace[736824272] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12369; }","duration":"107.774923ms","start":"2026-09-07T11:11:36.623098Z","end":"2026-09-07T11:11:36.730873Z","steps":["trace[736824272] 'agreement among raft nodes before linearized reading'  (duration: 107.608239ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:36.730907Z","caller":"traceutil/trace.go:171","msg":"trace[1469742082] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12369; }","duration":"108.387806ms","start":"2026-09-07T11:11:36.622499Z","end":"2026-09-07T11:11:36.730887Z","steps":["trace[1469742082] 'agreement among raft nodes before linearized reading'  (duration: 108.200052ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:36.730986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.812715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"}
{"level":"warn","ts":"2026-09-07T11:11:36.730984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.684621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:11:36.73105Z","caller":"traceutil/trace.go:171","msg":"trace[660547114] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12369; }","duration":"108.909127ms","start":"2026-09-07T11:11:36.622125Z","end":"2026-09-07T11:11:36.731034Z","steps":["trace[660547114] 'agreement among raft nodes before linearized reading'  (duration: 108.748803ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:36.731088Z","caller":"traceutil/trace.go:171","msg":"trace[2011178521] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12369; }","duration":"107.824505ms","start":"2026-09-07T11:11:36.623236Z","end":"2026-09-07T11:11:36.73106Z","steps":["trace[2011178521] 'agreement among raft nodes before linearized reading'  (duration: 107.561738ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:36.731096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.819695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-09-07T11:11:36.731131Z","caller":"traceutil/trace.go:171","msg":"trace[430365508] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12369; }","duration":"108.884387ms","start":"2026-09-07T11:11:36.622238Z","end":"2026-09-07T11:11:36.731122Z","steps":["trace[430365508] 'agreement among raft nodes before linearized reading'  (duration: 108.759023ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:36.731293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.990278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:11:36.731477Z","caller":"traceutil/trace.go:171","msg":"trace[545304085] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12369; }","duration":"108.285515ms","start":"2026-09-07T11:11:36.623165Z","end":"2026-09-07T11:11:36.731451Z","steps":["trace[545304085] 'agreement among raft nodes before linearized reading'  (duration: 107.736512ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:36.935013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.630604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-07T11:11:36.935109Z","caller":"traceutil/trace.go:171","msg":"trace[2139462720] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:12369; }","duration":"118.790128ms","start":"2026-09-07T11:11:36.816298Z","end":"2026-09-07T11:11:36.935088Z","steps":["trace[2139462720] 'count revisions from in-memory index tree'  (duration: 118.498752ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:37.590977Z","caller":"traceutil/trace.go:171","msg":"trace[437584181] transaction","detail":"{read_only:false; response_revision:12370; number_of_response:1; }","duration":"130.695802ms","start":"2026-09-07T11:11:37.460255Z","end":"2026-09-07T11:11:37.590951Z","steps":["trace[437584181] 'process raft request'  (duration: 130.479418ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:38.519247Z","caller":"traceutil/trace.go:171","msg":"trace[1939010884] transaction","detail":"{read_only:false; response_revision:12376; number_of_response:1; }","duration":"120.331622ms","start":"2026-09-07T11:11:38.398891Z","end":"2026-09-07T11:11:38.519223Z","steps":["trace[1939010884] 'process raft request'  (duration: 120.149778ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:39.736175Z","caller":"traceutil/trace.go:171","msg":"trace[1181231056] transaction","detail":"{read_only:false; response_revision:12380; number_of_response:1; }","duration":"136.329023ms","start":"2026-09-07T11:11:39.599819Z","end":"2026-09-07T11:11:39.736148Z","steps":["trace[1181231056] 'process raft request'  (duration: 136.134939ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:45.284603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.291725ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:11:45.284737Z","caller":"traceutil/trace.go:171","msg":"trace[1739146223] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:12409; }","duration":"488.428757ms","start":"2026-09-07T11:11:44.796281Z","end":"2026-09-07T11:11:45.284709Z","steps":["trace[1739146223] 'range keys from in-memory index tree'  (duration: 488.273744ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:45.284733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.006669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m2fsr\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-09-07T11:11:45.284813Z","caller":"traceutil/trace.go:171","msg":"trace[600705348] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m2fsr; range_end:; response_count:1; response_revision:12409; }","duration":"437.140592ms","start":"2026-09-07T11:11:44.847652Z","end":"2026-09-07T11:11:45.284793Z","steps":["trace[600705348] 'range keys from in-memory index tree'  (duration: 436.814575ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:45.284851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:44.847632Z","time spent":"437.210983ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6552,"request content":"key:\"/registry/pods/openstack/keepalived-m2fsr\" "}
{"level":"warn","ts":"2026-09-07T11:11:45.284824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.723867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-07T11:11:45.284957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.069192ms","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-09-07T11:11:45.284964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.312571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-07T11:11:45.285025Z","caller":"traceutil/trace.go:171","msg":"trace[2099913229] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12409; }","duration":"482.182715ms","start":"2026-09-07T11:11:44.802825Z","end":"2026-09-07T11:11:45.285008Z","steps":["trace[2099913229] 'range keys from in-memory index tree'  (duration: 481.873168ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:45.285017Z","caller":"traceutil/trace.go:171","msg":"trace[340507472] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12409; }","duration":"125.954372ms","start":"2026-09-07T11:11:45.159021Z","end":"2026-09-07T11:11:45.284976Z","steps":["trace[340507472] 'range keys from in-memory index tree'  (duration: 125.609665ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:45.285043Z","caller":"traceutil/trace.go:171","msg":"trace[968627512] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12409; }","duration":"471.428564ms","start":"2026-09-07T11:11:44.81359Z","end":"2026-09-07T11:11:45.285018Z","steps":["trace[968627512] 'range keys from in-memory index tree'  (duration: 471.123657ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:45.285081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:44.802803Z","time spent":"482.264866ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-09-07T11:11:45.285093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:11:44.81356Z","time spent":"471.521096ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-09-07T11:11:45.499621Z","caller":"traceutil/trace.go:171","msg":"trace[488046771] transaction","detail":"{read_only:false; response_revision:12410; number_of_response:1; }","duration":"207.136587ms","start":"2026-09-07T11:11:45.29246Z","end":"2026-09-07T11:11:45.499596Z","steps":["trace[488046771] 'process raft request'  (duration: 206.960933ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:45.503415Z","caller":"traceutil/trace.go:171","msg":"trace[651315481] linearizableReadLoop","detail":"{readStateIndex:12848; appliedIndex:12846; }","duration":"138.52129ms","start":"2026-09-07T11:11:45.364869Z","end":"2026-09-07T11:11:45.50339Z","steps":["trace[651315481] 'read index received'  (duration: 134.625867ms)","trace[651315481] 'applied index is now lower than readState.Index'  (duration: 3.894493ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:11:45.503481Z","caller":"traceutil/trace.go:171","msg":"trace[1014571152] transaction","detail":"{read_only:false; response_revision:12411; number_of_response:1; }","duration":"210.541499ms","start":"2026-09-07T11:11:45.292921Z","end":"2026-09-07T11:11:45.503462Z","steps":["trace[1014571152] 'process raft request'  (duration: 210.318854ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:11:45.503655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.759035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-09-07T11:11:45.503726Z","caller":"traceutil/trace.go:171","msg":"trace[1627364892] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:12411; }","duration":"138.847867ms","start":"2026-09-07T11:11:45.364861Z","end":"2026-09-07T11:11:45.503709Z","steps":["trace[1627364892] 'agreement among raft nodes before linearized reading'  (duration: 138.621573ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:45.915977Z","caller":"traceutil/trace.go:171","msg":"trace[1378512836] transaction","detail":"{read_only:false; response_revision:12413; number_of_response:1; }","duration":"113.781411ms","start":"2026-09-07T11:11:45.802174Z","end":"2026-09-07T11:11:45.915955Z","steps":["trace[1378512836] 'process raft request'  (duration: 113.353622ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:46.501156Z","caller":"traceutil/trace.go:171","msg":"trace[1131821634] transaction","detail":"{read_only:false; response_revision:12417; number_of_response:1; }","duration":"214.036193ms","start":"2026-09-07T11:11:46.287097Z","end":"2026-09-07T11:11:46.501133Z","steps":["trace[1131821634] 'process raft request'  (duration: 204.640043ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:46.501302Z","caller":"traceutil/trace.go:171","msg":"trace[1155167652] transaction","detail":"{read_only:false; response_revision:12418; number_of_response:1; }","duration":"175.936809ms","start":"2026-09-07T11:11:46.325343Z","end":"2026-09-07T11:11:46.501279Z","steps":["trace[1155167652] 'process raft request'  (duration: 175.746475ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:11:46.708419Z","caller":"traceutil/trace.go:171","msg":"trace[21454396] transaction","detail":"{read_only:false; response_revision:12419; number_of_response:1; }","duration":"121.512435ms","start":"2026-09-07T11:11:46.586874Z","end":"2026-09-07T11:11:46.708386Z","steps":["trace[21454396] 'process raft request'  (duration: 103.672405ms)","trace[21454396] 'compare'  (duration: 17.716598ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:12:09.271923Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10423}
{"level":"info","ts":"2026-09-07T11:12:09.353498Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10423,"took":"79.384397ms","hash":2441016849,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":25907200,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-07T11:12:09.353549Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2441016849,"revision":10423,"compact-revision":8056}
{"level":"info","ts":"2026-09-07T11:12:48.827385Z","caller":"traceutil/trace.go:171","msg":"trace[305945699] transaction","detail":"{read_only:false; response_revision:12834; number_of_response:1; }","duration":"119.349451ms","start":"2026-09-07T11:12:48.708006Z","end":"2026-09-07T11:12:48.827355Z","steps":["trace[305945699] 'process raft request'  (duration: 119.143027ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:12:48.88602Z","caller":"traceutil/trace.go:171","msg":"trace[700359501] transaction","detail":"{read_only:false; response_revision:12835; number_of_response:1; }","duration":"133.35809ms","start":"2026-09-07T11:12:48.752611Z","end":"2026-09-07T11:12:48.885969Z","steps":["trace[700359501] 'process raft request'  (duration: 133.126684ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:12:48.886152Z","caller":"traceutil/trace.go:171","msg":"trace[777052690] transaction","detail":"{read_only:false; response_revision:12836; number_of_response:1; }","duration":"107.550919ms","start":"2026-09-07T11:12:48.778571Z","end":"2026-09-07T11:12:48.886122Z","steps":["trace[777052690] 'process raft request'  (duration: 107.312603ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:12:49.10196Z","caller":"traceutil/trace.go:171","msg":"trace[1415678855] transaction","detail":"{read_only:false; response_revision:12841; number_of_response:1; }","duration":"116.690174ms","start":"2026-09-07T11:12:48.98524Z","end":"2026-09-07T11:12:49.10193Z","steps":["trace[1415678855] 'process raft request'  (duration: 116.606262ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:12:49.102025Z","caller":"traceutil/trace.go:171","msg":"trace[1657632692] transaction","detail":"{read_only:false; response_revision:12840; number_of_response:1; }","duration":"122.10924ms","start":"2026-09-07T11:12:48.979873Z","end":"2026-09-07T11:12:49.101982Z","steps":["trace[1657632692] 'process raft request'  (duration: 121.814884ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:12:52.855095Z","caller":"traceutil/trace.go:171","msg":"trace[1455371376] transaction","detail":"{read_only:false; response_revision:12866; number_of_response:1; }","duration":"124.452809ms","start":"2026-09-07T11:12:52.730602Z","end":"2026-09-07T11:12:52.855054Z","steps":["trace[1455371376] 'process raft request'  (duration: 124.175123ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:12:53.04307Z","caller":"traceutil/trace.go:171","msg":"trace[1489183381] transaction","detail":"{read_only:false; response_revision:12868; number_of_response:1; }","duration":"125.865679ms","start":"2026-09-07T11:12:52.917182Z","end":"2026-09-07T11:12:53.043047Z","steps":["trace[1489183381] 'process raft request'  (duration: 120.005994ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:12:53.045686Z","caller":"traceutil/trace.go:171","msg":"trace[2054164810] linearizableReadLoop","detail":"{readStateIndex:13322; appliedIndex:13320; }","duration":"125.395028ms","start":"2026-09-07T11:12:52.920257Z","end":"2026-09-07T11:12:53.045652Z","steps":["trace[2054164810] 'read index received'  (duration: 116.970558ms)","trace[2054164810] 'applied index is now lower than readState.Index'  (duration: 8.42229ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:12:53.045813Z","caller":"traceutil/trace.go:171","msg":"trace[325276120] transaction","detail":"{read_only:false; response_revision:12869; number_of_response:1; }","duration":"127.757799ms","start":"2026-09-07T11:12:52.918028Z","end":"2026-09-07T11:12:53.045786Z","steps":["trace[325276120] 'process raft request'  (duration: 127.31953ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:12:53.046052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.725977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-09-07T11:12:53.04611Z","caller":"traceutil/trace.go:171","msg":"trace[1807726357] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:12869; }","duration":"125.914181ms","start":"2026-09-07T11:12:52.920179Z","end":"2026-09-07T11:12:53.046093Z","steps":["trace[1807726357] 'agreement among raft nodes before linearized reading'  (duration: 125.633444ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:17:09.279612Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12589}
{"level":"info","ts":"2026-09-07T11:17:09.362296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12589,"took":"80.937291ms","hash":2087033446,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":27557888,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-07T11:17:09.362392Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2087033446,"revision":12589,"compact-revision":10423}
{"level":"info","ts":"2026-09-07T11:18:20.271705Z","caller":"traceutil/trace.go:171","msg":"trace[1118017911] linearizableReadLoop","detail":"{readStateIndex:15565; appliedIndex:15564; }","duration":"103.928592ms","start":"2026-09-07T11:18:20.167751Z","end":"2026-09-07T11:18:20.271679Z","steps":["trace[1118017911] 'read index received'  (duration: 103.792989ms)","trace[1118017911] 'applied index is now lower than readState.Index'  (duration: 134.343µs)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:18:20.271755Z","caller":"traceutil/trace.go:171","msg":"trace[1802199333] transaction","detail":"{read_only:false; response_revision:15034; number_of_response:1; }","duration":"109.265247ms","start":"2026-09-07T11:18:20.162455Z","end":"2026-09-07T11:18:20.27172Z","steps":["trace[1802199333] 'process raft request'  (duration: 109.066983ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:18:20.271941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.174988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-07T11:18:20.271982Z","caller":"traceutil/trace.go:171","msg":"trace[258486751] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15034; }","duration":"104.2775ms","start":"2026-09-07T11:18:20.167693Z","end":"2026-09-07T11:18:20.27197Z","steps":["trace[258486751] 'agreement among raft nodes before linearized reading'  (duration: 104.125377ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:19:01.742955Z","caller":"traceutil/trace.go:171","msg":"trace[800046807] transaction","detail":"{read_only:false; response_revision:15457; number_of_response:1; }","duration":"217.104054ms","start":"2026-09-07T11:19:01.525827Z","end":"2026-09-07T11:19:01.742932Z","steps":["trace[800046807] 'process raft request'  (duration: 216.91708ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:19:56.958465Z","caller":"traceutil/trace.go:171","msg":"trace[63417261] transaction","detail":"{read_only:false; response_revision:16107; number_of_response:1; }","duration":"113.901692ms","start":"2026-09-07T11:19:56.844534Z","end":"2026-09-07T11:19:56.958436Z","steps":["trace[63417261] 'process raft request'  (duration: 92.35579ms)","trace[63417261] 'compare'  (duration: 21.371118ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:19:56.961935Z","caller":"traceutil/trace.go:171","msg":"trace[681511104] transaction","detail":"{read_only:false; response_revision:16109; number_of_response:1; }","duration":"107.486773ms","start":"2026-09-07T11:19:56.85443Z","end":"2026-09-07T11:19:56.961917Z","steps":["trace[681511104] 'process raft request'  (duration: 107.272819ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:19:56.961837Z","caller":"traceutil/trace.go:171","msg":"trace[1081063084] transaction","detail":"{read_only:false; response_revision:16108; number_of_response:1; }","duration":"109.757532ms","start":"2026-09-07T11:19:56.852052Z","end":"2026-09-07T11:19:56.96181Z","steps":["trace[1081063084] 'process raft request'  (duration: 109.520227ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:20:33.981892Z","caller":"traceutil/trace.go:171","msg":"trace[1146986657] linearizableReadLoop","detail":"{readStateIndex:16873; appliedIndex:16872; }","duration":"105.88281ms","start":"2026-09-07T11:20:33.875991Z","end":"2026-09-07T11:20:33.981874Z","steps":["trace[1146986657] 'read index received'  (duration: 105.839499ms)","trace[1146986657] 'applied index is now lower than readState.Index'  (duration: 42.741µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T11:20:33.981998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.987112ms","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-09-07T11:20:33.982017Z","caller":"traceutil/trace.go:171","msg":"trace[208345640] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16299; }","duration":"106.030623ms","start":"2026-09-07T11:20:33.87598Z","end":"2026-09-07T11:20:33.982011Z","steps":["trace[208345640] 'agreement among raft nodes before linearized reading'  (duration: 105.981412ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:20:33.981927Z","caller":"traceutil/trace.go:171","msg":"trace[1849235424] transaction","detail":"{read_only:false; response_revision:16299; number_of_response:1; }","duration":"106.112584ms","start":"2026-09-07T11:20:33.875798Z","end":"2026-09-07T11:20:33.98191Z","steps":["trace[1849235424] 'process raft request'  (duration: 105.973502ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:20:33.999829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.836266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-07T11:20:33.999852Z","caller":"traceutil/trace.go:171","msg":"trace[1693218087] transaction","detail":"{read_only:false; response_revision:16300; number_of_response:1; }","duration":"121.695027ms","start":"2026-09-07T11:20:33.878099Z","end":"2026-09-07T11:20:33.999794Z","steps":["trace[1693218087] 'process raft request'  (duration: 121.515114ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:20:33.999917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.50649ms","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-09-07T11:20:33.999976Z","caller":"traceutil/trace.go:171","msg":"trace[162373557] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16300; }","duration":"111.580191ms","start":"2026-09-07T11:20:33.888384Z","end":"2026-09-07T11:20:33.999964Z","steps":["trace[162373557] 'agreement among raft nodes before linearized reading'  (duration: 111.487109ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:20:33.999914Z","caller":"traceutil/trace.go:171","msg":"trace[494355057] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16300; }","duration":"111.96427ms","start":"2026-09-07T11:20:33.887926Z","end":"2026-09-07T11:20:33.99989Z","steps":["trace[494355057] 'agreement among raft nodes before linearized reading'  (duration: 111.822037ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:20:34.000217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.443929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-09-07T11:20:34.000358Z","caller":"traceutil/trace.go:171","msg":"trace[126052964] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16300; }","duration":"111.587732ms","start":"2026-09-07T11:20:33.888744Z","end":"2026-09-07T11:20:34.000332Z","steps":["trace[126052964] 'agreement among raft nodes before linearized reading'  (duration: 111.08476ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:20:34.697679Z","caller":"traceutil/trace.go:171","msg":"trace[1252912250] linearizableReadLoop","detail":"{readStateIndex:16876; appliedIndex:16875; }","duration":"119.764097ms","start":"2026-09-07T11:20:34.577829Z","end":"2026-09-07T11:20:34.697593Z","steps":["trace[1252912250] 'read index received'  (duration: 109.922246ms)","trace[1252912250] 'applied index is now lower than readState.Index'  (duration: 9.840331ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:20:34.697737Z","caller":"traceutil/trace.go:171","msg":"trace[1909151529] transaction","detail":"{read_only:false; response_revision:16302; number_of_response:1; }","duration":"199.584648ms","start":"2026-09-07T11:20:34.498103Z","end":"2026-09-07T11:20:34.697688Z","steps":["trace[1909151529] 'process raft request'  (duration: 189.746837ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:20:34.698024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.204046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-09-07T11:20:34.698093Z","caller":"traceutil/trace.go:171","msg":"trace[855776772] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16302; }","duration":"120.319269ms","start":"2026-09-07T11:20:34.577757Z","end":"2026-09-07T11:20:34.698076Z","steps":["trace[855776772] 'agreement among raft nodes before linearized reading'  (duration: 120.122625ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:22:09.312419Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14588}
{"level":"info","ts":"2026-09-07T11:22:09.403306Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14588,"took":"87.890463ms","hash":1353918564,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":31195136,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-07T11:22:09.403455Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1353918564,"revision":14588,"compact-revision":12589}
{"level":"warn","ts":"2026-09-07T11:27:04.329279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.436862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-09-07T11:27:04.329348Z","caller":"traceutil/trace.go:171","msg":"trace[1140262208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19095; }","duration":"125.558245ms","start":"2026-09-07T11:27:04.203776Z","end":"2026-09-07T11:27:04.329334Z","steps":["trace[1140262208] 'range keys from in-memory index tree'  (duration: 125.283928ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:27:04.329546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.553329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-fv9w6\" ","response":"range_response_count:1 size:20747"}
{"level":"info","ts":"2026-09-07T11:27:04.329611Z","caller":"traceutil/trace.go:171","msg":"trace[1404592247] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-fv9w6; range_end:; response_count:1; response_revision:19095; }","duration":"208.644831ms","start":"2026-09-07T11:27:04.120943Z","end":"2026-09-07T11:27:04.329588Z","steps":["trace[1404592247] 'range keys from in-memory index tree'  (duration: 208.429866ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:27:04.329517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.805552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-09-07T11:27:04.329887Z","caller":"traceutil/trace.go:171","msg":"trace[614780306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19095; }","duration":"142.219021ms","start":"2026-09-07T11:27:04.187653Z","end":"2026-09-07T11:27:04.329872Z","steps":["trace[614780306] 'range keys from in-memory index tree'  (duration: 141.636648ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:27:04.55025Z","caller":"traceutil/trace.go:171","msg":"trace[670128374] transaction","detail":"{read_only:false; response_revision:19096; number_of_response:1; }","duration":"215.434416ms","start":"2026-09-07T11:27:04.334795Z","end":"2026-09-07T11:27:04.55023Z","steps":["trace[670128374] 'process raft request'  (duration: 215.292342ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:27:04.686783Z","caller":"traceutil/trace.go:171","msg":"trace[337953470] transaction","detail":"{read_only:false; response_revision:19097; number_of_response:1; }","duration":"351.685329ms","start":"2026-09-07T11:27:04.335062Z","end":"2026-09-07T11:27:04.686748Z","steps":["trace[337953470] 'process raft request'  (duration: 321.190556ms)","trace[337953470] 'compare'  (duration: 30.234417ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:27:04.686835Z","caller":"traceutil/trace.go:171","msg":"trace[1933161652] transaction","detail":"{read_only:false; response_revision:19099; number_of_response:1; }","duration":"134.470295ms","start":"2026-09-07T11:27:04.552337Z","end":"2026-09-07T11:27:04.686808Z","steps":["trace[1933161652] 'process raft request'  (duration: 134.408644ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:27:04.686911Z","caller":"traceutil/trace.go:171","msg":"trace[2139516908] transaction","detail":"{read_only:false; response_revision:19098; number_of_response:1; }","duration":"331.731722ms","start":"2026-09-07T11:27:04.35515Z","end":"2026-09-07T11:27:04.686881Z","steps":["trace[2139516908] 'process raft request'  (duration: 331.486867ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:27:04.686927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:27:04.335053Z","time spent":"351.798251ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:19083 > 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-09-07T11:27:04.687297Z","caller":"traceutil/trace.go:171","msg":"trace[2118793877] linearizableReadLoop","detail":"{readStateIndex:19765; appliedIndex:19763; }","duration":"348.548492ms","start":"2026-09-07T11:27:04.338736Z","end":"2026-09-07T11:27:04.687284Z","steps":["trace[2118793877] 'read index received'  (duration: 211.475272ms)","trace[2118793877] 'applied index is now lower than readState.Index'  (duration: 137.07208ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T11:27:04.687575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:27:04.355119Z","time spent":"331.842434ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20864,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-fv9w6\" mod_revision:19021 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-fv9w6\" value_size:20800 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-fv9w6\" > >"}
{"level":"warn","ts":"2026-09-07T11:27:04.688087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.343979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946642"}
{"level":"info","ts":"2026-09-07T11:27:04.688166Z","caller":"traceutil/trace.go:171","msg":"trace[2024189002] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:19099; }","duration":"349.428481ms","start":"2026-09-07T11:27:04.338726Z","end":"2026-09-07T11:27:04.688155Z","steps":["trace[2024189002] 'agreement among raft nodes before linearized reading'  (duration: 348.603013ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:27:04.688209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T11:27:04.338672Z","time spent":"349.514543ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":94,"response size":946664,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-09-07T11:27:09.320414Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16915}
{"level":"info","ts":"2026-09-07T11:27:09.419356Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16915,"took":"96.81514ms","hash":992863795,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":32112640,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-09-07T11:27:09.419426Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":992863795,"revision":16915,"compact-revision":14588}
{"level":"info","ts":"2026-09-07T11:27:19.053646Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"522eb07aa35b671b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-07T11:27:19.060569Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-07T11:27:19.06075Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-07T11:32:09.327782Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19143}
{"level":"info","ts":"2026-09-07T11:32:09.430792Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19143,"took":"99.836975ms","hash":2137146067,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":34004992,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-07T11:32:09.430923Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2137146067,"revision":19143,"compact-revision":16915}
{"level":"info","ts":"2026-09-07T11:33:39.487759Z","caller":"traceutil/trace.go:171","msg":"trace[1336519549] linearizableReadLoop","detail":"{readStateIndex:22828; appliedIndex:22827; }","duration":"151.579231ms","start":"2026-09-07T11:33:39.336157Z","end":"2026-09-07T11:33:39.487736Z","steps":["trace[1336519549] 'read index received'  (duration: 151.375666ms)","trace[1336519549] 'applied index is now lower than readState.Index'  (duration: 202.725µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T11:33:39.488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.826697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-09-07T11:33:39.488055Z","caller":"traceutil/trace.go:171","msg":"trace[691779860] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22060; }","duration":"151.923208ms","start":"2026-09-07T11:33:39.336115Z","end":"2026-09-07T11:33:39.488038Z","steps":["trace[691779860] 'agreement among raft nodes before linearized reading'  (duration: 151.715984ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:33:39.488311Z","caller":"traceutil/trace.go:171","msg":"trace[465737221] transaction","detail":"{read_only:false; response_revision:22060; number_of_response:1; }","duration":"178.987358ms","start":"2026-09-07T11:33:39.309283Z","end":"2026-09-07T11:33:39.48827Z","steps":["trace[465737221] 'process raft request'  (duration: 178.313594ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:33:39.892329Z","caller":"traceutil/trace.go:171","msg":"trace[374074007] transaction","detail":"{read_only:false; response_revision:22062; number_of_response:1; }","duration":"182.427511ms","start":"2026-09-07T11:33:39.709864Z","end":"2026-09-07T11:33:39.892292Z","steps":["trace[374074007] 'process raft request'  (duration: 149.555048ms)","trace[374074007] 'compare'  (duration: 32.755081ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T11:33:40.593786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.658551ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7429708462476389870 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:22055 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-07T11:33:40.594002Z","caller":"traceutil/trace.go:171","msg":"trace[338206861] transaction","detail":"{read_only:false; response_revision:22065; number_of_response:1; }","duration":"247.028103ms","start":"2026-09-07T11:33:40.34695Z","end":"2026-09-07T11:33:40.593978Z","steps":["trace[338206861] 'process raft request'  (duration: 246.943012ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:33:40.594156Z","caller":"traceutil/trace.go:171","msg":"trace[942504135] transaction","detail":"{read_only:false; response_revision:22064; number_of_response:1; }","duration":"247.153425ms","start":"2026-09-07T11:33:40.34692Z","end":"2026-09-07T11:33:40.594073Z","steps":["trace[942504135] 'process raft request'  (duration: 97.110826ms)","trace[942504135] 'compare'  (duration: 149.554868ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:37:09.338381Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21552}
{"level":"info","ts":"2026-09-07T11:37:09.455695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21552,"took":"113.778363ms","hash":1475847565,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":30724096,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-07T11:37:09.455761Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1475847565,"revision":21552,"compact-revision":19143}
{"level":"info","ts":"2026-09-07T11:38:02.217456Z","caller":"traceutil/trace.go:171","msg":"trace[1578643057] linearizableReadLoop","detail":"{readStateIndex:25500; appliedIndex:25499; }","duration":"184.119657ms","start":"2026-09-07T11:38:02.033314Z","end":"2026-09-07T11:38:02.217433Z","steps":["trace[1578643057] 'read index received'  (duration: 134.349282ms)","trace[1578643057] 'applied index is now lower than readState.Index'  (duration: 49.769435ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:38:02.217506Z","caller":"traceutil/trace.go:171","msg":"trace[2034820719] transaction","detail":"{read_only:false; response_revision:24657; number_of_response:1; }","duration":"196.010812ms","start":"2026-09-07T11:38:02.021467Z","end":"2026-09-07T11:38:02.217477Z","steps":["trace[2034820719] 'process raft request'  (duration: 146.129735ms)","trace[2034820719] 'compare'  (duration: 49.732714ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-07T11:38:02.217613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.285301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/openstackfloatingippools.infrastructure.cluster.x-k8s.io\" ","response":"range_response_count:1 size:10716"}
{"level":"info","ts":"2026-09-07T11:38:02.217935Z","caller":"traceutil/trace.go:171","msg":"trace[1963184849] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/openstackfloatingippools.infrastructure.cluster.x-k8s.io; range_end:; response_count:1; response_revision:24657; }","duration":"184.639548ms","start":"2026-09-07T11:38:02.03328Z","end":"2026-09-07T11:38:02.21792Z","steps":["trace[1963184849] 'agreement among raft nodes before linearized reading'  (duration: 184.2315ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:38:02.540675Z","caller":"traceutil/trace.go:171","msg":"trace[661599889] linearizableReadLoop","detail":"{readStateIndex:25503; appliedIndex:25502; }","duration":"231.817256ms","start":"2026-09-07T11:38:02.308824Z","end":"2026-09-07T11:38:02.540641Z","steps":["trace[661599889] 'read index received'  (duration: 230.812475ms)","trace[661599889] 'applied index is now lower than readState.Index'  (duration: 1.002811ms)"],"step_count":2}
{"level":"info","ts":"2026-09-07T11:38:02.540738Z","caller":"traceutil/trace.go:171","msg":"trace[1684751400] transaction","detail":"{read_only:false; response_revision:24660; number_of_response:1; }","duration":"234.209668ms","start":"2026-09-07T11:38:02.306493Z","end":"2026-09-07T11:38:02.540703Z","steps":["trace[1684751400] 'process raft request'  (duration: 233.305149ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-07T11:38:02.541035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.185554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/openstackclustertemplates.infrastructure.cluster.x-k8s.io\" ","response":"range_response_count:1 size:70572"}
{"level":"info","ts":"2026-09-07T11:38:02.54116Z","caller":"traceutil/trace.go:171","msg":"trace[1794596008] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/openstackclustertemplates.infrastructure.cluster.x-k8s.io; range_end:; response_count:1; response_revision:24660; }","duration":"232.353317ms","start":"2026-09-07T11:38:02.308782Z","end":"2026-09-07T11:38:02.541135Z","steps":["trace[1794596008] 'agreement among raft nodes before linearized reading'  (duration: 232.035291ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:39:18.333052Z","caller":"traceutil/trace.go:171","msg":"trace[656096111] transaction","detail":"{read_only:false; response_revision:25490; number_of_response:1; }","duration":"108.449709ms","start":"2026-09-07T11:39:18.224579Z","end":"2026-09-07T11:39:18.333029Z","steps":["trace[656096111] 'process raft request'  (duration: 108.309126ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:39:38.111861Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006799.wal"}
{"level":"info","ts":"2026-09-07T11:42:09.347014Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23727}
{"level":"info","ts":"2026-09-07T11:42:09.476499Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23727,"took":"125.170807ms","hash":2568082009,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":42151936,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-09-07T11:42:09.476592Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2568082009,"revision":23727,"compact-revision":21552}
{"level":"info","ts":"2026-09-07T11:43:47.348066Z","caller":"traceutil/trace.go:171","msg":"trace[698433077] transaction","detail":"{read_only:false; response_revision:27522; number_of_response:1; }","duration":"131.684485ms","start":"2026-09-07T11:43:47.216339Z","end":"2026-09-07T11:43:47.348024Z","steps":["trace[698433077] 'process raft request'  (duration: 131.329457ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:43:47.350034Z","caller":"traceutil/trace.go:171","msg":"trace[1076222389] transaction","detail":"{read_only:false; response_revision:27523; number_of_response:1; }","duration":"110.545335ms","start":"2026-09-07T11:43:47.239448Z","end":"2026-09-07T11:43:47.349994Z","steps":["trace[1076222389] 'process raft request'  (duration: 110.361571ms)"],"step_count":1}
{"level":"info","ts":"2026-09-07T11:47:09.353118Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26802}
{"level":"info","ts":"2026-09-07T11:47:09.485563Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26802,"took":"128.667601ms","hash":1092642086,"current-db-size-bytes":56393728,"current-db-size":"56 MB","current-db-size-in-use-bytes":29720576,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-07T11:47:09.48562Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1092642086,"revision":26802,"compact-revision":23727}
{"level":"info","ts":"2026-09-07T11:47:09.68615Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"522eb07aa35b671b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-07T11:47:09.692006Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-09-07T11:47:09.692142Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}