{"level":"warn","ts":"2026-04-22T16:30:54.648333Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T16:30:54.648459Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.76:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.76:2380","--initial-cluster=instance=https://199.19.213.76:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.76:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.76: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-04-22T16:30:54.648536Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-22T16:30:54.648544Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.76:2380"]}
{"level":"info","ts":"2026-04-22T16:30:54.648568Z","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-04-22T16:30:54.649148Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.76:2379"]}
{"level":"info","ts":"2026-04-22T16:30:54.649238Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.76:2380"],"listen-peer-urls":["https://199.19.213.76:2380"],"advertise-client-urls":["https://199.19.213.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.76: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-04-22T16:30:54.657639Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.172215ms"}
{"level":"info","ts":"2026-04-22T16:30:54.679682Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f66825837990484a","cluster-id":"3de51efb4d16c986"}
{"level":"info","ts":"2026-04-22T16:30:54.679814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a switched to configuration voters=()"}
{"level":"info","ts":"2026-04-22T16:30:54.679847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a became follower at term 0"}
{"level":"info","ts":"2026-04-22T16:30:54.679862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f66825837990484a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-22T16:30:54.679878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a became follower at term 1"}
{"level":"info","ts":"2026-04-22T16:30:54.679967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a switched to configuration voters=(17755482777518622794)"}
{"level":"warn","ts":"2026-04-22T16:30:54.687352Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-22T16:30:54.690709Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-22T16:30:54.69261Z","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-04-22T16:30:54.697947Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f66825837990484a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-22T16:30:54.698516Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f66825837990484a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-22T16:30:54.698919Z","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-04-22T16:30:54.699052Z","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-04-22T16:30:54.699076Z","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-04-22T16:30:54.700149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a switched to configuration voters=(17755482777518622794)"}
{"level":"info","ts":"2026-04-22T16:30:54.700406Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3de51efb4d16c986","local-member-id":"f66825837990484a","added-peer-id":"f66825837990484a","added-peer-peer-urls":["https://199.19.213.76:2380"]}
{"level":"info","ts":"2026-04-22T16:30:54.70483Z","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-04-22T16:30:54.705238Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.76:2380"}
{"level":"info","ts":"2026-04-22T16:30:54.705306Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.76:2380"}
{"level":"info","ts":"2026-04-22T16:30:54.705339Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f66825837990484a","initial-advertise-peer-urls":["https://199.19.213.76:2380"],"listen-peer-urls":["https://199.19.213.76:2380"],"advertise-client-urls":["https://199.19.213.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-22T16:30:54.705429Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-22T16:30:55.380742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a is starting a new election at term 1"}
{"level":"info","ts":"2026-04-22T16:30:55.380819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-22T16:30:55.380873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a received MsgPreVoteResp from f66825837990484a at term 1"}
{"level":"info","ts":"2026-04-22T16:30:55.380901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a became candidate at term 2"}
{"level":"info","ts":"2026-04-22T16:30:55.380912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a received MsgVoteResp from f66825837990484a at term 2"}
{"level":"info","ts":"2026-04-22T16:30:55.38093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f66825837990484a became leader at term 2"}
{"level":"info","ts":"2026-04-22T16:30:55.380951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f66825837990484a elected leader f66825837990484a at term 2"}
{"level":"info","ts":"2026-04-22T16:30:55.381942Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:30:55.382856Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f66825837990484a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.76:2379]}","request-path":"/0/members/f66825837990484a/attributes","cluster-id":"3de51efb4d16c986","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-22T16:30:55.382881Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T16:30:55.382945Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-22T16:30:55.383284Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3de51efb4d16c986","local-member-id":"f66825837990484a","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:30:55.383311Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-22T16:30:55.383358Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-22T16:30:55.383454Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:30:55.383493Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-22T16:30:55.386925Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.76:2379"}
{"level":"info","ts":"2026-04-22T16:30:55.38762Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-22T16:31:23.476118Z","caller":"traceutil/trace.go:171","msg":"trace[1583108253] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"143.559962ms","start":"2026-04-22T16:31:23.332521Z","end":"2026-04-22T16:31:23.476081Z","steps":["trace[1583108253] 'process raft request'  (duration: 143.339766ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:31:36.97542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.735248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:31:36.97568Z","caller":"traceutil/trace.go:171","msg":"trace[632835601] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"138.029676ms","start":"2026-04-22T16:31:36.837622Z","end":"2026-04-22T16:31:36.975652Z","steps":["trace[632835601] 'range keys from in-memory index tree'  (duration: 137.639716ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:31:37.161286Z","caller":"traceutil/trace.go:171","msg":"trace[1499669374] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"184.198787ms","start":"2026-04-22T16:31:36.977017Z","end":"2026-04-22T16:31:37.161216Z","steps":["trace[1499669374] 'read index received'  (duration: 182.708175ms)","trace[1499669374] 'applied index is now lower than readState.Index'  (duration: 1.488992ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:31:37.161398Z","caller":"traceutil/trace.go:171","msg":"trace[1899261000] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"228.296428ms","start":"2026-04-22T16:31:36.933049Z","end":"2026-04-22T16:31:37.161345Z","steps":["trace[1899261000] 'process raft request'  (duration: 227.024553ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:31:37.16159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.538457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:31:37.161706Z","caller":"traceutil/trace.go:171","msg":"trace[990467470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"184.714021ms","start":"2026-04-22T16:31:36.976965Z","end":"2026-04-22T16:31:37.161679Z","steps":["trace[990467470] 'agreement among raft nodes before linearized reading'  (duration: 184.491994ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:31:37.480262Z","caller":"traceutil/trace.go:171","msg":"trace[1643891408] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"275.877858ms","start":"2026-04-22T16:31:37.204355Z","end":"2026-04-22T16:31:37.480232Z","steps":["trace[1643891408] 'process raft request'  (duration: 275.686713ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:31:37.666841Z","caller":"traceutil/trace.go:171","msg":"trace[1454557983] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"105.057599ms","start":"2026-04-22T16:31:37.561713Z","end":"2026-04-22T16:31:37.666771Z","steps":["trace[1454557983] 'read index received'  (duration: 81.726752ms)","trace[1454557983] 'applied index is now lower than readState.Index'  (duration: 23.329557ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:31:37.666957Z","caller":"traceutil/trace.go:171","msg":"trace[154902709] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"446.797572ms","start":"2026-04-22T16:31:37.220118Z","end":"2026-04-22T16:31:37.666916Z","steps":["trace[154902709] 'process raft request'  (duration: 423.362943ms)","trace[154902709] 'compare'  (duration: 22.918985ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:31:37.667241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.517752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-04-22T16:31:37.667487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:37.220102Z","time spent":"446.930016ms","remote":"127.0.0.1:38304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"info","ts":"2026-04-22T16:31:37.667294Z","caller":"traceutil/trace.go:171","msg":"trace[369687599] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"105.634255ms","start":"2026-04-22T16:31:37.561645Z","end":"2026-04-22T16:31:37.667279Z","steps":["trace[369687599] 'agreement among raft nodes before linearized reading'  (duration: 105.357377ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:31:52.986493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.287903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T16:31:52.986566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.328161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nfcw5\" ","response":"range_response_count:1 size:3964"}
{"level":"info","ts":"2026-04-22T16:31:52.98665Z","caller":"traceutil/trace.go:171","msg":"trace[28410814] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nfcw5; range_end:; response_count:1; response_revision:791; }","duration":"195.464864ms","start":"2026-04-22T16:31:52.791173Z","end":"2026-04-22T16:31:52.986637Z","steps":["trace[28410814] 'range keys from in-memory index tree'  (duration: 195.131004ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:31:52.98663Z","caller":"traceutil/trace.go:171","msg":"trace[1793016275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"149.49482ms","start":"2026-04-22T16:31:52.837109Z","end":"2026-04-22T16:31:52.986603Z","steps":["trace[1793016275] 'range keys from in-memory index tree'  (duration: 149.119188ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:33:07.549374Z","caller":"traceutil/trace.go:171","msg":"trace[544130071] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"336.30763ms","start":"2026-04-22T16:33:07.213014Z","end":"2026-04-22T16:33:07.549322Z","steps":["trace[544130071] 'process raft request'  (duration: 336.110215ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:33:07.549806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:07.212989Z","time spent":"336.482506ms","remote":"127.0.0.1:34412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-261823e6-f1c9-4a44-bd04-e8e683fc28ac\" mod_revision:1787 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-261823e6-f1c9-4a44-bd04-e8e683fc28ac\" value_size:3631 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-261823e6-f1c9-4a44-bd04-e8e683fc28ac\" > >"}
{"level":"warn","ts":"2026-04-22T16:33:07.833138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.502072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-22T16:33:07.833224Z","caller":"traceutil/trace.go:171","msg":"trace[989982219] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1840; }","duration":"123.655306ms","start":"2026-04-22T16:33:07.709552Z","end":"2026-04-22T16:33:07.833207Z","steps":["trace[989982219] 'range keys from in-memory index tree'  (duration: 123.222485ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:33:07.832965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.603416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-261823e6-f1c9-4a44-bd04-e8e683fc28ac\" ","response":"range_response_count:1 size:3746"}
{"level":"info","ts":"2026-04-22T16:33:07.833598Z","caller":"traceutil/trace.go:171","msg":"trace[1897862910] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-261823e6-f1c9-4a44-bd04-e8e683fc28ac; range_end:; response_count:1; response_revision:1840; }","duration":"148.268375ms","start":"2026-04-22T16:33:07.685291Z","end":"2026-04-22T16:33:07.833559Z","steps":["trace[1897862910] 'range keys from in-memory index tree'  (duration: 147.418662ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:14.444961Z","caller":"traceutil/trace.go:171","msg":"trace[874951690] linearizableReadLoop","detail":"{readStateIndex:3517; appliedIndex:3516; }","duration":"192.939177ms","start":"2026-04-22T16:36:14.251992Z","end":"2026-04-22T16:36:14.444931Z","steps":["trace[874951690] 'read index received'  (duration: 129.475313ms)","trace[874951690] 'applied index is now lower than readState.Index'  (duration: 63.462514ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:36:14.445038Z","caller":"traceutil/trace.go:171","msg":"trace[1008649216] transaction","detail":"{read_only:false; response_revision:3384; number_of_response:1; }","duration":"226.991481ms","start":"2026-04-22T16:36:14.217998Z","end":"2026-04-22T16:36:14.444989Z","steps":["trace[1008649216] 'process raft request'  (duration: 163.28547ms)","trace[1008649216] 'compare'  (duration: 63.502355ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:36:14.445206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.197695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret\" ","response":"range_response_count:1 size:811"}
{"level":"info","ts":"2026-04-22T16:36:14.44528Z","caller":"traceutil/trace.go:171","msg":"trace[862309507] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret; range_end:; response_count:1; response_revision:3384; }","duration":"193.36661ms","start":"2026-04-22T16:36:14.251897Z","end":"2026-04-22T16:36:14.445264Z","steps":["trace[862309507] 'agreement among raft nodes before linearized reading'  (duration: 193.159574ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:36:14.455265Z","caller":"traceutil/trace.go:171","msg":"trace[1076283036] transaction","detail":"{read_only:false; response_revision:3385; number_of_response:1; }","duration":"105.783522ms","start":"2026-04-22T16:36:14.349459Z","end":"2026-04-22T16:36:14.455242Z","steps":["trace[1076283036] 'process raft request'  (duration: 105.661269ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:37:38.868256Z","caller":"traceutil/trace.go:171","msg":"trace[702115081] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"137.460412ms","start":"2026-04-22T16:37:38.730753Z","end":"2026-04-22T16:37:38.868213Z","steps":["trace[702115081] 'process raft request'  (duration: 137.05545ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:37:43.641954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.900157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-04-22T16:37:43.642278Z","caller":"traceutil/trace.go:171","msg":"trace[882756245] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4737; }","duration":"121.275057ms","start":"2026-04-22T16:37:43.520961Z","end":"2026-04-22T16:37:43.642236Z","steps":["trace[882756245] 'range keys from in-memory index tree'  (duration: 120.722441ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:37:44.022526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.009107ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5209149324147098341 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" mod_revision:4533 > success:<request_put:<key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" value_size:16458 >> failure:<request_range:<key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:37:44.022757Z","caller":"traceutil/trace.go:171","msg":"trace[571215267] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"213.25116ms","start":"2026-04-22T16:37:43.809481Z","end":"2026-04-22T16:37:44.022732Z","steps":["trace[571215267] 'process raft request'  (duration: 213.181118ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:37:44.022805Z","caller":"traceutil/trace.go:171","msg":"trace[920425241] linearizableReadLoop","detail":"{readStateIndex:4948; appliedIndex:4947; }","duration":"218.822208ms","start":"2026-04-22T16:37:43.803952Z","end":"2026-04-22T16:37:44.022774Z","steps":["trace[920425241] 'read index received'  (duration: 77.39253ms)","trace[920425241] 'applied index is now lower than readState.Index'  (duration: 141.427118ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:37:44.023147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.960001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:37:44.023199Z","caller":"traceutil/trace.go:171","msg":"trace[543797452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4752; }","duration":"188.064645ms","start":"2026-04-22T16:37:43.83512Z","end":"2026-04-22T16:37:44.023185Z","steps":["trace[543797452] 'agreement among raft nodes before linearized reading'  (duration: 187.971542ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:37:44.023276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.244245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-04-22T16:37:44.023323Z","caller":"traceutil/trace.go:171","msg":"trace[1352695905] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4752; }","duration":"235.315697ms","start":"2026-04-22T16:37:43.787989Z","end":"2026-04-22T16:37:44.023304Z","steps":["trace[1352695905] 'agreement among raft nodes before linearized reading'  (duration: 235.06115ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:37:44.023752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.832136ms","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-04-22T16:37:44.023832Z","caller":"traceutil/trace.go:171","msg":"trace[11582211] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4752; }","duration":"245.920808ms","start":"2026-04-22T16:37:43.777889Z","end":"2026-04-22T16:37:44.02381Z","steps":["trace[11582211] 'agreement among raft nodes before linearized reading'  (duration: 245.781494ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:37:44.023943Z","caller":"traceutil/trace.go:171","msg":"trace[741603516] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"242.319906ms","start":"2026-04-22T16:37:43.780398Z","end":"2026-04-22T16:37:44.022718Z","steps":["trace[741603516] 'process raft request'  (duration: 100.848926ms)","trace[741603516] 'compare'  (duration: 140.839392ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:37:44.262017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.396904ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5209149324147098348 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:4715 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:37:44.26229Z","caller":"traceutil/trace.go:171","msg":"trace[230457645] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"230.548581ms","start":"2026-04-22T16:37:44.0317Z","end":"2026-04-22T16:37:44.262248Z","steps":["trace[230457645] 'process raft request'  (duration: 92.815867ms)","trace[230457645] 'compare'  (duration: 136.951272ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:37:44.262587Z","caller":"traceutil/trace.go:171","msg":"trace[1942152052] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"230.804139ms","start":"2026-04-22T16:37:44.031717Z","end":"2026-04-22T16:37:44.262522Z","steps":["trace[1942152052] 'process raft request'  (duration: 230.414148ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:37:44.262892Z","caller":"traceutil/trace.go:171","msg":"trace[1375858786] linearizableReadLoop","detail":"{readStateIndex:4954; appliedIndex:4950; }","duration":"191.06775ms","start":"2026-04-22T16:37:44.071801Z","end":"2026-04-22T16:37:44.262869Z","steps":["trace[1375858786] 'read index received'  (duration: 52.744929ms)","trace[1375858786] 'applied index is now lower than readState.Index'  (duration: 138.319411ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:37:44.26293Z","caller":"traceutil/trace.go:171","msg":"trace[1562727669] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"231.089147ms","start":"2026-04-22T16:37:44.031812Z","end":"2026-04-22T16:37:44.262901Z","steps":["trace[1562727669] 'process raft request'  (duration: 230.615773ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:37:44.263005Z","caller":"traceutil/trace.go:171","msg":"trace[1763788062] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"231.000724ms","start":"2026-04-22T16:37:44.031996Z","end":"2026-04-22T16:37:44.262997Z","steps":["trace[1763788062] 'process raft request'  (duration: 230.775928ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:37:44.263831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.009847ms","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-04-22T16:37:44.263887Z","caller":"traceutil/trace.go:171","msg":"trace[779978897] 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:4757; }","duration":"192.12222ms","start":"2026-04-22T16:37:44.071748Z","end":"2026-04-22T16:37:44.263871Z","steps":["trace[779978897] 'agreement among raft nodes before linearized reading'  (duration: 191.415449ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:38:01.048785Z","caller":"traceutil/trace.go:171","msg":"trace[477571851] linearizableReadLoop","detail":"{readStateIndex:5296; appliedIndex:5295; }","duration":"155.050956ms","start":"2026-04-22T16:38:00.893704Z","end":"2026-04-22T16:38:01.048754Z","steps":["trace[477571851] 'read index received'  (duration: 106.160477ms)","trace[477571851] 'applied index is now lower than readState.Index'  (duration: 48.889449ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:38:01.04908Z","caller":"traceutil/trace.go:171","msg":"trace[372937644] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"226.236578ms","start":"2026-04-22T16:38:00.822824Z","end":"2026-04-22T16:38:01.049061Z","steps":["trace[372937644] 'process raft request'  (duration: 177.060091ms)","trace[372937644] 'compare'  (duration: 48.638322ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:38:01.049472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.740555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-02bab4b4-98c5-4da1-a6d2-31e0162e9ebb\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-04-22T16:38:01.049578Z","caller":"traceutil/trace.go:171","msg":"trace[806379193] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-02bab4b4-98c5-4da1-a6d2-31e0162e9ebb; range_end:; response_count:1; response_revision:5087; }","duration":"155.893769ms","start":"2026-04-22T16:38:00.89366Z","end":"2026-04-22T16:38:01.049553Z","steps":["trace[806379193] 'agreement among raft nodes before linearized reading'  (duration: 155.499618ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:38:01.064242Z","caller":"traceutil/trace.go:171","msg":"trace[1991982742] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"107.315831ms","start":"2026-04-22T16:38:00.956898Z","end":"2026-04-22T16:38:01.064214Z","steps":["trace[1991982742] 'process raft request'  (duration: 107.103175ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:38:01.06437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.383678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-02bab4b4-98c5-4da1-a6d2-31e0162e9ebb\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-04-22T16:38:01.064425Z","caller":"traceutil/trace.go:171","msg":"trace[1012770781] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-02bab4b4-98c5-4da1-a6d2-31e0162e9ebb; range_end:; response_count:1; response_revision:5088; }","duration":"116.492581ms","start":"2026-04-22T16:38:00.947918Z","end":"2026-04-22T16:38:01.064411Z","steps":["trace[1012770781] 'agreement among raft nodes before linearized reading'  (duration: 116.252895ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:38:01.245296Z","caller":"traceutil/trace.go:171","msg":"trace[2106986346] linearizableReadLoop","detail":"{readStateIndex:5298; appliedIndex:5297; }","duration":"176.161616ms","start":"2026-04-22T16:38:01.069106Z","end":"2026-04-22T16:38:01.245268Z","steps":["trace[2106986346] 'read index received'  (duration: 101.120234ms)","trace[2106986346] 'applied index is now lower than readState.Index'  (duration: 75.036672ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:38:01.245597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.133246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:38:01.245642Z","caller":"traceutil/trace.go:171","msg":"trace[453530039] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:5089; }","duration":"169.223398ms","start":"2026-04-22T16:38:01.076404Z","end":"2026-04-22T16:38:01.245628Z","steps":["trace[453530039] 'agreement among raft nodes before linearized reading'  (duration: 169.125055ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:38:01.245678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.560607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11496"}
{"level":"info","ts":"2026-04-22T16:38:01.245753Z","caller":"traceutil/trace.go:171","msg":"trace[2043498104] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5089; }","duration":"176.6558ms","start":"2026-04-22T16:38:01.069079Z","end":"2026-04-22T16:38:01.245735Z","steps":["trace[2043498104] 'agreement among raft nodes before linearized reading'  (duration: 176.330521ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:38:01.246197Z","caller":"traceutil/trace.go:171","msg":"trace[1003340796] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"187.228411ms","start":"2026-04-22T16:38:01.05892Z","end":"2026-04-22T16:38:01.246149Z","steps":["trace[1003340796] 'process raft request'  (duration: 111.291993ms)","trace[1003340796] 'compare'  (duration: 74.904778ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:38:01.576183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.686985ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5209149324147099127 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/prometheus-pushgateway-5c694d99cc-ln8bj\" mod_revision:4784 > success:<request_put:<key:\"/registry/pods/monitoring/prometheus-pushgateway-5c694d99cc-ln8bj\" value_size:3922 >> failure:<request_range:<key:\"/registry/pods/monitoring/prometheus-pushgateway-5c694d99cc-ln8bj\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:38:01.576337Z","caller":"traceutil/trace.go:171","msg":"trace[1725818831] linearizableReadLoop","detail":"{readStateIndex:5299; appliedIndex:5298; }","duration":"284.68394ms","start":"2026-04-22T16:38:01.291629Z","end":"2026-04-22T16:38:01.576313Z","steps":["trace[1725818831] 'read index received'  (duration: 135.883981ms)","trace[1725818831] 'applied index is now lower than readState.Index'  (duration: 148.798419ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:38:01.576549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.850766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T16:38:01.576518Z","caller":"traceutil/trace.go:171","msg":"trace[1441495182] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"313.615473ms","start":"2026-04-22T16:38:01.262856Z","end":"2026-04-22T16:38:01.576472Z","steps":["trace[1441495182] 'process raft request'  (duration: 164.503845ms)","trace[1441495182] 'compare'  (duration: 148.51271ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:38:01.576656Z","caller":"traceutil/trace.go:171","msg":"trace[1127760155] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:5090; }","duration":"285.070532ms","start":"2026-04-22T16:38:01.291567Z","end":"2026-04-22T16:38:01.576638Z","steps":["trace[1127760155] 'agreement among raft nodes before linearized reading'  (duration: 284.808974ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:38:01.576762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:38:01.262827Z","time spent":"313.799838ms","remote":"127.0.0.1:34412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3995,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/prometheus-pushgateway-5c694d99cc-ln8bj\" mod_revision:4784 > success:<request_put:<key:\"/registry/pods/monitoring/prometheus-pushgateway-5c694d99cc-ln8bj\" value_size:3922 >> failure:<request_range:<key:\"/registry/pods/monitoring/prometheus-pushgateway-5c694d99cc-ln8bj\" > >"}
{"level":"info","ts":"2026-04-22T16:38:01.584151Z","caller":"traceutil/trace.go:171","msg":"trace[1023898184] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"270.106606ms","start":"2026-04-22T16:38:01.314021Z","end":"2026-04-22T16:38:01.584127Z","steps":["trace[1023898184] 'process raft request'  (duration: 269.971272ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:39:04.317218Z","caller":"traceutil/trace.go:171","msg":"trace[694903272] transaction","detail":"{read_only:false; response_revision:5740; number_of_response:1; }","duration":"158.676282ms","start":"2026-04-22T16:39:04.158491Z","end":"2026-04-22T16:39:04.317167Z","steps":["trace[694903272] 'process raft request'  (duration: 131.141711ms)","trace[694903272] 'compare'  (duration: 27.224902ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:40:55.417153Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3254}
{"level":"info","ts":"2026-04-22T16:40:55.508946Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3254,"took":"90.116546ms","hash":3742367058,"current-db-size-bytes":61210624,"current-db-size":"61 MB","current-db-size-in-use-bytes":33882112,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-04-22T16:40:55.509029Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3742367058,"revision":3254,"compact-revision":-1}
{"level":"info","ts":"2026-04-22T16:44:05.76177Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000221b.wal"}
{"level":"warn","ts":"2026-04-22T16:44:22.956384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.8012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11496"}
{"level":"info","ts":"2026-04-22T16:44:22.956532Z","caller":"traceutil/trace.go:171","msg":"trace[1999169263] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8475; }","duration":"369.955175ms","start":"2026-04-22T16:44:22.586527Z","end":"2026-04-22T16:44:22.956482Z","steps":["trace[1999169263] 'range keys from in-memory index tree'  (duration: 369.660406ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:22.95657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.586517Z","time spent":"370.044907ms","remote":"127.0.0.1:34412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":11519,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-22T16:44:22.956361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.168622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T16:44:22.956585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.632878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6cjdk\" ","response":"range_response_count:1 size:6526"}
{"level":"info","ts":"2026-04-22T16:44:22.956684Z","caller":"traceutil/trace.go:171","msg":"trace[1992034599] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6cjdk; range_end:; response_count:1; response_revision:8475; }","duration":"576.746472ms","start":"2026-04-22T16:44:22.379912Z","end":"2026-04-22T16:44:22.956658Z","steps":["trace[1992034599] 'range keys from in-memory index tree'  (duration: 576.370621ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:22.956687Z","caller":"traceutil/trace.go:171","msg":"trace[253088277] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:8475; }","duration":"586.584183ms","start":"2026-04-22T16:44:22.370066Z","end":"2026-04-22T16:44:22.95665Z","steps":["trace[253088277] 'count revisions from in-memory index tree'  (duration: 586.028857ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:22.956721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.379847Z","time spent":"576.864325ms","remote":"127.0.0.1:34412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6549,"request content":"key:\"/registry/pods/openstack/keepalived-6cjdk\" "}
{"level":"warn","ts":"2026-04-22T16:44:22.95678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.370035Z","time spent":"586.695077ms","remote":"127.0.0.1:38112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-22T16:44:22.957045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.678442ms","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-04-22T16:44:22.957065Z","caller":"traceutil/trace.go:171","msg":"trace[315914348] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8475; }","duration":"372.733174ms","start":"2026-04-22T16:44:22.584325Z","end":"2026-04-22T16:44:22.957058Z","steps":["trace[315914348] 'range keys from in-memory index tree'  (duration: 372.58809ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:22.957086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.584305Z","time spent":"372.777286ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-22T16:44:22.957104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.454303ms","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-04-22T16:44:22.957127Z","caller":"traceutil/trace.go:171","msg":"trace[632514529] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8475; }","duration":"284.512805ms","start":"2026-04-22T16:44:22.672608Z","end":"2026-04-22T16:44:22.957121Z","steps":["trace[632514529] 'range keys from in-memory index tree'  (duration: 284.33029ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:22.957099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.213691ms","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-04-22T16:44:22.957211Z","caller":"traceutil/trace.go:171","msg":"trace[157666954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8475; }","duration":"587.309574ms","start":"2026-04-22T16:44:22.36986Z","end":"2026-04-22T16:44:22.95717Z","steps":["trace[157666954] 'range keys from in-memory index tree'  (duration: 586.916763ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:22.957261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.36977Z","time spent":"587.477198ms","remote":"127.0.0.1:34492","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-04-22T16:44:22.957105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.842068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T16:44:22.957313Z","caller":"traceutil/trace.go:171","msg":"trace[901387385] linearizableReadLoop","detail":"{readStateIndex:8850; appliedIndex:8849; }","duration":"275.401604ms","start":"2026-04-22T16:44:22.6819Z","end":"2026-04-22T16:44:22.957302Z","steps":["trace[901387385] 'read index received'  (duration: 250.489091ms)","trace[901387385] 'applied index is now lower than readState.Index'  (duration: 24.911533ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:44:22.957328Z","caller":"traceutil/trace.go:171","msg":"trace[1383878308] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8475; }","duration":"342.165387ms","start":"2026-04-22T16:44:22.615151Z","end":"2026-04-22T16:44:22.957317Z","steps":["trace[1383878308] 'count revisions from in-memory index tree'  (duration: 341.730206ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:22.95736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.615127Z","time spent":"342.219909ms","remote":"127.0.0.1:39924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"info","ts":"2026-04-22T16:44:22.957465Z","caller":"traceutil/trace.go:171","msg":"trace[1775503798] transaction","detail":"{read_only:false; response_revision:8476; number_of_response:1; }","duration":"282.408344ms","start":"2026-04-22T16:44:22.675017Z","end":"2026-04-22T16:44:22.957425Z","steps":["trace[1775503798] 'process raft request'  (duration: 257.526252ms)","trace[1775503798] 'compare'  (duration: 23.631767ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:44:22.957584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.070802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T16:44:22.957625Z","caller":"traceutil/trace.go:171","msg":"trace[1480402707] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:8476; }","duration":"224.174066ms","start":"2026-04-22T16:44:22.733441Z","end":"2026-04-22T16:44:22.957615Z","steps":["trace[1480402707] 'agreement among raft nodes before linearized reading'  (duration: 224.045012ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:22.957644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.904716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T16:44:22.957671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.768665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-04-22T16:44:22.9577Z","caller":"traceutil/trace.go:171","msg":"trace[1020853818] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8476; }","duration":"275.823797ms","start":"2026-04-22T16:44:22.681866Z","end":"2026-04-22T16:44:22.95769Z","steps":["trace[1020853818] 'agreement among raft nodes before linearized reading'  (duration: 275.531348ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:22.957702Z","caller":"traceutil/trace.go:171","msg":"trace[1600855958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8476; }","duration":"121.01217ms","start":"2026-04-22T16:44:22.836674Z","end":"2026-04-22T16:44:22.957686Z","steps":["trace[1600855958] 'agreement among raft nodes before linearized reading'  (duration: 120.907607ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:22.957847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.65427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"}
{"level":"info","ts":"2026-04-22T16:44:22.957956Z","caller":"traceutil/trace.go:171","msg":"trace[1988425786] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8476; }","duration":"165.796963ms","start":"2026-04-22T16:44:22.792127Z","end":"2026-04-22T16:44:22.957924Z","steps":["trace[1988425786] 'agreement among raft nodes before linearized reading'  (duration: 165.495105ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.329945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.775005ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5209149324147108433 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8466 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:44:23.330231Z","caller":"traceutil/trace.go:171","msg":"trace[1913213020] transaction","detail":"{read_only:false; response_revision:8477; number_of_response:1; }","duration":"364.465648ms","start":"2026-04-22T16:44:22.965731Z","end":"2026-04-22T16:44:23.330196Z","steps":["trace[1913213020] 'process raft request'  (duration: 186.300321ms)","trace[1913213020] 'compare'  (duration: 177.501258ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:44:23.330262Z","caller":"traceutil/trace.go:171","msg":"trace[729606462] transaction","detail":"{read_only:false; response_revision:8478; number_of_response:1; }","duration":"364.346074ms","start":"2026-04-22T16:44:22.965895Z","end":"2026-04-22T16:44:23.330241Z","steps":["trace[729606462] 'process raft request'  (duration: 364.20965ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.330378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.965716Z","time spent":"364.574701ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8466 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-22T16:44:23.330665Z","caller":"traceutil/trace.go:171","msg":"trace[1923360009] transaction","detail":"{read_only:false; response_revision:8479; number_of_response:1; }","duration":"364.551189ms","start":"2026-04-22T16:44:22.966026Z","end":"2026-04-22T16:44:23.330577Z","steps":["trace[1923360009] 'process raft request'  (duration: 364.172098ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.330724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.965882Z","time spent":"364.796876ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8465 > 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-04-22T16:44:23.330803Z","caller":"traceutil/trace.go:171","msg":"trace[384788312] transaction","detail":"{read_only:false; response_revision:8480; number_of_response:1; }","duration":"362.149852ms","start":"2026-04-22T16:44:22.968625Z","end":"2026-04-22T16:44:23.330774Z","steps":["trace[384788312] 'process raft request'  (duration: 361.837763ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.330936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.968617Z","time spent":"362.247244ms","remote":"127.0.0.1:34316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":629,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8471 > success:<request_put:<key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" value_size:549 >> failure:<request_range:<key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-22T16:44:23.330943Z","caller":"traceutil/trace.go:171","msg":"trace[1705475121] linearizableReadLoop","detail":"{readStateIndex:8852; appliedIndex:8850; }","duration":"364.914009ms","start":"2026-04-22T16:44:22.966016Z","end":"2026-04-22T16:44:23.33093Z","steps":["trace[1705475121] 'read index received'  (duration: 185.956499ms)","trace[1705475121] 'applied index is now lower than readState.Index'  (duration: 178.95621ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:44:23.330969Z","caller":"traceutil/trace.go:171","msg":"trace[1053549849] transaction","detail":"{read_only:false; response_revision:8481; number_of_response:1; }","duration":"361.457841ms","start":"2026-04-22T16:44:22.969493Z","end":"2026-04-22T16:44:23.330951Z","steps":["trace[1053549849] 'process raft request'  (duration: 361.234494ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.331063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.969485Z","time spent":"361.535193ms","remote":"127.0.0.1:34316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:8469 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-22T16:44:23.331094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.966018Z","time spent":"364.985931ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8467 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-04-22T16:44:23.331126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.843828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11496"}
{"level":"info","ts":"2026-04-22T16:44:23.331155Z","caller":"traceutil/trace.go:171","msg":"trace[619371011] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8481; }","duration":"364.909459ms","start":"2026-04-22T16:44:22.966237Z","end":"2026-04-22T16:44:23.331147Z","steps":["trace[619371011] 'agreement among raft nodes before linearized reading'  (duration: 364.777056ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.331175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.96622Z","time spent":"364.950191ms","remote":"127.0.0.1:34412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":11519,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-22T16:44:23.331472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.427385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:24 size:203471"}
{"level":"info","ts":"2026-04-22T16:44:23.331593Z","caller":"traceutil/trace.go:171","msg":"trace[461036669] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:24; response_revision:8481; }","duration":"365.610399ms","start":"2026-04-22T16:44:22.96596Z","end":"2026-04-22T16:44:23.33157Z","steps":["trace[461036669] 'agreement among raft nodes before linearized reading'  (duration: 365.031363ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.331652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:22.965932Z","time spent":"365.703602ms","remote":"127.0.0.1:34412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":24,"response size":203494,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-04-22T16:44:23.514365Z","caller":"traceutil/trace.go:171","msg":"trace[1199251139] transaction","detail":"{read_only:false; response_revision:8482; number_of_response:1; }","duration":"175.814849ms","start":"2026-04-22T16:44:23.338512Z","end":"2026-04-22T16:44:23.514327Z","steps":["trace[1199251139] 'process raft request'  (duration: 175.555931ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:23.585056Z","caller":"traceutil/trace.go:171","msg":"trace[1639795745] linearizableReadLoop","detail":"{readStateIndex:8857; appliedIndex:8855; }","duration":"232.597909ms","start":"2026-04-22T16:44:23.352417Z","end":"2026-04-22T16:44:23.585015Z","steps":["trace[1639795745] 'read index received'  (duration: 161.707056ms)","trace[1639795745] 'applied index is now lower than readState.Index'  (duration: 70.889033ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:44:23.585331Z","caller":"traceutil/trace.go:171","msg":"trace[818782457] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"242.43444ms","start":"2026-04-22T16:44:23.342689Z","end":"2026-04-22T16:44:23.585123Z","steps":["trace[818782457] 'process raft request'  (duration: 242.003316ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:23.585371Z","caller":"traceutil/trace.go:171","msg":"trace[1100535500] transaction","detail":"{read_only:false; response_revision:8484; number_of_response:1; }","duration":"202.476535ms","start":"2026-04-22T16:44:23.382855Z","end":"2026-04-22T16:44:23.585332Z","steps":["trace[1100535500] 'process raft request'  (duration: 202.058872ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.58554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.118253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"warn","ts":"2026-04-22T16:44:23.585556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.696849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:44:23.585614Z","caller":"traceutil/trace.go:171","msg":"trace[668253538] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8484; }","duration":"233.246276ms","start":"2026-04-22T16:44:23.352354Z","end":"2026-04-22T16:44:23.5856Z","steps":["trace[668253538] 'agreement among raft nodes before linearized reading'  (duration: 232.984139ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:23.585635Z","caller":"traceutil/trace.go:171","msg":"trace[986109616] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:8484; }","duration":"173.852024ms","start":"2026-04-22T16:44:23.411763Z","end":"2026-04-22T16:44:23.585615Z","steps":["trace[986109616] 'agreement among raft nodes before linearized reading'  (duration: 173.698929ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.585541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.635995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:44:23.585717Z","caller":"traceutil/trace.go:171","msg":"trace[1662417187] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8484; }","duration":"130.881092ms","start":"2026-04-22T16:44:23.454825Z","end":"2026-04-22T16:44:23.585706Z","steps":["trace[1662417187] 'agreement among raft nodes before linearized reading'  (duration: 130.640815ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:23.725967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.934003ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5209149324147108448 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8473 > 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-04-22T16:44:23.726342Z","caller":"traceutil/trace.go:171","msg":"trace[823546146] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"135.685749ms","start":"2026-04-22T16:44:23.590621Z","end":"2026-04-22T16:44:23.726306Z","steps":["trace[823546146] 'process raft request'  (duration: 33.292414ms)","trace[823546146] 'compare'  (duration: 101.795828ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:44:24.243016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.660617ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5209149324147108449 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" mod_revision:0 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" value_size:7315 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-04-22T16:44:24.243149Z","caller":"traceutil/trace.go:171","msg":"trace[214717292] linearizableReadLoop","detail":"{readStateIndex:8860; appliedIndex:8859; }","duration":"142.411952ms","start":"2026-04-22T16:44:24.100714Z","end":"2026-04-22T16:44:24.243126Z","steps":["trace[214717292] 'read index received'  (duration: 65.562µs)","trace[214717292] 'applied index is now lower than readState.Index'  (duration: 142.34471ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:44:24.24325Z","caller":"traceutil/trace.go:171","msg":"trace[1538892508] transaction","detail":"{read_only:false; number_of_response:0; response_revision:8485; }","duration":"650.687171ms","start":"2026-04-22T16:44:23.592547Z","end":"2026-04-22T16:44:24.243235Z","steps":["trace[1538892508] 'process raft request'  (duration: 244.707215ms)","trace[1538892508] 'compare'  (duration: 405.574004ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:44:24.243331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:23.592432Z","time spent":"650.863576ms","remote":"127.0.0.1:38258","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" mod_revision:0 > success:<request_put:<key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" value_size:7315 >> failure:<>"}
{"level":"warn","ts":"2026-04-22T16:44:24.243537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.809134ms","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-04-22T16:44:24.243623Z","caller":"traceutil/trace.go:171","msg":"trace[2146737600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8485; }","duration":"142.944767ms","start":"2026-04-22T16:44:24.100656Z","end":"2026-04-22T16:44:24.243601Z","steps":["trace[2146737600] 'agreement among raft nodes before linearized reading'  (duration: 142.621127ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:24.674448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.155107ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5209149324147108450 > lease_revoke:<id:484a9db607c12951>","response":"size:28"}
{"level":"info","ts":"2026-04-22T16:44:24.674659Z","caller":"traceutil/trace.go:171","msg":"trace[2135843606] linearizableReadLoop","detail":"{readStateIndex:8861; appliedIndex:8860; }","duration":"431.461757ms","start":"2026-04-22T16:44:24.243181Z","end":"2026-04-22T16:44:24.674643Z","steps":["trace[2135843606] 'read index received'  (duration: 149.145785ms)","trace[2135843606] 'applied index is now lower than readState.Index'  (duration: 282.312372ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:44:24.674851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.113899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:44:24.674935Z","caller":"traceutil/trace.go:171","msg":"trace[265505869] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:8485; }","duration":"535.346966ms","start":"2026-04-22T16:44:24.139566Z","end":"2026-04-22T16:44:24.674913Z","steps":["trace[265505869] 'agreement among raft nodes before linearized reading'  (duration: 535.176351ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:24.674969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:24.139534Z","time spent":"535.428048ms","remote":"127.0.0.1:39846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "}
{"level":"info","ts":"2026-04-22T16:44:24.67507Z","caller":"traceutil/trace.go:171","msg":"trace[404552952] transaction","detail":"{read_only:false; response_revision:8486; number_of_response:1; }","duration":"426.748113ms","start":"2026-04-22T16:44:24.248279Z","end":"2026-04-22T16:44:24.675027Z","steps":["trace[404552952] 'process raft request'  (duration: 426.271769ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:24.675342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:24.248258Z","time spent":"426.95977ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8474 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-22T16:44:24.745905Z","caller":"traceutil/trace.go:171","msg":"trace[1236619561] transaction","detail":"{read_only:false; response_revision:8487; number_of_response:1; }","duration":"175.751548ms","start":"2026-04-22T16:44:24.570117Z","end":"2026-04-22T16:44:24.745869Z","steps":["trace[1236619561] 'process raft request'  (duration: 104.881357ms)","trace[1236619561] 'compare'  (duration: 70.557273ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:44:24.745966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.238496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-22T16:44:24.746064Z","caller":"traceutil/trace.go:171","msg":"trace[1759407281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8487; }","duration":"502.409641ms","start":"2026-04-22T16:44:24.243631Z","end":"2026-04-22T16:44:24.746041Z","steps":["trace[1759407281] 'agreement among raft nodes before linearized reading'  (duration: 502.127803ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:24.746125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:24.243598Z","time spent":"502.518094ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-22T16:44:24.746604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.202745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" ","response":"range_response_count:1 size:13485"}
{"level":"info","ts":"2026-04-22T16:44:24.746698Z","caller":"traceutil/trace.go:171","msg":"trace[1633974138] range","detail":"{range_begin:/registry/statefulsets/openstack/percona-xtradb-haproxy; range_end:; response_count:1; response_revision:8487; }","duration":"502.339639ms","start":"2026-04-22T16:44:24.244338Z","end":"2026-04-22T16:44:24.746678Z","steps":["trace[1633974138] 'agreement among raft nodes before linearized reading'  (duration: 501.65685ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:24.746953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:24.244316Z","time spent":"502.626487ms","remote":"127.0.0.1:38258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":13508,"request content":"key:\"/registry/statefulsets/openstack/percona-xtradb-haproxy\" "}
{"level":"info","ts":"2026-04-22T16:44:24.944773Z","caller":"traceutil/trace.go:171","msg":"trace[1481736022] linearizableReadLoop","detail":"{readStateIndex:8865; appliedIndex:8863; }","duration":"179.588278ms","start":"2026-04-22T16:44:24.765149Z","end":"2026-04-22T16:44:24.944737Z","steps":["trace[1481736022] 'read index received'  (duration: 37.109014ms)","trace[1481736022] 'applied index is now lower than readState.Index'  (duration: 142.478114ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:44:24.944857Z","caller":"traceutil/trace.go:171","msg":"trace[179981915] transaction","detail":"{read_only:false; response_revision:8489; number_of_response:1; }","duration":"188.229255ms","start":"2026-04-22T16:44:24.756583Z","end":"2026-04-22T16:44:24.944813Z","steps":["trace[179981915] 'process raft request'  (duration: 177.762875ms)","trace[179981915] 'compare'  (duration: 10.223643ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:44:24.944945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.767432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-22T16:44:24.945004Z","caller":"traceutil/trace.go:171","msg":"trace[1517923007] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:8489; }","duration":"179.907357ms","start":"2026-04-22T16:44:24.76508Z","end":"2026-04-22T16:44:24.944988Z","steps":["trace[1517923007] 'agreement among raft nodes before linearized reading'  (duration: 179.764183ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:24.945001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.987602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:44:24.945162Z","caller":"traceutil/trace.go:171","msg":"trace[1410117297] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8489; }","duration":"110.186478ms","start":"2026-04-22T16:44:24.834943Z","end":"2026-04-22T16:44:24.945129Z","steps":["trace[1410117297] 'agreement among raft nodes before linearized reading'  (duration: 110.004413ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:25.877655Z","caller":"traceutil/trace.go:171","msg":"trace[1723334869] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"320.474156ms","start":"2026-04-22T16:44:25.557139Z","end":"2026-04-22T16:44:25.877613Z","steps":["trace[1723334869] 'process raft request'  (duration: 224.522166ms)","trace[1723334869] 'compare'  (duration: 95.777285ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:44:25.877705Z","caller":"traceutil/trace.go:171","msg":"trace[555887203] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"120.190595ms","start":"2026-04-22T16:44:25.757486Z","end":"2026-04-22T16:44:25.877676Z","steps":["trace[555887203] 'process raft request'  (duration: 120.125123ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:25.877792Z","caller":"traceutil/trace.go:171","msg":"trace[1672283430] linearizableReadLoop","detail":"{readStateIndex:8871; appliedIndex:8870; }","duration":"285.212246ms","start":"2026-04-22T16:44:25.592531Z","end":"2026-04-22T16:44:25.877743Z","steps":["trace[1672283430] 'read index received'  (duration: 189.149033ms)","trace[1672283430] 'applied index is now lower than readState.Index'  (duration: 96.056693ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:44:25.877846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:44:25.557104Z","time spent":"320.634091ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":537,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8482 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:461 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-22T16:44:25.878071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.757511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-22T16:44:25.8781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.987173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"warn","ts":"2026-04-22T16:44:25.878087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.520734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-04-22T16:44:25.878123Z","caller":"traceutil/trace.go:171","msg":"trace[798736616] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8496; }","duration":"248.888084ms","start":"2026-04-22T16:44:25.629223Z","end":"2026-04-22T16:44:25.878111Z","steps":["trace[798736616] 'agreement among raft nodes before linearized reading'  (duration: 248.74728ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:25.878139Z","caller":"traceutil/trace.go:171","msg":"trace[701500197] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8496; }","duration":"147.070925ms","start":"2026-04-22T16:44:25.731055Z","end":"2026-04-22T16:44:25.878126Z","steps":["trace[701500197] 'agreement among raft nodes before linearized reading'  (duration: 146.971782ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:25.878168Z","caller":"traceutil/trace.go:171","msg":"trace[1535398680] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8496; }","duration":"285.670328ms","start":"2026-04-22T16:44:25.59247Z","end":"2026-04-22T16:44:25.878141Z","steps":["trace[1535398680] 'agreement among raft nodes before linearized reading'  (duration: 285.447262ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:26.148362Z","caller":"traceutil/trace.go:171","msg":"trace[1834500058] transaction","detail":"{read_only:false; response_revision:8500; number_of_response:1; }","duration":"116.53948ms","start":"2026-04-22T16:44:26.031789Z","end":"2026-04-22T16:44:26.148328Z","steps":["trace[1834500058] 'process raft request'  (duration: 116.021065ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:44:53.642634Z","caller":"traceutil/trace.go:171","msg":"trace[485441460] linearizableReadLoop","detail":"{readStateIndex:9121; appliedIndex:9120; }","duration":"116.852279ms","start":"2026-04-22T16:44:53.525748Z","end":"2026-04-22T16:44:53.6426Z","steps":["trace[485441460] 'read index received'  (duration: 116.544421ms)","trace[485441460] 'applied index is now lower than readState.Index'  (duration: 306.498µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:44:53.642697Z","caller":"traceutil/trace.go:171","msg":"trace[1670963883] transaction","detail":"{read_only:false; response_revision:8734; number_of_response:1; }","duration":"117.034545ms","start":"2026-04-22T16:44:53.525626Z","end":"2026-04-22T16:44:53.642661Z","steps":["trace[1670963883] 'process raft request'  (duration: 116.689075ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:53.642965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.041006ms","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-04-22T16:44:53.643041Z","caller":"traceutil/trace.go:171","msg":"trace[961496051] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8734; }","duration":"109.179909ms","start":"2026-04-22T16:44:53.533835Z","end":"2026-04-22T16:44:53.643014Z","steps":["trace[961496051] 'agreement among raft nodes before linearized reading'  (duration: 108.968183ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:44:53.643101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.263812ms","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-04-22T16:44:53.643302Z","caller":"traceutil/trace.go:171","msg":"trace[1211076130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8734; }","duration":"117.57314ms","start":"2026-04-22T16:44:53.525694Z","end":"2026-04-22T16:44:53.643267Z","steps":["trace[1211076130] 'agreement among raft nodes before linearized reading'  (duration: 117.075456ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:07.67481Z","caller":"traceutil/trace.go:171","msg":"trace[1542946821] transaction","detail":"{read_only:false; response_revision:8872; number_of_response:1; }","duration":"105.089082ms","start":"2026-04-22T16:45:07.56968Z","end":"2026-04-22T16:45:07.674769Z","steps":["trace[1542946821] 'process raft request'  (duration: 39.804911ms)","trace[1542946821] 'compare'  (duration: 65.019944ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:07.866288Z","caller":"traceutil/trace.go:171","msg":"trace[1465669249] transaction","detail":"{read_only:false; response_revision:8873; number_of_response:1; }","duration":"127.879675ms","start":"2026-04-22T16:45:07.738375Z","end":"2026-04-22T16:45:07.866254Z","steps":["trace[1465669249] 'process raft request'  (duration: 111.64194ms)","trace[1465669249] 'compare'  (duration: 16.029339ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:07.866537Z","caller":"traceutil/trace.go:171","msg":"trace[262717794] linearizableReadLoop","detail":"{readStateIndex:9270; appliedIndex:9268; }","duration":"127.290178ms","start":"2026-04-22T16:45:07.739231Z","end":"2026-04-22T16:45:07.866521Z","steps":["trace[262717794] 'read index received'  (duration: 110.877369ms)","trace[262717794] 'applied index is now lower than readState.Index'  (duration: 16.411109ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:07.866916Z","caller":"traceutil/trace.go:171","msg":"trace[1364149203] transaction","detail":"{read_only:false; response_revision:8874; number_of_response:1; }","duration":"127.790063ms","start":"2026-04-22T16:45:07.739081Z","end":"2026-04-22T16:45:07.866871Z","steps":["trace[1364149203] 'process raft request'  (duration: 127.126523ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:45:07.867047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.796424ms","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-04-22T16:45:07.867092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.881215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6cjdk\" ","response":"range_response_count:1 size:6526"}
{"level":"info","ts":"2026-04-22T16:45:07.867111Z","caller":"traceutil/trace.go:171","msg":"trace[73807448] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8874; }","duration":"127.897176ms","start":"2026-04-22T16:45:07.739198Z","end":"2026-04-22T16:45:07.867095Z","steps":["trace[73807448] 'agreement among raft nodes before linearized reading'  (duration: 127.67828ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:07.867185Z","caller":"traceutil/trace.go:171","msg":"trace[2114572319] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6cjdk; range_end:; response_count:1; response_revision:8874; }","duration":"121.030889ms","start":"2026-04-22T16:45:07.746134Z","end":"2026-04-22T16:45:07.867165Z","steps":["trace[2114572319] 'agreement among raft nodes before linearized reading'  (duration: 120.734561ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:08.617362Z","caller":"traceutil/trace.go:171","msg":"trace[336636577] linearizableReadLoop","detail":"{readStateIndex:9273; appliedIndex:9272; }","duration":"157.299669ms","start":"2026-04-22T16:45:08.460032Z","end":"2026-04-22T16:45:08.617332Z","steps":["trace[336636577] 'read index received'  (duration: 157.108693ms)","trace[336636577] 'applied index is now lower than readState.Index'  (duration: 189.706µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:08.61744Z","caller":"traceutil/trace.go:171","msg":"trace[1027402883] transaction","detail":"{read_only:false; response_revision:8877; number_of_response:1; }","duration":"209.595268ms","start":"2026-04-22T16:45:08.407804Z","end":"2026-04-22T16:45:08.617399Z","steps":["trace[1027402883] 'process raft request'  (duration: 209.34294ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:45:08.617625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.574908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-vrnzx\" ","response":"range_response_count:1 size:4614"}
{"level":"info","ts":"2026-04-22T16:45:08.617681Z","caller":"traceutil/trace.go:171","msg":"trace[550804630] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-vrnzx; range_end:; response_count:1; response_revision:8877; }","duration":"157.717971ms","start":"2026-04-22T16:45:08.459951Z","end":"2026-04-22T16:45:08.617669Z","steps":["trace[550804630] 'agreement among raft nodes before linearized reading'  (duration: 157.529126ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:08.839627Z","caller":"traceutil/trace.go:171","msg":"trace[1075839611] linearizableReadLoop","detail":"{readStateIndex:9275; appliedIndex:9273; }","duration":"222.073906ms","start":"2026-04-22T16:45:08.617511Z","end":"2026-04-22T16:45:08.839584Z","steps":["trace[1075839611] 'read index received'  (duration: 221.330065ms)","trace[1075839611] 'applied index is now lower than readState.Index'  (duration: 741.171µs)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:08.839728Z","caller":"traceutil/trace.go:171","msg":"trace[1400470418] transaction","detail":"{read_only:false; response_revision:8879; number_of_response:1; }","duration":"367.035641ms","start":"2026-04-22T16:45:08.472635Z","end":"2026-04-22T16:45:08.83967Z","steps":["trace[1400470418] 'process raft request'  (duration: 366.843576ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:08.839898Z","caller":"traceutil/trace.go:171","msg":"trace[577112803] transaction","detail":"{read_only:false; response_revision:8878; number_of_response:1; }","duration":"378.773577ms","start":"2026-04-22T16:45:08.461064Z","end":"2026-04-22T16:45:08.839838Z","steps":["trace[577112803] 'process raft request'  (duration: 378.137199ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:45:08.839964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:45:08.472602Z","time spent":"367.230727ms","remote":"127.0.0.1:34464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2999,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/openstack/rook-ceph-detect-version\" mod_revision:8867 > success:<request_put:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" value_size:2942 >> failure:<request_range:<key:\"/registry/jobs/openstack/rook-ceph-detect-version\" > >"}
{"level":"warn","ts":"2026-04-22T16:45:08.839985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.637002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"warn","ts":"2026-04-22T16:45:08.840202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:45:08.461053Z","time spent":"379.006223ms","remote":"127.0.0.1:34298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/rook-ceph-detect-version-vrnzx.18a8bb96976893da\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/rook-ceph-detect-version-vrnzx.18a8bb96976893da\" value_size:654 lease:5209149324147108306 >> failure:<>"}
{"level":"info","ts":"2026-04-22T16:45:08.840218Z","caller":"traceutil/trace.go:171","msg":"trace[450811680] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8879; }","duration":"341.90762ms","start":"2026-04-22T16:45:08.498262Z","end":"2026-04-22T16:45:08.840169Z","steps":["trace[450811680] 'agreement among raft nodes before linearized reading'  (duration: 341.53039ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:45:08.840295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.32926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.76\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-04-22T16:45:08.840251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.616226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"info","ts":"2026-04-22T16:45:08.840399Z","caller":"traceutil/trace.go:171","msg":"trace[2125709735] range","detail":"{range_begin:/registry/masterleases/199.19.213.76; range_end:; response_count:1; response_revision:8879; }","duration":"104.486895ms","start":"2026-04-22T16:45:08.735882Z","end":"2026-04-22T16:45:08.840369Z","steps":["trace[2125709735] 'agreement among raft nodes before linearized reading'  (duration: 104.171216ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:45:08.840417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:45:08.498252Z","time spent":"342.126746ms","remote":"127.0.0.1:34316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":683,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-04-22T16:45:08.840446Z","caller":"traceutil/trace.go:171","msg":"trace[2107115597] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8879; }","duration":"218.857433ms","start":"2026-04-22T16:45:08.621558Z","end":"2026-04-22T16:45:08.840416Z","steps":["trace[2107115597] 'agreement among raft nodes before linearized reading'  (duration: 218.462112ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:45:08.840756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.335804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-04-22T16:45:08.840808Z","caller":"traceutil/trace.go:171","msg":"trace[1521958320] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8879; }","duration":"101.401517ms","start":"2026-04-22T16:45:08.73939Z","end":"2026-04-22T16:45:08.840791Z","steps":["trace[1521958320] 'agreement among raft nodes before linearized reading'  (duration: 100.660086ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:09.082096Z","caller":"traceutil/trace.go:171","msg":"trace[1959176800] linearizableReadLoop","detail":"{readStateIndex:9279; appliedIndex:9277; }","duration":"166.03864ms","start":"2026-04-22T16:45:08.916024Z","end":"2026-04-22T16:45:09.082063Z","steps":["trace[1959176800] 'read index received'  (duration: 115.412978ms)","trace[1959176800] 'applied index is now lower than readState.Index'  (duration: 50.623352ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:09.082122Z","caller":"traceutil/trace.go:171","msg":"trace[304247031] transaction","detail":"{read_only:false; response_revision:8881; number_of_response:1; }","duration":"221.50682ms","start":"2026-04-22T16:45:08.860562Z","end":"2026-04-22T16:45:09.082069Z","steps":["trace[304247031] 'process raft request'  (duration: 170.992462ms)","trace[304247031] 'compare'  (duration: 50.165888ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:45:09.082706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.655298ms","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-04-22T16:45:09.082785Z","caller":"traceutil/trace.go:171","msg":"trace[364225463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8882; }","duration":"166.798081ms","start":"2026-04-22T16:45:08.915968Z","end":"2026-04-22T16:45:09.082766Z","steps":["trace[364225463] 'agreement among raft nodes before linearized reading'  (duration: 166.505863ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:09.082977Z","caller":"traceutil/trace.go:171","msg":"trace[755586987] transaction","detail":"{read_only:false; response_revision:8882; number_of_response:1; }","duration":"180.638628ms","start":"2026-04-22T16:45:08.902299Z","end":"2026-04-22T16:45:09.082937Z","steps":["trace[755586987] 'process raft request'  (duration: 179.647629ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:10.043918Z","caller":"traceutil/trace.go:171","msg":"trace[539649378] transaction","detail":"{read_only:false; response_revision:8888; number_of_response:1; }","duration":"167.735478ms","start":"2026-04-22T16:45:09.87615Z","end":"2026-04-22T16:45:10.043885Z","steps":["trace[539649378] 'process raft request'  (duration: 167.44673ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:10.131793Z","caller":"traceutil/trace.go:171","msg":"trace[782256684] linearizableReadLoop","detail":"{readStateIndex:9286; appliedIndex:9284; }","duration":"251.998883ms","start":"2026-04-22T16:45:09.879762Z","end":"2026-04-22T16:45:10.131761Z","steps":["trace[782256684] 'read index received'  (duration: 163.865738ms)","trace[782256684] 'applied index is now lower than readState.Index'  (duration: 88.131385ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:10.131862Z","caller":"traceutil/trace.go:171","msg":"trace[474595395] transaction","detail":"{read_only:false; response_revision:8889; number_of_response:1; }","duration":"255.173374ms","start":"2026-04-22T16:45:09.876656Z","end":"2026-04-22T16:45:10.131829Z","steps":["trace[474595395] 'process raft request'  (duration: 254.881776ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:45:10.132047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.073488ms","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-04-22T16:45:10.132101Z","caller":"traceutil/trace.go:171","msg":"trace[2082288447] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8889; }","duration":"250.179161ms","start":"2026-04-22T16:45:09.881909Z","end":"2026-04-22T16:45:10.132088Z","steps":["trace[2082288447] 'agreement among raft nodes before linearized reading'  (duration: 250.036827ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:45:10.132172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.2642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6cjdk\" ","response":"range_response_count:1 size:6526"}
{"level":"info","ts":"2026-04-22T16:45:10.132328Z","caller":"traceutil/trace.go:171","msg":"trace[1234396008] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6cjdk; range_end:; response_count:1; response_revision:8889; }","duration":"252.58206ms","start":"2026-04-22T16:45:09.879706Z","end":"2026-04-22T16:45:10.132288Z","steps":["trace[1234396008] 'agreement among raft nodes before linearized reading'  (duration: 252.2056ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:11.011441Z","caller":"traceutil/trace.go:171","msg":"trace[1303580290] transaction","detail":"{read_only:false; response_revision:8892; number_of_response:1; }","duration":"102.863259ms","start":"2026-04-22T16:45:10.908476Z","end":"2026-04-22T16:45:11.011339Z","steps":["trace[1303580290] 'process raft request'  (duration: 102.688564ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:45:11.079346Z","caller":"traceutil/trace.go:171","msg":"trace[25973529] transaction","detail":"{read_only:false; response_revision:8893; number_of_response:1; }","duration":"117.962121ms","start":"2026-04-22T16:45:10.961338Z","end":"2026-04-22T16:45:11.0793Z","steps":["trace[25973529] 'process raft request'  (duration: 95.92734ms)","trace[25973529] 'compare'  (duration: 21.62914ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:45:55.425113Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6574}
{"level":"info","ts":"2026-04-22T16:45:55.519293Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6574,"took":"91.974386ms","hash":878256511,"current-db-size-bytes":61210624,"current-db-size":"61 MB","current-db-size-in-use-bytes":25882624,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-22T16:45:55.519514Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":878256511,"revision":6574,"compact-revision":3254}
{"level":"info","ts":"2026-04-22T16:46:11.87884Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f66825837990484a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-22T16:46:11.883269Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-22T16:46:11.883384Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-22T16:46:21.669327Z","caller":"traceutil/trace.go:171","msg":"trace[854075630] transaction","detail":"{read_only:false; response_revision:9640; number_of_response:1; }","duration":"168.324919ms","start":"2026-04-22T16:46:21.500966Z","end":"2026-04-22T16:46:21.669291Z","steps":["trace[854075630] 'process raft request'  (duration: 168.136133ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-22T16:46:21.901784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.758919ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5209149324147111812 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:9630 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-22T16:46:21.902279Z","caller":"traceutil/trace.go:171","msg":"trace[243289538] linearizableReadLoop","detail":"{readStateIndex:10074; appliedIndex:10072; }","duration":"167.116754ms","start":"2026-04-22T16:46:21.735131Z","end":"2026-04-22T16:46:21.902248Z","steps":["trace[243289538] 'read index received'  (duration: 38.785968ms)","trace[243289538] 'applied index is now lower than readState.Index'  (duration: 128.329316ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-22T16:46:21.902542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.511132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-22T16:46:21.902544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.381561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-22T16:46:21.90265Z","caller":"traceutil/trace.go:171","msg":"trace[1302752404] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:9642; }","duration":"167.553556ms","start":"2026-04-22T16:46:21.735074Z","end":"2026-04-22T16:46:21.902628Z","steps":["trace[1302752404] 'agreement among raft nodes before linearized reading'  (duration: 167.377011ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:46:21.902547Z","caller":"traceutil/trace.go:171","msg":"trace[776304712] transaction","detail":"{read_only:false; response_revision:9642; number_of_response:1; }","duration":"226.873261ms","start":"2026-04-22T16:46:21.675644Z","end":"2026-04-22T16:46:21.902517Z","steps":["trace[776304712] 'process raft request'  (duration: 226.416178ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:46:21.902584Z","caller":"traceutil/trace.go:171","msg":"trace[738291161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9642; }","duration":"148.594914ms","start":"2026-04-22T16:46:21.753975Z","end":"2026-04-22T16:46:21.90257Z","steps":["trace[738291161] 'agreement among raft nodes before linearized reading'  (duration: 148.508362ms)"],"step_count":1}
{"level":"info","ts":"2026-04-22T16:46:21.903163Z","caller":"traceutil/trace.go:171","msg":"trace[83106353] transaction","detail":"{read_only:false; response_revision:9641; number_of_response:1; }","duration":"227.484638ms","start":"2026-04-22T16:46:21.675637Z","end":"2026-04-22T16:46:21.903121Z","steps":["trace[83106353] 'process raft request'  (duration: 98.284187ms)","trace[83106353] 'compare'  (duration: 127.595964ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:46:22.168419Z","caller":"traceutil/trace.go:171","msg":"trace[625534853] transaction","detail":"{read_only:false; response_revision:9643; number_of_response:1; }","duration":"169.689738ms","start":"2026-04-22T16:46:21.998658Z","end":"2026-04-22T16:46:22.168348Z","steps":["trace[625534853] 'process raft request'  (duration: 116.965881ms)","trace[625534853] 'compare'  (duration: 52.48187ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:46:22.353722Z","caller":"traceutil/trace.go:171","msg":"trace[783793151] transaction","detail":"{read_only:false; response_revision:9645; number_of_response:1; }","duration":"176.952854ms","start":"2026-04-22T16:46:22.176733Z","end":"2026-04-22T16:46:22.353686Z","steps":["trace[783793151] 'process raft request'  (duration: 106.890863ms)","trace[783793151] 'compare'  (duration: 69.921887ms)"],"step_count":2}
{"level":"info","ts":"2026-04-22T16:50:55.433084Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9350}
{"level":"info","ts":"2026-04-22T16:50:55.518912Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9350,"took":"83.657391ms","hash":2618153626,"current-db-size-bytes":61210624,"current-db-size":"61 MB","current-db-size-in-use-bytes":25653248,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-22T16:50:55.519006Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2618153626,"revision":9350,"compact-revision":6574}