{"level":"warn","ts":"2026-05-04T01:38:38.041038Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T01:38:38.041167Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.204.45.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-04T01:38:38.041248Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-04T01:38:38.041276Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]}
{"level":"info","ts":"2026-05-04T01:38:38.041301Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-04T01:38:38.041941Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]}
{"level":"info","ts":"2026-05-04T01:38:38.042011Z","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.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-04T01:38:38.046352Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.139218ms"}
{"level":"info","ts":"2026-05-04T01:38:38.05989Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"}
{"level":"info","ts":"2026-05-04T01:38:38.060084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-04T01:38:38.060179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"}
{"level":"info","ts":"2026-05-04T01:38:38.060234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-04T01:38:38.060288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"}
{"level":"info","ts":"2026-05-04T01:38:38.060378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"}
{"level":"warn","ts":"2026-05-04T01:38:38.06657Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-04T01:38:38.068466Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-04T01:38:38.06975Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-04T01:38:38.072761Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-04T01:38:38.072988Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-04T01:38:38.073011Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-04T01:38:38.074439Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-04T01:38:38.07446Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-04T01:38:38.07579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"}
{"level":"info","ts":"2026-05-04T01:38:38.076063Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]}
{"level":"info","ts":"2026-05-04T01:38:38.078036Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-04T01:38:38.078231Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"}
{"level":"info","ts":"2026-05-04T01:38:38.078337Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"}
{"level":"info","ts":"2026-05-04T01:38:38.07832Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-04T01:38:38.07837Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-04T01:38:38.961369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-04T01:38:38.961466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-04T01:38:38.961496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"}
{"level":"info","ts":"2026-05-04T01:38:38.961523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"}
{"level":"info","ts":"2026-05-04T01:38:38.961538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"}
{"level":"info","ts":"2026-05-04T01:38:38.961557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"}
{"level":"info","ts":"2026-05-04T01:38:38.961573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"}
{"level":"info","ts":"2026-05-04T01:38:38.962825Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-04T01:38:38.962856Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T01:38:38.962904Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-04T01:38:38.962876Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T01:38:38.963197Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-04T01:38:38.963318Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-04T01:38:38.96439Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T01:38:38.964531Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T01:38:38.964576Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-04T01:38:38.966964Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"}
{"level":"info","ts":"2026-05-04T01:38:38.967561Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-05-04T01:38:47.670875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.823114ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471726030915727114 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/service-account-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/service-account-controller\" value_size:131 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-04T01:38:47.671061Z","caller":"traceutil/trace.go:171","msg":"trace[187402398] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"217.794664ms","start":"2026-05-04T01:38:47.453226Z","end":"2026-05-04T01:38:47.67102Z","steps":["trace[187402398] 'process raft request'  (duration: 49.314217ms)","trace[187402398] 'compare'  (duration: 167.655681ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:38:47.899594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.048161ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471726030915727120 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" value_size:129 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-04T01:38:47.899713Z","caller":"traceutil/trace.go:171","msg":"trace[1991541396] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"181.641643ms","start":"2026-05-04T01:38:47.718051Z","end":"2026-05-04T01:38:47.899693Z","steps":["trace[1991541396] 'process raft request'  (duration: 65.401589ms)","trace[1991541396] 'compare'  (duration: 115.858498ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:38:53.171447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.633636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T01:38:53.171543Z","caller":"traceutil/trace.go:171","msg":"trace[223810961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:405; }","duration":"187.803409ms","start":"2026-05-04T01:38:52.983722Z","end":"2026-05-04T01:38:53.171526Z","steps":["trace[223810961] 'range keys from in-memory index tree'  (duration: 187.533285ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:38:53.171527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.853811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-04T01:38:53.171611Z","caller":"traceutil/trace.go:171","msg":"trace[582769834] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:405; }","duration":"278.988033ms","start":"2026-05-04T01:38:52.892602Z","end":"2026-05-04T01:38:53.17159Z","steps":["trace[582769834] 'range keys from in-memory index tree'  (duration: 278.735729ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:38:53.297874Z","caller":"traceutil/trace.go:171","msg":"trace[603891653] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"122.38572ms","start":"2026-05-04T01:38:53.175464Z","end":"2026-05-04T01:38:53.29785Z","steps":["trace[603891653] 'process raft request'  (duration: 122.223477ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:39:08.975048Z","caller":"traceutil/trace.go:171","msg":"trace[198587790] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"104.673067ms","start":"2026-05-04T01:39:08.870349Z","end":"2026-05-04T01:39:08.975022Z","steps":["trace[198587790] 'read index received'  (duration: 104.517344ms)","trace[198587790] 'applied index is now lower than readState.Index'  (duration: 154.443µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:39:08.97512Z","caller":"traceutil/trace.go:171","msg":"trace[814575669] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"197.142144ms","start":"2026-05-04T01:39:08.77794Z","end":"2026-05-04T01:39:08.975082Z","steps":["trace[814575669] 'process raft request'  (duration: 196.941411ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:39:08.975257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.876031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T01:39:08.975356Z","caller":"traceutil/trace.go:171","msg":"trace[1259619523] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:508; }","duration":"105.041545ms","start":"2026-05-04T01:39:08.870294Z","end":"2026-05-04T01:39:08.975335Z","steps":["trace[1259619523] 'agreement among raft nodes before linearized reading'  (duration: 104.8402ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:39:10.049378Z","caller":"traceutil/trace.go:171","msg":"trace[2100038067] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"310.384024ms","start":"2026-05-04T01:39:09.738965Z","end":"2026-05-04T01:39:10.049349Z","steps":["trace[2100038067] 'process raft request'  (duration: 299.720643ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:39:10.051579Z","caller":"traceutil/trace.go:171","msg":"trace[297220578] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"304.185836ms","start":"2026-05-04T01:39:09.747354Z","end":"2026-05-04T01:39:10.05154Z","steps":["trace[297220578] 'process raft request'  (duration: 301.960755ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:39:10.051726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:39:09.747332Z","time spent":"304.321209ms","remote":"127.0.0.1:60862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" mod_revision:562 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" value_size:151118 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" > >"}
{"level":"warn","ts":"2026-05-04T01:39:10.051789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:39:09.738925Z","time spent":"312.249659ms","remote":"127.0.0.1:60862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" mod_revision:560 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" value_size:98578 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-04T01:39:10.053432Z","caller":"traceutil/trace.go:171","msg":"trace[317787132] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"288.211936ms","start":"2026-05-04T01:39:09.765159Z","end":"2026-05-04T01:39:10.053371Z","steps":["trace[317787132] 'process raft request'  (duration: 287.000883ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:39:10.053524Z","caller":"traceutil/trace.go:171","msg":"trace[1124061055] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:586; }","duration":"237.675507ms","start":"2026-05-04T01:39:09.815674Z","end":"2026-05-04T01:39:10.053349Z","steps":["trace[1124061055] 'read index received'  (duration: 222.94919ms)","trace[1124061055] 'applied index is now lower than readState.Index'  (duration: 14.724307ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:39:10.053898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.139235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-04T01:39:10.054054Z","caller":"traceutil/trace.go:171","msg":"trace[579654602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:567; }","duration":"238.38618ms","start":"2026-05-04T01:39:09.815631Z","end":"2026-05-04T01:39:10.054018Z","steps":["trace[579654602] 'agreement among raft nodes before linearized reading'  (duration: 237.84959ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:39:16.206441Z","caller":"traceutil/trace.go:171","msg":"trace[168582018] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"155.715687ms","start":"2026-05-04T01:39:16.050578Z","end":"2026-05-04T01:39:16.206294Z","steps":["trace[168582018] 'process raft request'  (duration: 150.154077ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:39:16.206682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.247759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-04T01:39:16.206557Z","caller":"traceutil/trace.go:171","msg":"trace[2088246488] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"125.901843ms","start":"2026-05-04T01:39:16.080391Z","end":"2026-05-04T01:39:16.206293Z","steps":["trace[2088246488] 'read index received'  (duration: 119.375744ms)","trace[2088246488] 'applied index is now lower than readState.Index'  (duration: 6.523849ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:39:16.206885Z","caller":"traceutil/trace.go:171","msg":"trace[430870887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"126.448893ms","start":"2026-05-04T01:39:16.080336Z","end":"2026-05-04T01:39:16.206785Z","steps":["trace[430870887] 'agreement among raft nodes before linearized reading'  (duration: 126.056646ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:39:16.387406Z","caller":"traceutil/trace.go:171","msg":"trace[161670325] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"161.889058ms","start":"2026-05-04T01:39:16.225488Z","end":"2026-05-04T01:39:16.387377Z","steps":["trace[161670325] 'read index received'  (duration: 130.265297ms)","trace[161670325] 'applied index is now lower than readState.Index'  (duration: 31.622701ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:39:16.387488Z","caller":"traceutil/trace.go:171","msg":"trace[391897881] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"174.876093ms","start":"2026-05-04T01:39:16.212526Z","end":"2026-05-04T01:39:16.387402Z","steps":["trace[391897881] 'process raft request'  (duration: 143.213712ms)","trace[391897881] 'compare'  (duration: 31.506048ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:39:16.387716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.201086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rklmx\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-05-04T01:39:16.387802Z","caller":"traceutil/trace.go:171","msg":"trace[302615374] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rklmx; range_end:; response_count:1; response_revision:621; }","duration":"162.348868ms","start":"2026-05-04T01:39:16.225431Z","end":"2026-05-04T01:39:16.38778Z","steps":["trace[302615374] 'agreement among raft nodes before linearized reading'  (duration: 162.062172ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:39:16.400729Z","caller":"traceutil/trace.go:171","msg":"trace[255128414] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"138.790965ms","start":"2026-05-04T01:39:16.261923Z","end":"2026-05-04T01:39:16.400714Z","steps":["trace[255128414] 'process raft request'  (duration: 138.682263ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:39:17.07241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.735821ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471726030915727636 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-rklmx\" mod_revision:502 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-rklmx\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-rklmx\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T01:39:17.072517Z","caller":"traceutil/trace.go:171","msg":"trace[23744004] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"668.837052ms","start":"2026-05-04T01:39:16.403665Z","end":"2026-05-04T01:39:17.072502Z","steps":["trace[23744004] 'read index received'  (duration: 248.849576ms)","trace[23744004] 'applied index is now lower than readState.Index'  (duration: 419.986406ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:39:17.072587Z","caller":"traceutil/trace.go:171","msg":"trace[697708221] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"671.28413ms","start":"2026-05-04T01:39:16.401268Z","end":"2026-05-04T01:39:17.072552Z","steps":["trace[697708221] 'process raft request'  (duration: 251.285994ms)","trace[697708221] 'compare'  (duration: 419.548867ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:39:17.072635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.967995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-05-04T01:39:17.072669Z","caller":"traceutil/trace.go:171","msg":"trace[378739631] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:623; }","duration":"669.024216ms","start":"2026-05-04T01:39:16.403636Z","end":"2026-05-04T01:39:17.07266Z","steps":["trace[378739631] 'agreement among raft nodes before linearized reading'  (duration: 668.955145ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:39:17.072673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.777838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-04T01:39:17.072707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:39:16.40362Z","time spent":"669.076827ms","remote":"127.0.0.1:32768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "}
{"level":"info","ts":"2026-05-04T01:39:17.072746Z","caller":"traceutil/trace.go:171","msg":"trace[1109308277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"350.891191ms","start":"2026-05-04T01:39:16.721838Z","end":"2026-05-04T01:39:17.072729Z","steps":["trace[1109308277] 'agreement among raft nodes before linearized reading'  (duration: 350.781299ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:39:17.072743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:39:16.401239Z","time spent":"671.426964ms","remote":"127.0.0.1:60990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-rklmx\" mod_revision:502 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-rklmx\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-rklmx\" > >"}
{"level":"warn","ts":"2026-05-04T01:39:17.072789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:39:16.721817Z","time spent":"350.965682ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-04T01:39:17.218175Z","caller":"traceutil/trace.go:171","msg":"trace[1449507002] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"115.699003ms","start":"2026-05-04T01:39:17.102421Z","end":"2026-05-04T01:39:17.21812Z","steps":["trace[1449507002] 'process raft request'  (duration: 108.268126ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:39:17.218212Z","caller":"traceutil/trace.go:171","msg":"trace[983901928] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"114.362396ms","start":"2026-05-04T01:39:17.103819Z","end":"2026-05-04T01:39:17.218181Z","steps":["trace[983901928] 'process raft request'  (duration: 114.267884ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:39:17.218228Z","caller":"traceutil/trace.go:171","msg":"trace[1413082074] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"115.236442ms","start":"2026-05-04T01:39:17.102962Z","end":"2026-05-04T01:39:17.218199Z","steps":["trace[1413082074] 'process raft request'  (duration: 115.063519ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:40:46.307702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.115526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-05-04T01:40:46.30774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.537083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e8e1f2c4-8441-48c7-84fd-ddc844d659fa\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-04T01:40:46.307795Z","caller":"traceutil/trace.go:171","msg":"trace[1233778586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1837; }","duration":"112.216778ms","start":"2026-05-04T01:40:46.19556Z","end":"2026-05-04T01:40:46.307776Z","steps":["trace[1233778586] 'range keys from in-memory index tree'  (duration: 111.941513ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:40:46.307819Z","caller":"traceutil/trace.go:171","msg":"trace[968192956] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e8e1f2c4-8441-48c7-84fd-ddc844d659fa; range_end:; response_count:1; response_revision:1837; }","duration":"299.665996ms","start":"2026-05-04T01:40:46.008134Z","end":"2026-05-04T01:40:46.3078Z","steps":["trace[968192956] 'range keys from in-memory index tree'  (duration: 299.357509ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:40:46.30782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.336696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-04T01:40:46.307935Z","caller":"traceutil/trace.go:171","msg":"trace[1179748011] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1837; }","duration":"359.497321ms","start":"2026-05-04T01:40:45.948408Z","end":"2026-05-04T01:40:46.307905Z","steps":["trace[1179748011] 'range keys from in-memory index tree'  (duration: 359.150593ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:40:46.307981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:40:45.948388Z","time spent":"359.584283ms","remote":"127.0.0.1:32824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-04T01:40:47.043341Z","caller":"traceutil/trace.go:171","msg":"trace[596240605] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"332.139536ms","start":"2026-05-04T01:40:46.711172Z","end":"2026-05-04T01:40:47.043312Z","steps":["trace[596240605] 'process raft request'  (duration: 332.009694ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:40:47.043513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:40:46.711153Z","time spent":"332.27001ms","remote":"127.0.0.1:32824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1684 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-05-04T01:40:47.051735Z","caller":"traceutil/trace.go:171","msg":"trace[1042810459] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1914; }","duration":"330.429694ms","start":"2026-05-04T01:40:46.721285Z","end":"2026-05-04T01:40:47.051715Z","steps":["trace[1042810459] 'read index received'  (duration: 322.127606ms)","trace[1042810459] 'applied index is now lower than readState.Index'  (duration: 8.301178ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:40:47.05195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.651859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T01:40:47.051989Z","caller":"traceutil/trace.go:171","msg":"trace[391733501] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1843; }","duration":"330.71316ms","start":"2026-05-04T01:40:46.721259Z","end":"2026-05-04T01:40:47.051972Z","steps":["trace[391733501] 'agreement among raft nodes before linearized reading'  (duration: 330.657709ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:40:47.052011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:40:46.721249Z","time spent":"330.757161ms","remote":"127.0.0.1:60804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-04T01:40:47.052106Z","caller":"traceutil/trace.go:171","msg":"trace[358575412] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"338.031501ms","start":"2026-05-04T01:40:46.714038Z","end":"2026-05-04T01:40:47.05207Z","steps":["trace[358575412] 'process raft request'  (duration: 337.558321ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:40:47.052285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.579408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-04T01:40:47.052335Z","caller":"traceutil/trace.go:171","msg":"trace[460663793] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1843; }","duration":"224.67099ms","start":"2026-05-04T01:40:46.827649Z","end":"2026-05-04T01:40:47.05232Z","steps":["trace[460663793] 'agreement among raft nodes before linearized reading'  (duration: 224.547368ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:40:47.052277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:40:46.714017Z","time spent":"338.169973ms","remote":"127.0.0.1:60990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e8e1f2c4-8441-48c7-84fd-ddc844d659fa\" mod_revision:1791 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e8e1f2c4-8441-48c7-84fd-ddc844d659fa\" value_size:3629 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e8e1f2c4-8441-48c7-84fd-ddc844d659fa\" > >"}
{"level":"warn","ts":"2026-05-04T01:40:47.052446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.409637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-04T01:40:47.052486Z","caller":"traceutil/trace.go:171","msg":"trace[1316818330] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1843; }","duration":"107.478757ms","start":"2026-05-04T01:40:46.944998Z","end":"2026-05-04T01:40:47.052476Z","steps":["trace[1316818330] 'agreement among raft nodes before linearized reading'  (duration: 107.326014ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:40:58.510002Z","caller":"traceutil/trace.go:171","msg":"trace[1524595473] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"134.661637ms","start":"2026-05-04T01:40:58.375303Z","end":"2026-05-04T01:40:58.509965Z","steps":["trace[1524595473] 'process raft request'  (duration: 134.310321ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:41:35.241688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.030785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T01:41:35.241818Z","caller":"traceutil/trace.go:171","msg":"trace[1918235924] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2152; }","duration":"356.23724ms","start":"2026-05-04T01:41:34.885552Z","end":"2026-05-04T01:41:35.24179Z","steps":["trace[1918235924] 'count revisions from in-memory index tree'  (duration: 355.867752ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:41:35.241878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:41:34.885539Z","time spent":"356.324991ms","remote":"127.0.0.1:60972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":31,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"warn","ts":"2026-05-04T01:41:35.241943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.023183ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471726030915730795 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2141 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T01:41:35.242046Z","caller":"traceutil/trace.go:171","msg":"trace[25887164] linearizableReadLoop","detail":"{readStateIndex:2237; appliedIndex:2236; }","duration":"172.115085ms","start":"2026-05-04T01:41:35.069915Z","end":"2026-05-04T01:41:35.24203Z","steps":["trace[25887164] 'read index received'  (duration: 56.761µs)","trace[25887164] 'applied index is now lower than readState.Index'  (duration: 172.057074ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:41:35.242094Z","caller":"traceutil/trace.go:171","msg":"trace[1853935180] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"329.979126ms","start":"2026-05-04T01:41:34.91208Z","end":"2026-05-04T01:41:35.242059Z","steps":["trace[1853935180] 'process raft request'  (duration: 99.745819ms)","trace[1853935180] 'compare'  (duration: 229.913822ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:41:35.242156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.228397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T01:41:35.242185Z","caller":"traceutil/trace.go:171","msg":"trace[630544666] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2153; }","duration":"149.295759ms","start":"2026-05-04T01:41:35.092881Z","end":"2026-05-04T01:41:35.242176Z","steps":["trace[630544666] 'agreement among raft nodes before linearized reading'  (duration: 149.238658ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:41:35.242258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:41:34.912054Z","time spent":"330.119179ms","remote":"127.0.0.1:32824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2141 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-04T01:41:35.242632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.714686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-04T01:41:35.242728Z","caller":"traceutil/trace.go:171","msg":"trace[1869419116] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2153; }","duration":"172.852409ms","start":"2026-05-04T01:41:35.069861Z","end":"2026-05-04T01:41:35.242714Z","steps":["trace[1869419116] 'agreement among raft nodes before linearized reading'  (duration: 172.242887ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:41:35.47376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.738071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-04T01:41:35.474121Z","caller":"traceutil/trace.go:171","msg":"trace[1978553609] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2153; }","duration":"110.147528ms","start":"2026-05-04T01:41:35.363945Z","end":"2026-05-04T01:41:35.474092Z","steps":["trace[1978553609] 'range keys from in-memory index tree'  (duration: 109.539247ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:42:16.247823Z","caller":"traceutil/trace.go:171","msg":"trace[1724399303] transaction","detail":"{read_only:false; response_revision:2550; number_of_response:1; }","duration":"252.150466ms","start":"2026-05-04T01:42:15.995645Z","end":"2026-05-04T01:42:16.247796Z","steps":["trace[1724399303] 'process raft request'  (duration: 251.990453ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:42:16.278443Z","caller":"traceutil/trace.go:171","msg":"trace[436067940] linearizableReadLoop","detail":"{readStateIndex:2651; appliedIndex:2649; }","duration":"235.976346ms","start":"2026-05-04T01:42:16.042435Z","end":"2026-05-04T01:42:16.278411Z","steps":["trace[436067940] 'read index received'  (duration: 205.195887ms)","trace[436067940] 'applied index is now lower than readState.Index'  (duration: 30.779129ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:42:16.278545Z","caller":"traceutil/trace.go:171","msg":"trace[1314655131] transaction","detail":"{read_only:false; response_revision:2551; number_of_response:1; }","duration":"279.403568ms","start":"2026-05-04T01:42:15.999108Z","end":"2026-05-04T01:42:16.278512Z","steps":["trace[1314655131] 'process raft request'  (duration: 279.122183ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:42:16.278737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.283803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-04T01:42:16.278835Z","caller":"traceutil/trace.go:171","msg":"trace[1145997792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2551; }","duration":"236.422695ms","start":"2026-05-04T01:42:16.042384Z","end":"2026-05-04T01:42:16.278807Z","steps":["trace[1145997792] 'agreement among raft nodes before linearized reading'  (duration: 236.14706ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:42:49.981966Z","caller":"traceutil/trace.go:171","msg":"trace[1651621895] linearizableReadLoop","detail":"{readStateIndex:2861; appliedIndex:2860; }","duration":"103.890574ms","start":"2026-05-04T01:42:49.878053Z","end":"2026-05-04T01:42:49.981943Z","steps":["trace[1651621895] 'read index received'  (duration: 103.801923ms)","trace[1651621895] 'applied index is now lower than readState.Index'  (duration: 87.151µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:42:49.982319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.226341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-04T01:42:49.982355Z","caller":"traceutil/trace.go:171","msg":"trace[1256030114] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2753; }","duration":"104.340203ms","start":"2026-05-04T01:42:49.878003Z","end":"2026-05-04T01:42:49.982344Z","steps":["trace[1256030114] 'agreement among raft nodes before linearized reading'  (duration: 104.042738ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:42:49.98264Z","caller":"traceutil/trace.go:171","msg":"trace[1647838597] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"146.621218ms","start":"2026-05-04T01:42:49.83601Z","end":"2026-05-04T01:42:49.982631Z","steps":["trace[1647838597] 'process raft request'  (duration: 145.810063ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:42:50.226923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.137566ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471726030915732216 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2743 > 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-05-04T01:42:50.227149Z","caller":"traceutil/trace.go:171","msg":"trace[336154911] transaction","detail":"{read_only:false; response_revision:2755; number_of_response:1; }","duration":"239.667124ms","start":"2026-05-04T01:42:49.987464Z","end":"2026-05-04T01:42:50.227131Z","steps":["trace[336154911] 'process raft request'  (duration: 239.566332ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:42:50.227191Z","caller":"traceutil/trace.go:171","msg":"trace[729301650] transaction","detail":"{read_only:false; response_revision:2754; number_of_response:1; }","duration":"290.872973ms","start":"2026-05-04T01:42:49.936278Z","end":"2026-05-04T01:42:50.227151Z","steps":["trace[729301650] 'process raft request'  (duration: 94.41126ms)","trace[729301650] 'compare'  (duration: 195.489155ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:46:35.147157Z","caller":"traceutil/trace.go:171","msg":"trace[1064027886] transaction","detail":"{read_only:false; response_revision:4588; number_of_response:1; }","duration":"104.321643ms","start":"2026-05-04T01:46:35.042791Z","end":"2026-05-04T01:46:35.147113Z","steps":["trace[1064027886] 'process raft request'  (duration: 101.786597ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:46:41.040057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.020893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"}
{"level":"warn","ts":"2026-05-04T01:46:41.040105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.874071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-xv4xd-tls\" ","response":"range_response_count:1 size:2130"}
{"level":"info","ts":"2026-05-04T01:46:41.040165Z","caller":"traceutil/trace.go:171","msg":"trace[1724308213] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"105.830832ms","start":"2026-05-04T01:46:40.934311Z","end":"2026-05-04T01:46:41.040141Z","steps":["trace[1724308213] 'process raft request'  (duration: 69.024673ms)","trace[1724308213] 'compare'  (duration: 36.669996ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:46:41.040166Z","caller":"traceutil/trace.go:171","msg":"trace[421634449] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4752; }","duration":"108.186806ms","start":"2026-05-04T01:46:40.931965Z","end":"2026-05-04T01:46:41.040152Z","steps":["trace[421634449] 'range keys from in-memory index tree'  (duration: 107.79154ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:41.040189Z","caller":"traceutil/trace.go:171","msg":"trace[1179838333] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-xv4xd-tls; range_end:; response_count:1; response_revision:4752; }","duration":"107.027194ms","start":"2026-05-04T01:46:40.93314Z","end":"2026-05-04T01:46:41.040167Z","steps":["trace[1179838333] 'range keys from in-memory index tree'  (duration: 106.683708ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:46:41.040086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.820698ms","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-05-04T01:46:41.04036Z","caller":"traceutil/trace.go:171","msg":"trace[1446209478] 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":"109.125393ms","start":"2026-05-04T01:46:40.931192Z","end":"2026-05-04T01:46:41.040318Z","steps":["trace[1446209478] 'range keys from in-memory index tree'  (duration: 108.664484ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:41.047659Z","caller":"traceutil/trace.go:171","msg":"trace[644579265] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"111.900906ms","start":"2026-05-04T01:46:40.935739Z","end":"2026-05-04T01:46:41.04764Z","steps":["trace[644579265] 'process raft request'  (duration: 111.561779ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:42.028253Z","caller":"traceutil/trace.go:171","msg":"trace[468022719] linearizableReadLoop","detail":"{readStateIndex:4978; appliedIndex:4977; }","duration":"177.597997ms","start":"2026-05-04T01:46:41.850617Z","end":"2026-05-04T01:46:42.028215Z","steps":["trace[468022719] 'read index received'  (duration: 123.394121ms)","trace[468022719] 'applied index is now lower than readState.Index'  (duration: 54.202216ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:46:42.028378Z","caller":"traceutil/trace.go:171","msg":"trace[616023866] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"195.586844ms","start":"2026-05-04T01:46:41.832749Z","end":"2026-05-04T01:46:42.028336Z","steps":["trace[616023866] 'process raft request'  (duration: 141.189145ms)","trace[616023866] 'compare'  (duration: 53.749017ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:46:42.028604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.943463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T01:46:42.028674Z","caller":"traceutil/trace.go:171","msg":"trace[494049111] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:4790; }","duration":"178.089406ms","start":"2026-05-04T01:46:41.850564Z","end":"2026-05-04T01:46:42.028653Z","steps":["trace[494049111] 'agreement among raft nodes before linearized reading'  (duration: 177.815641ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:46.670242Z","caller":"traceutil/trace.go:171","msg":"trace[1444340587] linearizableReadLoop","detail":"{readStateIndex:5130; appliedIndex:5129; }","duration":"254.672509ms","start":"2026-05-04T01:46:46.415543Z","end":"2026-05-04T01:46:46.670216Z","steps":["trace[1444340587] 'read index received'  (duration: 254.515426ms)","trace[1444340587] 'applied index is now lower than readState.Index'  (duration: 155.863µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:46:46.670311Z","caller":"traceutil/trace.go:171","msg":"trace[1553741184] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"278.687792ms","start":"2026-05-04T01:46:46.391584Z","end":"2026-05-04T01:46:46.670272Z","steps":["trace[1553741184] 'process raft request'  (duration: 278.407017ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:46:46.670723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.155698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-04T01:46:46.670787Z","caller":"traceutil/trace.go:171","msg":"trace[1261920593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4938; }","duration":"255.27578ms","start":"2026-05-04T01:46:46.415494Z","end":"2026-05-04T01:46:46.67077Z","steps":["trace[1261920593] 'agreement among raft nodes before linearized reading'  (duration: 254.843022ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:46.702952Z","caller":"traceutil/trace.go:171","msg":"trace[894269049] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"167.667868ms","start":"2026-05-04T01:46:46.535253Z","end":"2026-05-04T01:46:46.702921Z","steps":["trace[894269049] 'process raft request'  (duration: 167.142528ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:46:46.703025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.246888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-05-04T01:46:46.703084Z","caller":"traceutil/trace.go:171","msg":"trace[1939550042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4939; }","duration":"282.384461ms","start":"2026-05-04T01:46:46.420684Z","end":"2026-05-04T01:46:46.703069Z","steps":["trace[1939550042] 'agreement among raft nodes before linearized reading'  (duration: 282.162557ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:46:46.703368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.238123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-edd5608d-cfe8-4c07-9336-cc3d919145f1\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-05-04T01:46:46.703536Z","caller":"traceutil/trace.go:171","msg":"trace[1502260204] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-edd5608d-cfe8-4c07-9336-cc3d919145f1; range_end:; response_count:1; response_revision:4939; }","duration":"146.481577ms","start":"2026-05-04T01:46:46.557017Z","end":"2026-05-04T01:46:46.703499Z","steps":["trace[1502260204] 'agreement among raft nodes before linearized reading'  (duration: 146.004949ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:46.827493Z","caller":"traceutil/trace.go:171","msg":"trace[994271331] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"138.339267ms","start":"2026-05-04T01:46:46.68913Z","end":"2026-05-04T01:46:46.82747Z","steps":["trace[994271331] 'process raft request'  (duration: 138.284596ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:46.82781Z","caller":"traceutil/trace.go:171","msg":"trace[1562676232] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"151.896478ms","start":"2026-05-04T01:46:46.675873Z","end":"2026-05-04T01:46:46.827769Z","steps":["trace[1562676232] 'process raft request'  (duration: 79.214689ms)","trace[1562676232] 'compare'  (duration: 72.18435ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:46:46.86788Z","caller":"traceutil/trace.go:171","msg":"trace[1867191129] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"158.990918ms","start":"2026-05-04T01:46:46.708862Z","end":"2026-05-04T01:46:46.867853Z","steps":["trace[1867191129] 'process raft request'  (duration: 158.736993ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:46.868159Z","caller":"traceutil/trace.go:171","msg":"trace[68785830] linearizableReadLoop","detail":"{readStateIndex:5135; appliedIndex:5131; }","duration":"146.930136ms","start":"2026-05-04T01:46:46.721199Z","end":"2026-05-04T01:46:46.868129Z","steps":["trace[68785830] 'read index received'  (duration: 33.869804ms)","trace[68785830] 'applied index is now lower than readState.Index'  (duration: 113.058932ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:46:46.868292Z","caller":"traceutil/trace.go:171","msg":"trace[173091072] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"158.277225ms","start":"2026-05-04T01:46:46.710003Z","end":"2026-05-04T01:46:46.86828Z","steps":["trace[173091072] 'process raft request'  (duration: 157.778816ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:46:46.868564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.329743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T01:46:46.868664Z","caller":"traceutil/trace.go:171","msg":"trace[1585460439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4943; }","duration":"147.457065ms","start":"2026-05-04T01:46:46.721186Z","end":"2026-05-04T01:46:46.868643Z","steps":["trace[1585460439] 'agreement among raft nodes before linearized reading'  (duration: 147.244151ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:48.759862Z","caller":"traceutil/trace.go:171","msg":"trace[953368452] transaction","detail":"{read_only:false; response_revision:4985; number_of_response:1; }","duration":"198.327342ms","start":"2026-05-04T01:46:48.561514Z","end":"2026-05-04T01:46:48.759842Z","steps":["trace[953368452] 'process raft request'  (duration: 198.166799ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:48.759861Z","caller":"traceutil/trace.go:171","msg":"trace[685517253] linearizableReadLoop","detail":"{readStateIndex:5179; appliedIndex:5178; }","duration":"176.105493ms","start":"2026-05-04T01:46:48.583723Z","end":"2026-05-04T01:46:48.759828Z","steps":["trace[685517253] 'read index received'  (duration: 175.92399ms)","trace[685517253] 'applied index is now lower than readState.Index'  (duration: 180.423µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:46:48.760159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.413998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"}
{"level":"info","ts":"2026-05-04T01:46:48.76024Z","caller":"traceutil/trace.go:171","msg":"trace[1156822799] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4985; }","duration":"176.549791ms","start":"2026-05-04T01:46:48.583674Z","end":"2026-05-04T01:46:48.760224Z","steps":["trace[1156822799] 'agreement among raft nodes before linearized reading'  (duration: 176.215205ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:46:48.760322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.438699ms","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-05-04T01:46:48.760383Z","caller":"traceutil/trace.go:171","msg":"trace[1222015575] 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:4985; }","duration":"138.543361ms","start":"2026-05-04T01:46:48.621822Z","end":"2026-05-04T01:46:48.760365Z","steps":["trace[1222015575] 'agreement among raft nodes before linearized reading'  (duration: 138.410689ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:56.876218Z","caller":"traceutil/trace.go:171","msg":"trace[1334003880] transaction","detail":"{read_only:false; response_revision:5142; number_of_response:1; }","duration":"124.597535ms","start":"2026-05-04T01:46:56.751582Z","end":"2026-05-04T01:46:56.87618Z","steps":["trace[1334003880] 'process raft request'  (duration: 33.717661ms)","trace[1334003880] 'compare'  (duration: 90.600419ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:46:56.87642Z","caller":"traceutil/trace.go:171","msg":"trace[2127955277] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"124.538883ms","start":"2026-05-04T01:46:56.751861Z","end":"2026-05-04T01:46:56.8764Z","steps":["trace[2127955277] 'process raft request'  (duration: 124.233068ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:56.876817Z","caller":"traceutil/trace.go:171","msg":"trace[1610982080] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"124.529064ms","start":"2026-05-04T01:46:56.75228Z","end":"2026-05-04T01:46:56.876809Z","steps":["trace[1610982080] 'process raft request'  (duration: 124.287669ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:56.876824Z","caller":"traceutil/trace.go:171","msg":"trace[76824608] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"114.903446ms","start":"2026-05-04T01:46:56.761897Z","end":"2026-05-04T01:46:56.8768Z","steps":["trace[76824608] 'process raft request'  (duration: 114.794724ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:46:56.876772Z","caller":"traceutil/trace.go:171","msg":"trace[943064145] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"124.687796ms","start":"2026-05-04T01:46:56.752039Z","end":"2026-05-04T01:46:56.876727Z","steps":["trace[943064145] 'process raft request'  (duration: 124.269359ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:47:07.00771Z","caller":"traceutil/trace.go:171","msg":"trace[1348982569] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"175.150465ms","start":"2026-05-04T01:47:06.832533Z","end":"2026-05-04T01:47:07.007683Z","steps":["trace[1348982569] 'process raft request'  (duration: 174.978412ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:47:07.174949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.29112ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471726030915738463 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5260 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T01:47:07.175082Z","caller":"traceutil/trace.go:171","msg":"trace[347373902] linearizableReadLoop","detail":"{readStateIndex:5535; appliedIndex:5534; }","duration":"188.51711ms","start":"2026-05-04T01:47:06.986543Z","end":"2026-05-04T01:47:07.17506Z","steps":["trace[347373902] 'read index received'  (duration: 21.739149ms)","trace[347373902] 'applied index is now lower than readState.Index'  (duration: 166.776811ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:47:07.175142Z","caller":"traceutil/trace.go:171","msg":"trace[157164394] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"246.812854ms","start":"2026-05-04T01:47:06.928281Z","end":"2026-05-04T01:47:07.175094Z","steps":["trace[157164394] 'process raft request'  (duration: 111.266989ms)","trace[157164394] 'compare'  (duration: 135.135458ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:47:07.175343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.536795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-05-04T01:47:07.175195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.663233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T01:47:07.175384Z","caller":"traceutil/trace.go:171","msg":"trace[52632966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5332; }","duration":"155.608566ms","start":"2026-05-04T01:47:07.019765Z","end":"2026-05-04T01:47:07.175373Z","steps":["trace[52632966] 'agreement among raft nodes before linearized reading'  (duration: 155.459812ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:47:07.175409Z","caller":"traceutil/trace.go:171","msg":"trace[2061923062] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:5332; }","duration":"188.913298ms","start":"2026-05-04T01:47:06.986478Z","end":"2026-05-04T01:47:07.175391Z","steps":["trace[2061923062] 'agreement among raft nodes before linearized reading'  (duration: 188.673323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:47:07.176096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.711092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-04T01:47:07.176198Z","caller":"traceutil/trace.go:171","msg":"trace[544825581] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5332; }","duration":"146.858234ms","start":"2026-05-04T01:47:07.029319Z","end":"2026-05-04T01:47:07.176177Z","steps":["trace[544825581] 'agreement among raft nodes before linearized reading'  (duration: 146.04378ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:48:38.997577Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3022}
{"level":"info","ts":"2026-05-04T01:48:39.092002Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3022,"took":"92.272047ms","hash":1827738701,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":31703040,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-05-04T01:48:39.092189Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1827738701,"revision":3022,"compact-revision":-1}
{"level":"info","ts":"2026-05-04T01:53:10.847892Z","caller":"traceutil/trace.go:171","msg":"trace[740481888] linearizableReadLoop","detail":"{readStateIndex:8439; appliedIndex:8438; }","duration":"166.927221ms","start":"2026-05-04T01:53:10.680931Z","end":"2026-05-04T01:53:10.847859Z","steps":["trace[740481888] 'read index received'  (duration: 166.769658ms)","trace[740481888] 'applied index is now lower than readState.Index'  (duration: 155.902µs)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:53:10.848032Z","caller":"traceutil/trace.go:171","msg":"trace[1106360956] transaction","detail":"{read_only:false; response_revision:8148; number_of_response:1; }","duration":"247.545228ms","start":"2026-05-04T01:53:10.600476Z","end":"2026-05-04T01:53:10.848022Z","steps":["trace[1106360956] 'process raft request'  (duration: 247.172152ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:53:10.848291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.334028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-04T01:53:10.84841Z","caller":"traceutil/trace.go:171","msg":"trace[314143599] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8148; }","duration":"167.514511ms","start":"2026-05-04T01:53:10.680867Z","end":"2026-05-04T01:53:10.848381Z","steps":["trace[314143599] 'agreement among raft nodes before linearized reading'  (duration: 167.255166ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:53:11.116301Z","caller":"traceutil/trace.go:171","msg":"trace[1628662220] linearizableReadLoop","detail":"{readStateIndex:8440; appliedIndex:8439; }","duration":"268.294851ms","start":"2026-05-04T01:53:10.847981Z","end":"2026-05-04T01:53:11.116276Z","steps":["trace[1628662220] 'read index received'  (duration: 244.742306ms)","trace[1628662220] 'applied index is now lower than readState.Index'  (duration: 23.551945ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:53:11.116301Z","caller":"traceutil/trace.go:171","msg":"trace[1907217104] transaction","detail":"{read_only:false; response_revision:8149; number_of_response:1; }","duration":"277.488951ms","start":"2026-05-04T01:53:10.838767Z","end":"2026-05-04T01:53:11.116256Z","steps":["trace[1907217104] 'process raft request'  (duration: 253.914825ms)","trace[1907217104] 'compare'  (duration: 23.191339ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:53:11.116484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.537113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T01:53:11.11653Z","caller":"traceutil/trace.go:171","msg":"trace[1743400837] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:8149; }","duration":"367.616614ms","start":"2026-05-04T01:53:10.748898Z","end":"2026-05-04T01:53:11.116514Z","steps":["trace[1743400837] 'agreement among raft nodes before linearized reading'  (duration: 367.527573ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:53:11.116565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:53:10.748889Z","time spent":"367.667585ms","remote":"127.0.0.1:60952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "}
{"level":"info","ts":"2026-05-04T01:53:11.116712Z","caller":"traceutil/trace.go:171","msg":"trace[46711982] transaction","detail":"{read_only:false; response_revision:8150; number_of_response:1; }","duration":"248.535056ms","start":"2026-05-04T01:53:10.868135Z","end":"2026-05-04T01:53:11.11667Z","steps":["trace[46711982] 'process raft request'  (duration: 248.083558ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:53:11.116688Z","caller":"traceutil/trace.go:171","msg":"trace[1624257400] transaction","detail":"{read_only:false; response_revision:8151; number_of_response:1; }","duration":"145.117428ms","start":"2026-05-04T01:53:10.971527Z","end":"2026-05-04T01:53:11.116645Z","steps":["trace[1624257400] 'process raft request'  (duration: 144.998076ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:53:11.116791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.800228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-05-04T01:53:11.116831Z","caller":"traceutil/trace.go:171","msg":"trace[800305717] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8151; }","duration":"263.894019ms","start":"2026-05-04T01:53:10.852926Z","end":"2026-05-04T01:53:11.11682Z","steps":["trace[800305717] 'agreement among raft nodes before linearized reading'  (duration: 263.700305ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:53:11.116999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.218798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/barbican-api-754957bb76-hh4db\" ","response":"range_response_count:1 size:8471"}
{"level":"info","ts":"2026-05-04T01:53:11.117097Z","caller":"traceutil/trace.go:171","msg":"trace[1206968740] range","detail":"{range_begin:/registry/pods/openstack/barbican-api-754957bb76-hh4db; range_end:; response_count:1; response_revision:8151; }","duration":"146.36077ms","start":"2026-05-04T01:53:10.97071Z","end":"2026-05-04T01:53:11.117071Z","steps":["trace[1206968740] 'agreement among raft nodes before linearized reading'  (duration: 146.022004ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:53:22.694253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.578128ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471726030915746161 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.138\" mod_revision:8166 > success:<request_put:<key:\"/registry/masterleases/199.204.45.138\" value_size:67 lease:8471726030915746159 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.138\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T01:53:22.694392Z","caller":"traceutil/trace.go:171","msg":"trace[426740914] transaction","detail":"{read_only:false; response_revision:8217; number_of_response:1; }","duration":"158.82162ms","start":"2026-05-04T01:53:22.535546Z","end":"2026-05-04T01:53:22.694368Z","steps":["trace[426740914] 'process raft request'  (duration: 53.021138ms)","trace[426740914] 'compare'  (duration: 105.220792ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:53:23.434712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.418022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-05-04T01:53:23.434808Z","caller":"traceutil/trace.go:171","msg":"trace[1721577774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8222; }","duration":"101.551684ms","start":"2026-05-04T01:53:23.333234Z","end":"2026-05-04T01:53:23.434786Z","steps":["trace[1721577774] 'range keys from in-memory index tree'  (duration: 101.233649ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:53:23.610487Z","caller":"traceutil/trace.go:171","msg":"trace[2092890481] transaction","detail":"{read_only:false; response_revision:8223; number_of_response:1; }","duration":"170.346253ms","start":"2026-05-04T01:53:23.44011Z","end":"2026-05-04T01:53:23.610456Z","steps":["trace[2092890481] 'process raft request'  (duration: 170.140589ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:53:23.879227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.209051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-04T01:53:23.879328Z","caller":"traceutil/trace.go:171","msg":"trace[1492442714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8223; }","duration":"157.426914ms","start":"2026-05-04T01:53:23.721879Z","end":"2026-05-04T01:53:23.879306Z","steps":["trace[1492442714] 'range keys from in-memory index tree'  (duration: 157.107009ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:53:24.889704Z","caller":"traceutil/trace.go:171","msg":"trace[1282816996] transaction","detail":"{read_only:false; response_revision:8228; number_of_response:1; }","duration":"129.501759ms","start":"2026-05-04T01:53:24.760171Z","end":"2026-05-04T01:53:24.889673Z","steps":["trace[1282816996] 'process raft request'  (duration: 129.270485ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:53:25.378814Z","caller":"traceutil/trace.go:171","msg":"trace[786920422] transaction","detail":"{read_only:false; response_revision:8230; number_of_response:1; }","duration":"174.845416ms","start":"2026-05-04T01:53:25.203941Z","end":"2026-05-04T01:53:25.378787Z","steps":["trace[786920422] 'process raft request'  (duration: 174.692524ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:53:25.407745Z","caller":"traceutil/trace.go:171","msg":"trace[1320745116] linearizableReadLoop","detail":"{readStateIndex:8526; appliedIndex:8524; }","duration":"145.941863ms","start":"2026-05-04T01:53:25.261776Z","end":"2026-05-04T01:53:25.407717Z","steps":["trace[1320745116] 'read index received'  (duration: 116.853156ms)","trace[1320745116] 'applied index is now lower than readState.Index'  (duration: 29.087387ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:53:25.407772Z","caller":"traceutil/trace.go:171","msg":"trace[949171866] transaction","detail":"{read_only:false; response_revision:8231; number_of_response:1; }","duration":"180.691764ms","start":"2026-05-04T01:53:25.227054Z","end":"2026-05-04T01:53:25.407746Z","steps":["trace[949171866] 'process raft request'  (duration: 180.534052ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:53:25.408122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.320299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-04T01:53:25.408184Z","caller":"traceutil/trace.go:171","msg":"trace[1460227474] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8231; }","duration":"146.440522ms","start":"2026-05-04T01:53:25.261724Z","end":"2026-05-04T01:53:25.408164Z","steps":["trace[1460227474] 'agreement among raft nodes before linearized reading'  (duration: 146.143177ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:53:39.008253Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6133}
{"level":"info","ts":"2026-05-04T01:53:39.117685Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6133,"took":"107.183849ms","hash":877949474,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":23539712,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-05-04T01:53:39.117783Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":877949474,"revision":6133,"compact-revision":3022}
{"level":"info","ts":"2026-05-04T01:54:12.284543Z","caller":"traceutil/trace.go:171","msg":"trace[975800895] transaction","detail":"{read_only:false; response_revision:8567; number_of_response:1; }","duration":"360.459931ms","start":"2026-05-04T01:54:11.924056Z","end":"2026-05-04T01:54:12.284516Z","steps":["trace[975800895] 'process raft request'  (duration: 360.302029ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:54:12.28475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:54:11.924041Z","time spent":"360.582143ms","remote":"127.0.0.1:32824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8556 > 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":"info","ts":"2026-05-04T01:54:12.560448Z","caller":"traceutil/trace.go:171","msg":"trace[1026865681] linearizableReadLoop","detail":"{readStateIndex:8877; appliedIndex:8875; }","duration":"335.154484ms","start":"2026-05-04T01:54:12.225248Z","end":"2026-05-04T01:54:12.560403Z","steps":["trace[1026865681] 'read index received'  (duration: 59.187802ms)","trace[1026865681] 'applied index is now lower than readState.Index'  (duration: 275.964642ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:54:12.560482Z","caller":"traceutil/trace.go:171","msg":"trace[1086525438] transaction","detail":"{read_only:false; response_revision:8568; number_of_response:1; }","duration":"431.765637ms","start":"2026-05-04T01:54:12.128681Z","end":"2026-05-04T01:54:12.560447Z","steps":["trace[1086525438] 'process raft request'  (duration: 429.022996ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:54:12.560707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:54:12.128652Z","time spent":"431.95436ms","remote":"127.0.0.1:32824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:8529 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:414 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-04T01:54:12.560831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.899067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-04T01:54:12.560875Z","caller":"traceutil/trace.go:171","msg":"trace[1981205853] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:8568; }","duration":"304.006829ms","start":"2026-05-04T01:54:12.256855Z","end":"2026-05-04T01:54:12.560862Z","steps":["trace[1981205853] 'agreement among raft nodes before linearized reading'  (duration: 303.785824ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:54:12.560912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:54:12.256835Z","time spent":"304.068752ms","remote":"127.0.0.1:60856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.138\" "}
{"level":"warn","ts":"2026-05-04T01:54:12.561006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.552047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"warn","ts":"2026-05-04T01:54:12.561052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.141367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"warn","ts":"2026-05-04T01:54:12.561051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.126457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-04T01:54:12.56108Z","caller":"traceutil/trace.go:171","msg":"trace[32562185] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8568; }","duration":"261.625668ms","start":"2026-05-04T01:54:12.299432Z","end":"2026-05-04T01:54:12.561058Z","steps":["trace[32562185] 'agreement among raft nodes before linearized reading'  (duration: 261.375503ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:54:12.56109Z","caller":"traceutil/trace.go:171","msg":"trace[165036750] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8568; }","duration":"237.216718ms","start":"2026-05-04T01:54:12.323862Z","end":"2026-05-04T01:54:12.561078Z","steps":["trace[165036750] 'agreement among raft nodes before linearized reading'  (duration: 237.088326ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:54:12.5611Z","caller":"traceutil/trace.go:171","msg":"trace[1957842510] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:8568; }","duration":"165.213488ms","start":"2026-05-04T01:54:12.395872Z","end":"2026-05-04T01:54:12.561085Z","steps":["trace[1957842510] 'agreement among raft nodes before linearized reading'  (duration: 165.126247ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:54:12.561136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.322321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-05-04T01:54:12.561191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.913424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-254pf\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-05-04T01:54:12.561234Z","caller":"traceutil/trace.go:171","msg":"trace[659279632] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8568; }","duration":"262.457093ms","start":"2026-05-04T01:54:12.298747Z","end":"2026-05-04T01:54:12.561204Z","steps":["trace[659279632] 'agreement among raft nodes before linearized reading'  (duration: 262.24214ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:54:12.561274Z","caller":"traceutil/trace.go:171","msg":"trace[1175444640] range","detail":"{range_begin:/registry/pods/openstack/keepalived-254pf; range_end:; response_count:1; response_revision:8568; }","duration":"203.039636ms","start":"2026-05-04T01:54:12.358217Z","end":"2026-05-04T01:54:12.561257Z","steps":["trace[1175444640] 'agreement among raft nodes before linearized reading'  (duration: 202.427855ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:54:12.560773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.503552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-04T01:54:12.561515Z","caller":"traceutil/trace.go:171","msg":"trace[838058129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8568; }","duration":"336.321856ms","start":"2026-05-04T01:54:12.225175Z","end":"2026-05-04T01:54:12.561497Z","steps":["trace[838058129] 'agreement among raft nodes before linearized reading'  (duration: 335.348677ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:54:12.561561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-04T01:54:12.225144Z","time spent":"336.401338ms","remote":"127.0.0.1:32824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-05-04T01:54:25.232955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.572913ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8471726030915747650 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:8557 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-04T01:54:25.233206Z","caller":"traceutil/trace.go:171","msg":"trace[2079626506] transaction","detail":"{read_only:false; response_revision:8704; number_of_response:1; }","duration":"133.572646ms","start":"2026-05-04T01:54:25.099615Z","end":"2026-05-04T01:54:25.233187Z","steps":["trace[2079626506] 'process raft request'  (duration: 133.495555ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:54:25.23345Z","caller":"traceutil/trace.go:171","msg":"trace[2037572222] transaction","detail":"{read_only:false; response_revision:8703; number_of_response:1; }","duration":"228.58972ms","start":"2026-05-04T01:54:25.004812Z","end":"2026-05-04T01:54:25.233402Z","steps":["trace[2037572222] 'process raft request'  (duration: 112.457467ms)","trace[2037572222] 'compare'  (duration: 115.43956ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:54:25.47865Z","caller":"traceutil/trace.go:171","msg":"trace[1081378015] linearizableReadLoop","detail":"{readStateIndex:9019; appliedIndex:9018; }","duration":"189.184608ms","start":"2026-05-04T01:54:25.289424Z","end":"2026-05-04T01:54:25.478609Z","steps":["trace[1081378015] 'read index received'  (duration: 147.348712ms)","trace[1081378015] 'applied index is now lower than readState.Index'  (duration: 41.834466ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T01:54:25.478873Z","caller":"traceutil/trace.go:171","msg":"trace[1196603733] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"258.592495ms","start":"2026-05-04T01:54:25.220263Z","end":"2026-05-04T01:54:25.478855Z","steps":["trace[1196603733] 'process raft request'  (duration: 216.415314ms)","trace[1196603733] 'compare'  (duration: 41.168452ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:54:25.479056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.609895ms","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-05-04T01:54:25.479176Z","caller":"traceutil/trace.go:171","msg":"trace[1108055248] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8705; }","duration":"189.85938ms","start":"2026-05-04T01:54:25.28929Z","end":"2026-05-04T01:54:25.479149Z","steps":["trace[1108055248] 'agreement among raft nodes before linearized reading'  (duration: 189.614935ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:54:25.673019Z","caller":"traceutil/trace.go:171","msg":"trace[193058722] transaction","detail":"{read_only:false; response_revision:8709; number_of_response:1; }","duration":"113.73651ms","start":"2026-05-04T01:54:25.55925Z","end":"2026-05-04T01:54:25.672987Z","steps":["trace[193058722] 'process raft request'  (duration: 113.452784ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:54:25.673206Z","caller":"traceutil/trace.go:171","msg":"trace[1417868115] linearizableReadLoop","detail":"{readStateIndex:9023; appliedIndex:9021; }","duration":"112.309773ms","start":"2026-05-04T01:54:25.560859Z","end":"2026-05-04T01:54:25.673168Z","steps":["trace[1417868115] 'read index received'  (duration: 76.627441ms)","trace[1417868115] 'applied index is now lower than readState.Index'  (duration: 35.679912ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-04T01:54:25.673506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.624239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-s84bz\" ","response":"range_response_count:1 size:4633"}
{"level":"warn","ts":"2026-05-04T01:54:25.67351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.64729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:3066"}
{"level":"info","ts":"2026-05-04T01:54:25.673564Z","caller":"traceutil/trace.go:171","msg":"trace[745214192] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-s84bz; range_end:; response_count:1; response_revision:8710; }","duration":"112.730931ms","start":"2026-05-04T01:54:25.560819Z","end":"2026-05-04T01:54:25.673549Z","steps":["trace[745214192] 'agreement among raft nodes before linearized reading'  (duration: 112.601928ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:54:25.67361Z","caller":"traceutil/trace.go:171","msg":"trace[1891076997] range","detail":"{range_begin:/registry/jobs/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8710; }","duration":"112.745781ms","start":"2026-05-04T01:54:25.560836Z","end":"2026-05-04T01:54:25.673582Z","steps":["trace[1891076997] 'agreement among raft nodes before linearized reading'  (duration: 112.530237ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:54:46.424534Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002410.wal"}
{"level":"info","ts":"2026-05-04T01:55:22.155388Z","caller":"traceutil/trace.go:171","msg":"trace[685106594] transaction","detail":"{read_only:false; response_revision:9231; number_of_response:1; }","duration":"258.606455ms","start":"2026-05-04T01:55:21.896758Z","end":"2026-05-04T01:55:22.155364Z","steps":["trace[685106594] 'process raft request'  (duration: 255.11255ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:55:22.159871Z","caller":"traceutil/trace.go:171","msg":"trace[2140921886] transaction","detail":"{read_only:false; response_revision:9232; number_of_response:1; }","duration":"260.636734ms","start":"2026-05-04T01:55:21.899212Z","end":"2026-05-04T01:55:22.159849Z","steps":["trace[2140921886] 'process raft request'  (duration: 260.234986ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:56:14.415324Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f3d52791b64f7591","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T01:56:14.421715Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-05-04T01:56:14.42244Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-05-04T01:58:39.014996Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8309}
{"level":"info","ts":"2026-05-04T01:58:39.096557Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8309,"took":"78.396227ms","hash":4019193998,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":26443776,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-05-04T01:58:39.096648Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4019193998,"revision":8309,"compact-revision":6133}
{"level":"info","ts":"2026-05-04T01:58:48.218591Z","caller":"traceutil/trace.go:171","msg":"trace[2050089522] transaction","detail":"{read_only:false; response_revision:11041; number_of_response:1; }","duration":"147.627796ms","start":"2026-05-04T01:58:48.070933Z","end":"2026-05-04T01:58:48.21856Z","steps":["trace[2050089522] 'process raft request'  (duration: 147.388662ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T01:59:06.9559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.017689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-254pf\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-05-04T01:59:06.956009Z","caller":"traceutil/trace.go:171","msg":"trace[933395813] range","detail":"{range_begin:/registry/pods/openstack/keepalived-254pf; range_end:; response_count:1; response_revision:11147; }","duration":"121.157401ms","start":"2026-05-04T01:59:06.834829Z","end":"2026-05-04T01:59:06.955986Z","steps":["trace[933395813] 'range keys from in-memory index tree'  (duration: 120.764583ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T01:59:07.239135Z","caller":"traceutil/trace.go:171","msg":"trace[847156124] transaction","detail":"{read_only:false; response_revision:11149; number_of_response:1; }","duration":"174.0485ms","start":"2026-05-04T01:59:07.065031Z","end":"2026-05-04T01:59:07.23908Z","steps":["trace[847156124] 'process raft request'  (duration: 113.943748ms)","trace[847156124] 'compare'  (duration: 59.756906ms)"],"step_count":2}
{"level":"info","ts":"2026-05-04T02:03:39.022419Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10969}
{"level":"info","ts":"2026-05-04T02:03:39.109459Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10969,"took":"84.135629ms","hash":1333134163,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":27652096,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-05-04T02:03:39.109541Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1333134163,"revision":10969,"compact-revision":8309}
{"level":"info","ts":"2026-05-04T02:08:39.028966Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13003}
{"level":"info","ts":"2026-05-04T02:08:39.114315Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13003,"took":"82.414919ms","hash":1398924169,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":24190976,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-05-04T02:08:39.114383Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1398924169,"revision":13003,"compact-revision":10969}
{"level":"info","ts":"2026-05-04T02:13:39.03538Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14701}
{"level":"info","ts":"2026-05-04T02:13:39.111636Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14701,"took":"73.37146ms","hash":2824168847,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":20496384,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-05-04T02:13:39.111724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2824168847,"revision":14701,"compact-revision":13003}
{"level":"info","ts":"2026-05-04T02:18:39.041828Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16226}
{"level":"info","ts":"2026-05-04T02:18:39.111806Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16226,"took":"67.407089ms","hash":1592911859,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":20451328,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-05-04T02:18:39.111868Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1592911859,"revision":16226,"compact-revision":14701}
{"level":"info","ts":"2026-05-04T02:19:38.419368Z","caller":"traceutil/trace.go:171","msg":"trace[1447484392] transaction","detail":"{read_only:false; response_revision:18049; number_of_response:1; }","duration":"111.035118ms","start":"2026-05-04T02:19:38.308303Z","end":"2026-05-04T02:19:38.419338Z","steps":["trace[1447484392] 'process raft request'  (duration: 110.865145ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T02:23:39.05025Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17746}
{"level":"info","ts":"2026-05-04T02:23:39.115827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17746,"took":"62.751254ms","hash":1727748735,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":20504576,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-05-04T02:23:39.115895Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1727748735,"revision":17746,"compact-revision":16226}
{"level":"info","ts":"2026-05-04T02:23:44.201026Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f3d52791b64f7591","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-05-04T02:23:44.206413Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-05-04T02:23:44.206554Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-05-04T02:28:39.057901Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19269}
{"level":"info","ts":"2026-05-04T02:28:39.123223Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19269,"took":"62.639852ms","hash":3243221085,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":20578304,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-05-04T02:28:39.123285Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3243221085,"revision":19269,"compact-revision":17746}
{"level":"warn","ts":"2026-05-04T02:30:46.590717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.278916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"warn","ts":"2026-05-04T02:30:46.590818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.093268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-05-04T02:30:46.59087Z","caller":"traceutil/trace.go:171","msg":"trace[581175371] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:21460; }","duration":"171.48177ms","start":"2026-05-04T02:30:46.419358Z","end":"2026-05-04T02:30:46.59084Z","steps":["trace[581175371] 'range keys from in-memory index tree'  (duration: 171.044512ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T02:30:46.590907Z","caller":"traceutil/trace.go:171","msg":"trace[2059776664] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:21460; }","duration":"126.22565ms","start":"2026-05-04T02:30:46.46466Z","end":"2026-05-04T02:30:46.590885Z","steps":["trace[2059776664] 'count revisions from in-memory index tree'  (duration: 126.007717ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T02:30:46.590883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.689622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-04T02:30:46.591134Z","caller":"traceutil/trace.go:171","msg":"trace[74965310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21460; }","duration":"179.994918ms","start":"2026-05-04T02:30:46.411114Z","end":"2026-05-04T02:30:46.591109Z","steps":["trace[74965310] 'range keys from in-memory index tree'  (duration: 179.455218ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-04T02:30:46.590969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.297363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-05-04T02:30:46.591408Z","caller":"traceutil/trace.go:171","msg":"trace[91767052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21460; }","duration":"174.791022ms","start":"2026-05-04T02:30:46.416575Z","end":"2026-05-04T02:30:46.591366Z","steps":["trace[91767052] 'range keys from in-memory index tree'  (duration: 174.072968ms)"],"step_count":1}
{"level":"info","ts":"2026-05-04T02:33:39.06428Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20811}
{"level":"info","ts":"2026-05-04T02:33:39.141597Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20811,"took":"74.599383ms","hash":3233070171,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":20480000,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-05-04T02:33:39.141676Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3233070171,"revision":20811,"compact-revision":19269}
{"level":"info","ts":"2026-05-04T02:38:39.071824Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22335}
{"level":"info","ts":"2026-05-04T02:38:39.137507Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22335,"took":"63.06658ms","hash":3675653203,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":20512768,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-05-04T02:38:39.137592Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3675653203,"revision":22335,"compact-revision":20811}