{"level":"warn","ts":"2026-03-31T22:19:40.87217Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T22:19:40.872271Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-03-31T22:19:40.872344Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-31T22:19:40.87236Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-03-31T22:19:40.872381Z","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-03-31T22:19:40.872967Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-03-31T22:19:40.873158Z","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.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-03-31T22:19:40.878086Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.531719ms"} {"level":"info","ts":"2026-03-31T22:19:40.885407Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-03-31T22:19:40.885472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-03-31T22:19:40.885496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-03-31T22:19:40.885509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-31T22:19:40.885521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-03-31T22:19:40.885559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-03-31T22:19:40.892505Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-31T22:19:40.897347Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-31T22:19:40.899819Z","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-03-31T22:19:40.902359Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-31T22:19:40.903103Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-31T22:19:40.903194Z","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-03-31T22:19:40.903319Z","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-03-31T22:19:40.903334Z","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-03-31T22:19:40.903764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-03-31T22:19:40.90396Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-03-31T22:19:40.905265Z","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-03-31T22:19:40.905492Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-31T22:19:40.905537Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-31T22:19:40.905572Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-03-31T22:19:40.905602Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-03-31T22:19:41.486661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-03-31T22:19:41.486732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-31T22:19:41.486777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-03-31T22:19:41.486808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-03-31T22:19:41.486825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-03-31T22:19:41.486856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-03-31T22:19:41.48688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-03-31T22:19:41.488215Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T22:19:41.489134Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T22:19:41.489217Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-31T22:19:41.489124Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-03-31T22:19:41.489483Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-31T22:19:41.489541Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-31T22:19:41.492419Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-31T22:19:41.492746Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-03-31T22:19:41.493896Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T22:19:41.493989Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T22:19:41.494034Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-31T22:20:07.493128Z","caller":"traceutil/trace.go:171","msg":"trace[844839227] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"167.173873ms","start":"2026-03-31T22:20:07.325928Z","end":"2026-03-31T22:20:07.493102Z","steps":["trace[844839227] 'process raft request' (duration: 159.027375ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:20:07.493067Z","caller":"traceutil/trace.go:171","msg":"trace[1024766869] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"129.608985ms","start":"2026-03-31T22:20:07.363417Z","end":"2026-03-31T22:20:07.493026Z","steps":["trace[1024766869] 'read index received' (duration: 121.435605ms)","trace[1024766869] 'applied index is now lower than readState.Index' (duration: 8.17159ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:20:07.493271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.813395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:20:07.493693Z","caller":"traceutil/trace.go:171","msg":"trace[1892673288] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:466; }","duration":"130.288349ms","start":"2026-03-31T22:20:07.363371Z","end":"2026-03-31T22:20:07.493659Z","steps":["trace[1892673288] 'agreement among raft nodes before linearized reading' (duration: 129.806444ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:20:19.520907Z","caller":"traceutil/trace.go:171","msg":"trace[1395004626] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"136.651975ms","start":"2026-03-31T22:20:19.384222Z","end":"2026-03-31T22:20:19.520873Z","steps":["trace[1395004626] 'process raft request' (duration: 136.398052ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:20:19.760656Z","caller":"traceutil/trace.go:171","msg":"trace[767028277] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"185.673403ms","start":"2026-03-31T22:20:19.574951Z","end":"2026-03-31T22:20:19.760624Z","steps":["trace[767028277] 'read index received' (duration: 156.651343ms)","trace[767028277] 'applied index is now lower than readState.Index' (duration: 29.02114ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:20:19.761208Z","caller":"traceutil/trace.go:171","msg":"trace[1093517033] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"197.709272ms","start":"2026-03-31T22:20:19.562964Z","end":"2026-03-31T22:20:19.760674Z","steps":["trace[1093517033] 'process raft request' (duration: 169.504624ms)","trace[1093517033] 'compare' (duration: 27.480101ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:20:19.762784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.791922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-31T22:20:19.763116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.058995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-31T22:20:19.763328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.220938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zkmkz\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-31T22:20:19.763564Z","caller":"traceutil/trace.go:171","msg":"trace[1735445423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"188.281676ms","start":"2026-03-31T22:20:19.574976Z","end":"2026-03-31T22:20:19.763258Z","steps":["trace[1735445423] 'agreement among raft nodes before linearized reading' (duration: 187.679406ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:20:19.763657Z","caller":"traceutil/trace.go:171","msg":"trace[237889123] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zkmkz; range_end:; response_count:1; response_revision:620; }","duration":"169.437599ms","start":"2026-03-31T22:20:19.593921Z","end":"2026-03-31T22:20:19.763358Z","steps":["trace[237889123] 'agreement among raft nodes before linearized reading' (duration: 168.88537ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:20:19.764734Z","caller":"traceutil/trace.go:171","msg":"trace[692952556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"187.935319ms","start":"2026-03-31T22:20:19.574919Z","end":"2026-03-31T22:20:19.762854Z","steps":["trace[692952556] 'agreement among raft nodes before linearized reading' (duration: 185.850781ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:20:20.166199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.573811ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-31T22:20:20.166499Z","caller":"traceutil/trace.go:171","msg":"trace[795534461] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"341.02242ms","start":"2026-03-31T22:20:19.825425Z","end":"2026-03-31T22:20:20.166447Z","steps":["trace[795534461] 'process raft request' (duration: 145.572764ms)","trace[795534461] 'compare' (duration: 194.241253ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:20:20.166723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:20:19.825382Z","time spent":"341.239781ms","remote":"127.0.0.1:45248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T22:20:20.277749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.378239ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-03-31T22:21:03.915705Z","caller":"traceutil/trace.go:171","msg":"trace[1468642942] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"134.963308ms","start":"2026-03-31T22:21:03.780705Z","end":"2026-03-31T22:21:03.915668Z","steps":["trace[1468642942] 'process raft request' (duration: 134.7082ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:21:49.45085Z","caller":"traceutil/trace.go:171","msg":"trace[851511588] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"114.550368ms","start":"2026-03-31T22:21:49.336274Z","end":"2026-03-31T22:21:49.450824Z","steps":["trace[851511588] 'process raft request' (duration: 114.318192ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.102695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.360095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-03-31T22:22:40.102798Z","caller":"traceutil/trace.go:171","msg":"trace[713172685] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2169; }","duration":"199.515679ms","start":"2026-03-31T22:22:39.903262Z","end":"2026-03-31T22:22:40.102777Z","steps":["trace[713172685] 'range keys from in-memory index tree' (duration: 199.059518ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.102839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.470348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T22:22:40.102937Z","caller":"traceutil/trace.go:171","msg":"trace[1960117928] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2169; }","duration":"336.629851ms","start":"2026-03-31T22:22:39.766285Z","end":"2026-03-31T22:22:40.102914Z","steps":["trace[1960117928] 'count revisions from in-memory index tree' (duration: 336.371926ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.102993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:22:39.76626Z","time spent":"336.719623ms","remote":"127.0.0.1:45128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":67,"response size":28,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-03-31T22:22:40.103398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.125105ms","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-03-31T22:22:40.103537Z","caller":"traceutil/trace.go:171","msg":"trace[1404227672] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2169; }","duration":"182.31336ms","start":"2026-03-31T22:22:39.9212Z","end":"2026-03-31T22:22:40.103514Z","steps":["trace[1404227672] 'range keys from in-memory index tree' (duration: 181.948612ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.736921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.774734ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-03-31T22:22:40.737275Z","caller":"traceutil/trace.go:171","msg":"trace[664310397] linearizableReadLoop","detail":"{readStateIndex:2255; appliedIndex:2252; }","duration":"411.419622ms","start":"2026-03-31T22:22:40.325836Z","end":"2026-03-31T22:22:40.737256Z","steps":["trace[664310397] 'read index received' (duration: 226.29514ms)","trace[664310397] 'applied index is now lower than readState.Index' (duration: 185.123502ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:22:40.737687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.83224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-03-31T22:22:40.737708Z","caller":"traceutil/trace.go:171","msg":"trace[649842149] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"524.387001ms","start":"2026-03-31T22:22:40.213287Z","end":"2026-03-31T22:22:40.737674Z","steps":["trace[649842149] 'process raft request' (duration: 523.759107ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:22:40.737805Z","caller":"traceutil/trace.go:171","msg":"trace[1367788819] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2172; }","duration":"411.988334ms","start":"2026-03-31T22:22:40.325788Z","end":"2026-03-31T22:22:40.737776Z","steps":["trace[1367788819] 'agreement among raft nodes before linearized reading' (duration: 411.670437ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.738056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:22:40.325773Z","time spent":"412.26384ms","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":592,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"info","ts":"2026-03-31T22:22:40.737499Z","caller":"traceutil/trace.go:171","msg":"trace[1676433183] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"447.767433ms","start":"2026-03-31T22:22:40.289676Z","end":"2026-03-31T22:22:40.737444Z","steps":["trace[1676433183] 'process raft request' (duration: 447.524567ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.738478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:22:40.213261Z","time spent":"524.639927ms","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T22:22:40.738585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:22:40.289656Z","time spent":"448.516469ms","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T22:22:40.747372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.466961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:22:40.747393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.858092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-03-31T22:22:40.747423Z","caller":"traceutil/trace.go:171","msg":"trace[1799686998] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2173; }","duration":"225.551523ms","start":"2026-03-31T22:22:40.521859Z","end":"2026-03-31T22:22:40.747411Z","steps":["trace[1799686998] 'agreement among raft nodes before linearized reading' (duration: 225.463181ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.747393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.256876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-31T22:22:40.747448Z","caller":"traceutil/trace.go:171","msg":"trace[1491959002] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2173; }","duration":"256.934094ms","start":"2026-03-31T22:22:40.490491Z","end":"2026-03-31T22:22:40.747425Z","steps":["trace[1491959002] 'agreement among raft nodes before linearized reading' (duration: 256.786011ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:22:40.747516Z","caller":"traceutil/trace.go:171","msg":"trace[1258919763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2173; }","duration":"147.348289ms","start":"2026-03-31T22:22:40.600124Z","end":"2026-03-31T22:22:40.747473Z","steps":["trace[1258919763] 'agreement among raft nodes before linearized reading' (duration: 147.136154ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.747491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.622805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:22:40.747592Z","caller":"traceutil/trace.go:171","msg":"trace[693730392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2173; }","duration":"381.776298ms","start":"2026-03-31T22:22:40.365789Z","end":"2026-03-31T22:22:40.747566Z","steps":["trace[693730392] 'agreement among raft nodes before linearized reading' (duration: 381.580133ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.747643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:22:40.36576Z","time spent":"381.87473ms","remote":"127.0.0.1:33268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-31T22:22:40.747597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.56432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:22:40.747853Z","caller":"traceutil/trace.go:171","msg":"trace[1453926170] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:2173; }","duration":"346.98565ms","start":"2026-03-31T22:22:40.400789Z","end":"2026-03-31T22:22:40.747775Z","steps":["trace[1453926170] 'agreement among raft nodes before linearized reading' (duration: 346.5757ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:22:40.747976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:22:40.400762Z","time spent":"347.191415ms","remote":"127.0.0.1:38932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":26,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"info","ts":"2026-03-31T22:23:25.041551Z","caller":"traceutil/trace.go:171","msg":"trace[661940080] transaction","detail":"{read_only:false; response_revision:2458; number_of_response:1; }","duration":"121.360427ms","start":"2026-03-31T22:23:24.920125Z","end":"2026-03-31T22:23:25.041486Z","steps":["trace[661940080] 'process raft request' (duration: 121.11235ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:23:25.041617Z","caller":"traceutil/trace.go:171","msg":"trace[950727692] transaction","detail":"{read_only:false; response_revision:2459; number_of_response:1; }","duration":"119.933328ms","start":"2026-03-31T22:23:24.921644Z","end":"2026-03-31T22:23:25.041578Z","steps":["trace[950727692] 'process raft request' (duration: 119.719172ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:23:55.323171Z","caller":"traceutil/trace.go:171","msg":"trace[1071255525] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"107.905305ms","start":"2026-03-31T22:23:55.215232Z","end":"2026-03-31T22:23:55.323138Z","steps":["trace[1071255525] 'process raft request' (duration: 107.553134ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:23:55.323419Z","caller":"traceutil/trace.go:171","msg":"trace[87805180] transaction","detail":"{read_only:false; response_revision:2630; number_of_response:1; }","duration":"107.183495ms","start":"2026-03-31T22:23:55.216212Z","end":"2026-03-31T22:23:55.323396Z","steps":["trace[87805180] 'process raft request' (duration: 106.874827ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:23:55.323659Z","caller":"traceutil/trace.go:171","msg":"trace[1482697944] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"106.883135ms","start":"2026-03-31T22:23:55.216742Z","end":"2026-03-31T22:23:55.323625Z","steps":["trace[1482697944] 'process raft request' (duration: 106.569437ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:23:55.323656Z","caller":"traceutil/trace.go:171","msg":"trace[103453194] linearizableReadLoop","detail":"{readStateIndex:2729; appliedIndex:2727; }","duration":"107.703619ms","start":"2026-03-31T22:23:55.215919Z","end":"2026-03-31T22:23:55.323622Z","steps":["trace[103453194] 'read index received' (duration: 92.363283ms)","trace[103453194] 'applied index is now lower than readState.Index' (duration: 15.338666ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:23:55.323855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.931045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-03-31T22:23:55.323904Z","caller":"traceutil/trace.go:171","msg":"trace[533821397] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2631; }","duration":"108.015988ms","start":"2026-03-31T22:23:55.215872Z","end":"2026-03-31T22:23:55.323888Z","steps":["trace[533821397] 'agreement among raft nodes before linearized reading' (duration: 107.876774ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:26:18.761055Z","caller":"traceutil/trace.go:171","msg":"trace[1754747136] linearizableReadLoop","detail":"{readStateIndex:3574; appliedIndex:3572; }","duration":"119.354058ms","start":"2026-03-31T22:26:18.641672Z","end":"2026-03-31T22:26:18.761026Z","steps":["trace[1754747136] 'read index received' (duration: 75.14646ms)","trace[1754747136] 'applied index is now lower than readState.Index' (duration: 44.206298ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:26:18.761081Z","caller":"traceutil/trace.go:171","msg":"trace[831396247] transaction","detail":"{read_only:false; response_revision:3438; number_of_response:1; }","duration":"143.502179ms","start":"2026-03-31T22:26:18.617534Z","end":"2026-03-31T22:26:18.761036Z","steps":["trace[831396247] 'process raft request' (duration: 99.408604ms)","trace[831396247] 'compare' (duration: 43.823238ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:26:18.761237Z","caller":"traceutil/trace.go:171","msg":"trace[1351154509] transaction","detail":"{read_only:false; response_revision:3439; number_of_response:1; }","duration":"143.039217ms","start":"2026-03-31T22:26:18.618185Z","end":"2026-03-31T22:26:18.761225Z","steps":["trace[1351154509] 'process raft request' (duration: 142.787811ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:26:18.761548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.208678ms","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-03-31T22:26:18.761592Z","caller":"traceutil/trace.go:171","msg":"trace[256804122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3439; }","duration":"136.28669ms","start":"2026-03-31T22:26:18.625296Z","end":"2026-03-31T22:26:18.761582Z","steps":["trace[256804122] 'agreement among raft nodes before linearized reading' (duration: 136.089455ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:26:23.642976Z","caller":"traceutil/trace.go:171","msg":"trace[809240836] transaction","detail":"{read_only:false; response_revision:3571; number_of_response:1; }","duration":"143.003367ms","start":"2026-03-31T22:26:23.499938Z","end":"2026-03-31T22:26:23.642941Z","steps":["trace[809240836] 'process raft request' (duration: 135.833659ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:28:09.347668Z","caller":"traceutil/trace.go:171","msg":"trace[1633720213] transaction","detail":"{read_only:false; response_revision:4563; number_of_response:1; }","duration":"110.021754ms","start":"2026-03-31T22:28:09.23759Z","end":"2026-03-31T22:28:09.347612Z","steps":["trace[1633720213] 'process raft request' (duration: 60.97313ms)","trace[1633720213] 'compare' (duration: 48.795437ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:28:10.752563Z","caller":"traceutil/trace.go:171","msg":"trace[573176638] transaction","detail":"{read_only:false; response_revision:4606; number_of_response:1; }","duration":"125.134626ms","start":"2026-03-31T22:28:10.627401Z","end":"2026-03-31T22:28:10.752535Z","steps":["trace[573176638] 'process raft request' (duration: 124.950531ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:28:10.761562Z","caller":"traceutil/trace.go:171","msg":"trace[1351423839] transaction","detail":"{read_only:false; response_revision:4607; number_of_response:1; }","duration":"132.797166ms","start":"2026-03-31T22:28:10.62874Z","end":"2026-03-31T22:28:10.761537Z","steps":["trace[1351423839] 'process raft request' (duration: 132.432377ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:28:10.761441Z","caller":"traceutil/trace.go:171","msg":"trace[1202273026] linearizableReadLoop","detail":"{readStateIndex:4786; appliedIndex:4784; }","duration":"104.584015ms","start":"2026-03-31T22:28:10.656811Z","end":"2026-03-31T22:28:10.761395Z","steps":["trace[1202273026] 'read index received' (duration: 95.555318ms)","trace[1202273026] 'applied index is now lower than readState.Index' (duration: 9.026947ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:28:10.761956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.13241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-03-31T22:28:10.762063Z","caller":"traceutil/trace.go:171","msg":"trace[460835959] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4607; }","duration":"105.260493ms","start":"2026-03-31T22:28:10.656749Z","end":"2026-03-31T22:28:10.76201Z","steps":["trace[460835959] 'agreement among raft nodes before linearized reading' (duration: 104.878852ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:20.464437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.085064ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-03-31T22:28:20.464813Z","caller":"traceutil/trace.go:171","msg":"trace[607944353] linearizableReadLoop","detail":"{readStateIndex:5095; appliedIndex:5093; }","duration":"321.748413ms","start":"2026-03-31T22:28:20.143036Z","end":"2026-03-31T22:28:20.464784Z","steps":["trace[607944353] 'read index received' (duration: 16.629226ms)","trace[607944353] 'applied index is now lower than readState.Index' (duration: 305.118397ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:28:20.46489Z","caller":"traceutil/trace.go:171","msg":"trace[354984465] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"319.629965ms","start":"2026-03-31T22:28:20.145221Z","end":"2026-03-31T22:28:20.464851Z","steps":["trace[354984465] 'process raft request' (duration: 319.341127ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:20.465046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:28:20.145202Z","time spent":"319.775958ms","remote":"127.0.0.1:44110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2181,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-31T22:28:20.507135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.069582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-mcdn5.18a20d8c02091368\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-03-31T22:28:20.507242Z","caller":"traceutil/trace.go:171","msg":"trace[1958848272] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-mcdn5.18a20d8c02091368; range_end:; response_count:1; response_revision:4909; }","duration":"364.216606ms","start":"2026-03-31T22:28:20.142995Z","end":"2026-03-31T22:28:20.507212Z","steps":["trace[1958848272] 'agreement among raft nodes before linearized reading' (duration: 321.885877ms)","trace[1958848272] 'range keys from in-memory index tree' (duration: 42.079133ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:28:20.507293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:28:20.142978Z","time spent":"364.303128ms","remote":"127.0.0.1:33346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":983,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-mcdn5.18a20d8c02091368\" "} {"level":"info","ts":"2026-03-31T22:28:20.507387Z","caller":"traceutil/trace.go:171","msg":"trace[666545246] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"282.815707ms","start":"2026-03-31T22:28:20.224533Z","end":"2026-03-31T22:28:20.507348Z","steps":["trace[666545246] 'process raft request' (duration: 240.246021ms)","trace[666545246] 'compare' (duration: 42.252167ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:28:20.507909Z","caller":"traceutil/trace.go:171","msg":"trace[1811378450] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"213.430177ms","start":"2026-03-31T22:28:20.294429Z","end":"2026-03-31T22:28:20.50786Z","steps":["trace[1811378450] 'process raft request' (duration: 212.85236ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:28:20.507978Z","caller":"traceutil/trace.go:171","msg":"trace[8127532] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"211.699298ms","start":"2026-03-31T22:28:20.296232Z","end":"2026-03-31T22:28:20.507931Z","steps":["trace[8127532] 'process raft request' (duration: 211.471341ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:20.508029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.420559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:28:20.508093Z","caller":"traceutil/trace.go:171","msg":"trace[176887995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4912; }","duration":"143.533712ms","start":"2026-03-31T22:28:20.364543Z","end":"2026-03-31T22:28:20.508076Z","steps":["trace[176887995] 'agreement among raft nodes before linearized reading' (duration: 143.43855ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:20.508206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.88714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e35a73dd-f9c4-4704-b4ce-ab51820a0d8e\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-03-31T22:28:20.508255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.630528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-03-31T22:28:20.508309Z","caller":"traceutil/trace.go:171","msg":"trace[727379479] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e35a73dd-f9c4-4704-b4ce-ab51820a0d8e; range_end:; response_count:1; response_revision:4912; }","duration":"206.056924ms","start":"2026-03-31T22:28:20.302225Z","end":"2026-03-31T22:28:20.508282Z","steps":["trace[727379479] 'agreement among raft nodes before linearized reading' (duration: 205.783937ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:28:20.508349Z","caller":"traceutil/trace.go:171","msg":"trace[328277735] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4912; }","duration":"287.764062ms","start":"2026-03-31T22:28:20.220557Z","end":"2026-03-31T22:28:20.508321Z","steps":["trace[328277735] 'agreement among raft nodes before linearized reading' (duration: 287.460144ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:20.508903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.565074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e35a73dd-f9c4-4704-b4ce-ab51820a0d8e\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-03-31T22:28:20.508962Z","caller":"traceutil/trace.go:171","msg":"trace[1976650891] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e35a73dd-f9c4-4704-b4ce-ab51820a0d8e; range_end:; response_count:1; response_revision:4912; }","duration":"365.765109ms","start":"2026-03-31T22:28:20.143183Z","end":"2026-03-31T22:28:20.508948Z","steps":["trace[1976650891] 'agreement among raft nodes before linearized reading' (duration: 364.765762ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:20.508998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:28:20.143179Z","time spent":"365.80945ms","remote":"127.0.0.1:33454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3622,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e35a73dd-f9c4-4704-b4ce-ab51820a0d8e\" "} {"level":"info","ts":"2026-03-31T22:28:24.295062Z","caller":"traceutil/trace.go:171","msg":"trace[1151665925] linearizableReadLoop","detail":"{readStateIndex:5185; appliedIndex:5184; }","duration":"105.285103ms","start":"2026-03-31T22:28:24.189745Z","end":"2026-03-31T22:28:24.29503Z","steps":["trace[1151665925] 'read index received' (duration: 104.350948ms)","trace[1151665925] 'applied index is now lower than readState.Index' (duration: 931.585µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:28:24.295358Z","caller":"traceutil/trace.go:171","msg":"trace[453544815] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"107.920916ms","start":"2026-03-31T22:28:24.187421Z","end":"2026-03-31T22:28:24.295342Z","steps":["trace[453544815] 'process raft request' (duration: 106.638781ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:24.295481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.318567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:26 size:822344"} {"level":"info","ts":"2026-03-31T22:28:24.295565Z","caller":"traceutil/trace.go:171","msg":"trace[395856531] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:26; response_revision:4993; }","duration":"108.512553ms","start":"2026-03-31T22:28:24.187033Z","end":"2026-03-31T22:28:24.295545Z","steps":["trace[395856531] 'range keys from in-memory index tree' (duration: 107.687229ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:24.29558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.829059ms","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-03-31T22:28:24.295638Z","caller":"traceutil/trace.go:171","msg":"trace[341436490] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4994; }","duration":"105.932092ms","start":"2026-03-31T22:28:24.189686Z","end":"2026-03-31T22:28:24.295618Z","steps":["trace[341436490] 'agreement among raft nodes before linearized reading' (duration: 105.700666ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:24.370884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.54722ms","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-03-31T22:28:24.371024Z","caller":"traceutil/trace.go:171","msg":"trace[2138384012] 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:4995; }","duration":"159.726294ms","start":"2026-03-31T22:28:24.21126Z","end":"2026-03-31T22:28:24.370986Z","steps":["trace[2138384012] 'agreement among raft nodes before linearized reading' (duration: 159.364274ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:28:33.729175Z","caller":"traceutil/trace.go:171","msg":"trace[178510247] transaction","detail":"{read_only:false; response_revision:5153; number_of_response:1; }","duration":"188.37706ms","start":"2026-03-31T22:28:33.540743Z","end":"2026-03-31T22:28:33.72912Z","steps":["trace[178510247] 'process raft request' (duration: 96.086832ms)","trace[178510247] 'compare' (duration: 92.027401ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:28:33.729219Z","caller":"traceutil/trace.go:171","msg":"trace[1818264396] linearizableReadLoop","detail":"{readStateIndex:5351; appliedIndex:5347; }","duration":"110.210518ms","start":"2026-03-31T22:28:33.618988Z","end":"2026-03-31T22:28:33.729199Z","steps":["trace[1818264396] 'read index received' (duration: 17.856049ms)","trace[1818264396] 'applied index is now lower than readState.Index' (duration: 92.353109ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:28:33.729623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.556998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:28:33.729765Z","caller":"traceutil/trace.go:171","msg":"trace[166258378] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:5156; }","duration":"110.802254ms","start":"2026-03-31T22:28:33.618918Z","end":"2026-03-31T22:28:33.72972Z","steps":["trace[166258378] 'agreement among raft nodes before linearized reading' (duration: 110.347602ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:28:33.729674Z","caller":"traceutil/trace.go:171","msg":"trace[1281269513] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"171.411475ms","start":"2026-03-31T22:28:33.55825Z","end":"2026-03-31T22:28:33.729662Z","steps":["trace[1281269513] 'process raft request' (duration: 170.85569ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:28:33.729946Z","caller":"traceutil/trace.go:171","msg":"trace[2083829150] transaction","detail":"{read_only:false; response_revision:5154; number_of_response:1; }","duration":"187.65114ms","start":"2026-03-31T22:28:33.542279Z","end":"2026-03-31T22:28:33.72993Z","steps":["trace[2083829150] 'process raft request' (duration: 186.758006ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:28:33.729957Z","caller":"traceutil/trace.go:171","msg":"trace[1893876927] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"171.536318ms","start":"2026-03-31T22:28:33.55839Z","end":"2026-03-31T22:28:33.729926Z","steps":["trace[1893876927] 'process raft request' (duration: 170.765087ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:41.728297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.492728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-83a3daf2-c4a6-4de0-93ed-1a4149d96053\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-03-31T22:28:41.728413Z","caller":"traceutil/trace.go:171","msg":"trace[986789254] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-83a3daf2-c4a6-4de0-93ed-1a4149d96053; range_end:; response_count:1; response_revision:5299; }","duration":"130.671184ms","start":"2026-03-31T22:28:41.597714Z","end":"2026-03-31T22:28:41.728385Z","steps":["trace[986789254] 'range keys from in-memory index tree' (duration: 130.196549ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:42.097193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.639476ms","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-03-31T22:28:42.097298Z","caller":"traceutil/trace.go:171","msg":"trace[807933914] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5300; }","duration":"132.811851ms","start":"2026-03-31T22:28:41.964463Z","end":"2026-03-31T22:28:42.097275Z","steps":["trace[807933914] 'range keys from in-memory index tree' (duration: 132.358699ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:28:42.097647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.32064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k7lmn\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-03-31T22:28:42.097737Z","caller":"traceutil/trace.go:171","msg":"trace[1353886719] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k7lmn; range_end:; response_count:1; response_revision:5300; }","duration":"118.477453ms","start":"2026-03-31T22:28:41.979237Z","end":"2026-03-31T22:28:42.097714Z","steps":["trace[1353886719] 'range keys from in-memory index tree' (duration: 117.526548ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:29:41.55846Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2870} {"level":"info","ts":"2026-03-31T22:29:41.63893Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2870,"took":"78.75402ms","hash":2471250758,"current-db-size-bytes":57290752,"current-db-size":"57 MB","current-db-size-in-use-bytes":32600064,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-03-31T22:29:41.638994Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2471250758,"revision":2870,"compact-revision":-1} {"level":"info","ts":"2026-03-31T22:34:40.634796Z","caller":"traceutil/trace.go:171","msg":"trace[699311905] linearizableReadLoop","detail":"{readStateIndex:8408; appliedIndex:8405; }","duration":"344.169379ms","start":"2026-03-31T22:34:40.2906Z","end":"2026-03-31T22:34:40.634769Z","steps":["trace[699311905] 'read index received' (duration: 293.293866ms)","trace[699311905] 'applied index is now lower than readState.Index' (duration: 50.874453ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:34:40.63483Z","caller":"traceutil/trace.go:171","msg":"trace[708858655] transaction","detail":"{read_only:false; response_revision:8120; number_of_response:1; }","duration":"500.096261ms","start":"2026-03-31T22:34:40.134694Z","end":"2026-03-31T22:34:40.63479Z","steps":["trace[708858655] 'process raft request' (duration: 499.864065ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:40.634918Z","caller":"traceutil/trace.go:171","msg":"trace[272593913] transaction","detail":"{read_only:false; response_revision:8121; number_of_response:1; }","duration":"497.462207ms","start":"2026-03-31T22:34:40.137394Z","end":"2026-03-31T22:34:40.634857Z","steps":["trace[272593913] 'process raft request' (duration: 497.320833ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:40.635014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:40.134647Z","time spent":"500.275856ms","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T22:34:40.635069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.340631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:40.635151Z","caller":"traceutil/trace.go:171","msg":"trace[869782139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8121; }","duration":"271.471095ms","start":"2026-03-31T22:34:40.363659Z","end":"2026-03-31T22:34:40.63513Z","steps":["trace[869782139] 'agreement among raft nodes before linearized reading' (duration: 271.324831ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:40.635096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.504898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k7lmn\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-03-31T22:34:40.635158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:40.137361Z","time spent":"497.674473ms","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-31T22:34:40.635222Z","caller":"traceutil/trace.go:171","msg":"trace[1059152218] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k7lmn; range_end:; response_count:1; response_revision:8121; }","duration":"344.667702ms","start":"2026-03-31T22:34:40.290543Z","end":"2026-03-31T22:34:40.63521Z","steps":["trace[1059152218] 'agreement among raft nodes before linearized reading' (duration: 344.427315ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:40.635252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:40.290519Z","time spent":"344.726144ms","remote":"127.0.0.1:33454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6545,"request content":"key:\"/registry/pods/openstack/keepalived-k7lmn\" "} {"level":"info","ts":"2026-03-31T22:34:41.565932Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5904} {"level":"info","ts":"2026-03-31T22:34:41.659872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5904,"took":"91.87115ms","hash":134718348,"current-db-size-bytes":57290752,"current-db-size":"57 MB","current-db-size-in-use-bytes":26419200,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-31T22:34:41.659934Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":134718348,"revision":5904,"compact-revision":2870} {"level":"info","ts":"2026-03-31T22:34:52.807014Z","caller":"traceutil/trace.go:171","msg":"trace[165483853] transaction","detail":"{read_only:false; response_revision:8185; number_of_response:1; }","duration":"123.175466ms","start":"2026-03-31T22:34:52.68378Z","end":"2026-03-31T22:34:52.806955Z","steps":["trace[165483853] 'process raft request' (duration: 111.993343ms)","trace[165483853] 'compare' (duration: 10.897975ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:34:53.671121Z","caller":"traceutil/trace.go:171","msg":"trace[135026440] linearizableReadLoop","detail":"{readStateIndex:8480; appliedIndex:8479; }","duration":"422.826709ms","start":"2026-03-31T22:34:53.248269Z","end":"2026-03-31T22:34:53.671096Z","steps":["trace[135026440] 'read index received' (duration: 422.590171ms)","trace[135026440] 'applied index is now lower than readState.Index' (duration: 235.588µs)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:34:53.671321Z","caller":"traceutil/trace.go:171","msg":"trace[714301032] transaction","detail":"{read_only:false; response_revision:8189; number_of_response:1; }","duration":"438.93285ms","start":"2026-03-31T22:34:53.232233Z","end":"2026-03-31T22:34:53.671166Z","steps":["trace[714301032] 'process raft request' (duration: 438.701462ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.671392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.058325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.671531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.219436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:53.671602Z","caller":"traceutil/trace.go:171","msg":"trace[1607749496] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8189; }","duration":"341.323628ms","start":"2026-03-31T22:34:53.330258Z","end":"2026-03-31T22:34:53.671582Z","steps":["trace[1607749496] 'agreement among raft nodes before linearized reading' (duration: 341.171364ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.671612Z","caller":"traceutil/trace.go:171","msg":"trace[412991423] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8189; }","duration":"423.293771ms","start":"2026-03-31T22:34:53.248265Z","end":"2026-03-31T22:34:53.671559Z","steps":["trace[412991423] 'agreement among raft nodes before linearized reading' (duration: 422.951202ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.671748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.330248Z","time spent":"341.479852ms","remote":"127.0.0.1:46880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 "} {"level":"warn","ts":"2026-03-31T22:34:53.671752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.248237Z","time spent":"423.488687ms","remote":"127.0.0.1:46822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T22:34:53.671777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.45443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:53.671855Z","caller":"traceutil/trace.go:171","msg":"trace[997156338] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8189; }","duration":"342.546462ms","start":"2026-03-31T22:34:53.329287Z","end":"2026-03-31T22:34:53.671833Z","steps":["trace[997156338] 'agreement among raft nodes before linearized reading' (duration: 342.438029ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.671859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.232221Z","time spent":"439.258008ms","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T22:34:53.67203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.744209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:53.672085Z","caller":"traceutil/trace.go:171","msg":"trace[1159278345] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8189; }","duration":"342.839051ms","start":"2026-03-31T22:34:53.329234Z","end":"2026-03-31T22:34:53.672073Z","steps":["trace[1159278345] 'agreement among raft nodes before linearized reading' (duration: 342.740528ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.672138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.040465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-31T22:34:53.672205Z","caller":"traceutil/trace.go:171","msg":"trace[83591338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8189; }","duration":"161.141128ms","start":"2026-03-31T22:34:53.511048Z","end":"2026-03-31T22:34:53.672189Z","steps":["trace[83591338] 'agreement among raft nodes before linearized reading' (duration: 160.963153ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.672215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.220629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:53.672273Z","caller":"traceutil/trace.go:171","msg":"trace[1059111928] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8189; }","duration":"364.293901ms","start":"2026-03-31T22:34:53.307963Z","end":"2026-03-31T22:34:53.672257Z","steps":["trace[1059111928] 'agreement among raft nodes before linearized reading' (duration: 364.217039ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.671934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.329281Z","time spent":"342.630254ms","remote":"127.0.0.1:46880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true "} {"level":"warn","ts":"2026-03-31T22:34:53.672339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.307956Z","time spent":"364.359622ms","remote":"127.0.0.1:46864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 "} {"level":"warn","ts":"2026-03-31T22:34:53.672428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.45382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-31T22:34:53.671364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.015074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.672449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.072721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:53.672507Z","caller":"traceutil/trace.go:171","msg":"trace[1689302562] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8189; }","duration":"424.186066ms","start":"2026-03-31T22:34:53.248296Z","end":"2026-03-31T22:34:53.672482Z","steps":["trace[1689302562] 'agreement among raft nodes before linearized reading' (duration: 422.981293ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.672535Z","caller":"traceutil/trace.go:171","msg":"trace[200038617] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8189; }","duration":"386.217435ms","start":"2026-03-31T22:34:53.286297Z","end":"2026-03-31T22:34:53.672515Z","steps":["trace[200038617] 'agreement among raft nodes before linearized reading' (duration: 386.04085ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.672583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.248291Z","time spent":"424.250328ms","remote":"127.0.0.1:46822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "} {"level":"warn","ts":"2026-03-31T22:34:53.672584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.85266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.672618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.811006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.672576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.671573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.67267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.954789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:53.672681Z","caller":"traceutil/trace.go:171","msg":"trace[267209350] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8189; }","duration":"402.987924ms","start":"2026-03-31T22:34:53.269663Z","end":"2026-03-31T22:34:53.672651Z","steps":["trace[267209350] 'agreement among raft nodes before linearized reading' (duration: 402.796108ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.672703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.171553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.672587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.888247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.672746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.243035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:53.672755Z","caller":"traceutil/trace.go:171","msg":"trace[1557225014] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8189; }","duration":"365.108503ms","start":"2026-03-31T22:34:53.307637Z","end":"2026-03-31T22:34:53.672746Z","steps":["trace[1557225014] 'agreement among raft nodes before linearized reading' (duration: 364.847876ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.672751Z","caller":"traceutil/trace.go:171","msg":"trace[1458794609] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8189; }","duration":"403.881898ms","start":"2026-03-31T22:34:53.268825Z","end":"2026-03-31T22:34:53.672707Z","steps":["trace[1458794609] 'agreement among raft nodes before linearized reading' (duration: 403.562279ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.672763Z","caller":"traceutil/trace.go:171","msg":"trace[1680633157] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8189; }","duration":"386.275666ms","start":"2026-03-31T22:34:53.286467Z","end":"2026-03-31T22:34:53.672743Z","steps":["trace[1680633157] 'agreement among raft nodes before linearized reading' (duration: 386.187214ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.672767Z","caller":"traceutil/trace.go:171","msg":"trace[1138091340] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8189; }","duration":"365.050332ms","start":"2026-03-31T22:34:53.30769Z","end":"2026-03-31T22:34:53.67274Z","steps":["trace[1138091340] 'agreement among raft nodes before linearized reading' (duration: 364.946999ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.672801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.307621Z","time spent":"365.168155ms","remote":"127.0.0.1:46864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 "} {"level":"info","ts":"2026-03-31T22:34:53.672801Z","caller":"traceutil/trace.go:171","msg":"trace[302242468] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8189; }","duration":"386.318337ms","start":"2026-03-31T22:34:53.286463Z","end":"2026-03-31T22:34:53.672781Z","steps":["trace[302242468] 'agreement among raft nodes before linearized reading' (duration: 386.253415ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.67282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.286445Z","time spent":"386.362098ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T22:34:53.67284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.286443Z","time spent":"386.388269ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 "} {"level":"warn","ts":"2026-03-31T22:34:53.672831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.268821Z","time spent":"403.996221ms","remote":"127.0.0.1:46832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":26,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T22:34:53.672606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.286273Z","time spent":"386.311637ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true "} {"level":"warn","ts":"2026-03-31T22:34:53.672851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.897308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.67286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.354434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:53.672902Z","caller":"traceutil/trace.go:171","msg":"trace[669815010] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8189; }","duration":"275.967049ms","start":"2026-03-31T22:34:53.396919Z","end":"2026-03-31T22:34:53.672886Z","steps":["trace[669815010] 'agreement among raft nodes before linearized reading' (duration: 275.885547ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.672669Z","caller":"traceutil/trace.go:171","msg":"trace[315832556] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8189; }","duration":"403.881118ms","start":"2026-03-31T22:34:53.268774Z","end":"2026-03-31T22:34:53.672655Z","steps":["trace[315832556] 'agreement among raft nodes before linearized reading' (duration: 403.796955ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.672831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.307684Z","time spent":"365.132134ms","remote":"127.0.0.1:46864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true "} {"level":"warn","ts":"2026-03-31T22:34:53.672995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.268765Z","time spent":"404.219018ms","remote":"127.0.0.1:46832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":26,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true "} {"level":"warn","ts":"2026-03-31T22:34:53.673023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.02869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.673059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.982342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.672756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.269643Z","time spent":"403.091246ms","remote":"127.0.0.1:46832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":26,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:500 "} {"level":"warn","ts":"2026-03-31T22:34:53.672149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.329217Z","time spent":"342.912743ms","remote":"127.0.0.1:46880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 "} {"level":"info","ts":"2026-03-31T22:34:53.673092Z","caller":"traceutil/trace.go:171","msg":"trace[1190711043] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8189; }","duration":"325.031513ms","start":"2026-03-31T22:34:53.348052Z","end":"2026-03-31T22:34:53.673083Z","steps":["trace[1190711043] 'agreement among raft nodes before linearized reading' (duration: 324.979361ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.673096Z","caller":"traceutil/trace.go:171","msg":"trace[1521129727] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8189; }","duration":"277.138503ms","start":"2026-03-31T22:34:53.39594Z","end":"2026-03-31T22:34:53.673079Z","steps":["trace[1521129727] 'agreement among raft nodes before linearized reading' (duration: 277.033721ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.672935Z","caller":"traceutil/trace.go:171","msg":"trace[1486728309] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8189; }","duration":"324.429066ms","start":"2026-03-31T22:34:53.348487Z","end":"2026-03-31T22:34:53.672916Z","steps":["trace[1486728309] 'agreement among raft nodes before linearized reading' (duration: 324.322573ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.672966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.797585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.673219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.348452Z","time spent":"324.746315ms","remote":"127.0.0.1:46882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:500 "} {"level":"info","ts":"2026-03-31T22:34:53.67326Z","caller":"traceutil/trace.go:171","msg":"trace[659088122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8189; }","duration":"264.317674ms","start":"2026-03-31T22:34:53.408918Z","end":"2026-03-31T22:34:53.673236Z","steps":["trace[659088122] 'agreement among raft nodes before linearized reading' (duration: 263.397468ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.673354Z","caller":"traceutil/trace.go:171","msg":"trace[426709255] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8189; }","duration":"424.214087ms","start":"2026-03-31T22:34:53.249037Z","end":"2026-03-31T22:34:53.673252Z","steps":["trace[426709255] 'agreement among raft nodes before linearized reading' (duration: 423.530408ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.673757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.249034Z","time spent":"424.69736ms","remote":"127.0.0.1:46822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 "} {"level":"warn","ts":"2026-03-31T22:34:53.673119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.348046Z","time spent":"325.066223ms","remote":"127.0.0.1:46882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:10000 "} {"level":"warn","ts":"2026-03-31T22:34:53.671601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.382311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"warn","ts":"2026-03-31T22:34:53.673503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.551345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.67316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.124586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.673534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.801162ms","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:5"} {"level":"warn","ts":"2026-03-31T22:34:53.673538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.824513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.673556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.915161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-31T22:34:53.673581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.844833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-31T22:34:53.674649Z","caller":"traceutil/trace.go:171","msg":"trace[1377177698] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8189; }","duration":"302.939584ms","start":"2026-03-31T22:34:53.371683Z","end":"2026-03-31T22:34:53.674623Z","steps":["trace[1377177698] 'agreement among raft nodes before linearized reading' (duration: 301.875234ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.67475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.371659Z","time spent":"303.062358ms","remote":"127.0.0.1:46892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:10000 "} {"level":"info","ts":"2026-03-31T22:34:53.674887Z","caller":"traceutil/trace.go:171","msg":"trace[1192593646] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8189; }","duration":"278.973585ms","start":"2026-03-31T22:34:53.395898Z","end":"2026-03-31T22:34:53.674871Z","steps":["trace[1192593646] 'agreement among raft nodes before linearized reading' (duration: 277.554225ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.674982Z","caller":"traceutil/trace.go:171","msg":"trace[1056026903] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8189; }","duration":"303.227783ms","start":"2026-03-31T22:34:53.371701Z","end":"2026-03-31T22:34:53.674929Z","steps":["trace[1056026903] 'agreement among raft nodes before linearized reading' (duration: 301.799672ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.675031Z","caller":"traceutil/trace.go:171","msg":"trace[2063988402] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8189; }","duration":"326.955857ms","start":"2026-03-31T22:34:53.347997Z","end":"2026-03-31T22:34:53.674953Z","steps":["trace[2063988402] 'agreement among raft nodes before linearized reading' (duration: 325.135896ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.675137Z","caller":"traceutil/trace.go:171","msg":"trace[2132945849] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8189; }","duration":"161.963371ms","start":"2026-03-31T22:34:53.513161Z","end":"2026-03-31T22:34:53.675124Z","steps":["trace[2132945849] 'agreement among raft nodes before linearized reading' (duration: 158.244677ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.675155Z","caller":"traceutil/trace.go:171","msg":"trace[121088524] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8189; }","duration":"303.458288ms","start":"2026-03-31T22:34:53.371681Z","end":"2026-03-31T22:34:53.67514Z","steps":["trace[121088524] 'agreement among raft nodes before linearized reading' (duration: 301.816482ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.675158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.34798Z","time spent":"327.133642ms","remote":"127.0.0.1:46882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true "} {"level":"warn","ts":"2026-03-31T22:34:53.675167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.371691Z","time spent":"303.413527ms","remote":"127.0.0.1:46892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true "} {"level":"warn","ts":"2026-03-31T22:34:53.675194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.371671Z","time spent":"303.510451ms","remote":"127.0.0.1:46892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":26,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:500 "} {"level":"info","ts":"2026-03-31T22:34:53.675308Z","caller":"traceutil/trace.go:171","msg":"trace[1276806273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8189; }","duration":"305.692712ms","start":"2026-03-31T22:34:53.369596Z","end":"2026-03-31T22:34:53.675289Z","steps":["trace[1276806273] 'agreement among raft nodes before linearized reading' (duration: 303.900841ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:34:53.675378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:34:53.369577Z","time spent":"305.781474ms","remote":"127.0.0.1:33268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-31T22:34:53.802352Z","caller":"traceutil/trace.go:171","msg":"trace[1014041831] transaction","detail":"{read_only:false; response_revision:8192; number_of_response:1; }","duration":"122.807674ms","start":"2026-03-31T22:34:53.679518Z","end":"2026-03-31T22:34:53.802326Z","steps":["trace[1014041831] 'process raft request' (duration: 122.744112ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:34:53.802388Z","caller":"traceutil/trace.go:171","msg":"trace[1453374871] transaction","detail":"{read_only:false; response_revision:8191; number_of_response:1; }","duration":"123.571817ms","start":"2026-03-31T22:34:53.678776Z","end":"2026-03-31T22:34:53.802348Z","steps":["trace[1453374871] 'process raft request' (duration: 60.108072ms)","trace[1453374871] 'compare' (duration: 63.228748ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:35:34.442623Z","caller":"traceutil/trace.go:171","msg":"trace[131903938] linearizableReadLoop","detail":"{readStateIndex:8809; appliedIndex:8808; }","duration":"102.623289ms","start":"2026-03-31T22:35:34.339973Z","end":"2026-03-31T22:35:34.442596Z","steps":["trace[131903938] 'read index received' (duration: 68.793043ms)","trace[131903938] 'applied index is now lower than readState.Index' (duration: 33.829126ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:35:34.442655Z","caller":"traceutil/trace.go:171","msg":"trace[723886715] transaction","detail":"{read_only:false; response_revision:8505; number_of_response:1; }","duration":"103.730901ms","start":"2026-03-31T22:35:34.338885Z","end":"2026-03-31T22:35:34.442616Z","steps":["trace[723886715] 'process raft request' (duration: 69.936245ms)","trace[723886715] 'compare' (duration: 33.404204ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:35:34.44294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.933028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-jsmsz\" ","response":"range_response_count:1 size:2803"} {"level":"info","ts":"2026-03-31T22:35:34.443041Z","caller":"traceutil/trace.go:171","msg":"trace[1603807814] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-jsmsz; range_end:; response_count:1; response_revision:8505; }","duration":"103.073182ms","start":"2026-03-31T22:35:34.339941Z","end":"2026-03-31T22:35:34.443015Z","steps":["trace[1603807814] 'agreement among raft nodes before linearized reading' (duration: 102.766973ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:35:35.010494Z","caller":"traceutil/trace.go:171","msg":"trace[1087824572] transaction","detail":"{read_only:false; response_revision:8507; number_of_response:1; }","duration":"103.085602ms","start":"2026-03-31T22:35:34.907371Z","end":"2026-03-31T22:35:35.010457Z","steps":["trace[1087824572] 'process raft request' (duration: 102.885506ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:35:35.346906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.693867ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:38"} {"level":"info","ts":"2026-03-31T22:35:35.347039Z","caller":"traceutil/trace.go:171","msg":"trace[2132700170] linearizableReadLoop","detail":"{readStateIndex:8813; appliedIndex:8812; }","duration":"250.305747ms","start":"2026-03-31T22:35:35.09671Z","end":"2026-03-31T22:35:35.347016Z","steps":["trace[2132700170] 'read index received' (duration: 144.503397ms)","trace[2132700170] 'applied index is now lower than readState.Index' (duration: 105.80039ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:35:35.347176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:35:35.011478Z","time spent":"335.678898ms","remote":"127.0.0.1:33298","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-31T22:35:35.347486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.765341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-k7lmn\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-03-31T22:35:35.347546Z","caller":"traceutil/trace.go:171","msg":"trace[1427839688] range","detail":"{range_begin:/registry/pods/openstack/keepalived-k7lmn; range_end:; response_count:1; response_revision:8508; }","duration":"250.865214ms","start":"2026-03-31T22:35:35.096665Z","end":"2026-03-31T22:35:35.34753Z","steps":["trace[1427839688] 'agreement among raft nodes before linearized reading' (duration: 250.448751ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:35:35.372893Z","caller":"traceutil/trace.go:171","msg":"trace[1762396805] transaction","detail":"{read_only:false; response_revision:8510; number_of_response:1; }","duration":"239.916868ms","start":"2026-03-31T22:35:35.132952Z","end":"2026-03-31T22:35:35.372869Z","steps":["trace[1762396805] 'process raft request' (duration: 239.811625ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:35:35.372979Z","caller":"traceutil/trace.go:171","msg":"trace[1542132931] transaction","detail":"{read_only:false; response_revision:8509; number_of_response:1; }","duration":"249.155423ms","start":"2026-03-31T22:35:35.123796Z","end":"2026-03-31T22:35:35.372952Z","steps":["trace[1542132931] 'process raft request' (duration: 248.791173ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:35:35.373359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.957244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-03-31T22:35:35.373554Z","caller":"traceutil/trace.go:171","msg":"trace[1624531998] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8510; }","duration":"193.099748ms","start":"2026-03-31T22:35:35.180321Z","end":"2026-03-31T22:35:35.37342Z","steps":["trace[1624531998] 'agreement among raft nodes before linearized reading' (duration: 192.700486ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:35:35.373664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.736819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-jsmsz\" ","response":"range_response_count:1 size:4653"} {"level":"info","ts":"2026-03-31T22:35:35.373794Z","caller":"traceutil/trace.go:171","msg":"trace[471028818] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-jsmsz; range_end:; response_count:1; response_revision:8510; }","duration":"250.906535ms","start":"2026-03-31T22:35:35.12287Z","end":"2026-03-31T22:35:35.373777Z","steps":["trace[471028818] 'agreement among raft nodes before linearized reading' (duration: 250.175864ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:35:36.274772Z","caller":"traceutil/trace.go:171","msg":"trace[1913625603] linearizableReadLoop","detail":"{readStateIndex:8820; appliedIndex:8819; }","duration":"263.699444ms","start":"2026-03-31T22:35:36.011049Z","end":"2026-03-31T22:35:36.274748Z","steps":["trace[1913625603] 'read index received' (duration: 194.839699ms)","trace[1913625603] 'applied index is now lower than readState.Index' (duration: 68.858225ms)"],"step_count":2} {"level":"info","ts":"2026-03-31T22:35:36.274836Z","caller":"traceutil/trace.go:171","msg":"trace[1519072308] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"362.554074ms","start":"2026-03-31T22:35:35.912252Z","end":"2026-03-31T22:35:36.274806Z","steps":["trace[1519072308] 'process raft request' (duration: 293.580875ms)","trace[1519072308] 'compare' (duration: 68.751332ms)"],"step_count":2} {"level":"warn","ts":"2026-03-31T22:35:36.274954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T22:35:35.912224Z","time spent":"362.666087ms","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-31T22:35:36.275034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.968141ms","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-03-31T22:35:36.275113Z","caller":"traceutil/trace.go:171","msg":"trace[632631639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8516; }","duration":"264.089085ms","start":"2026-03-31T22:35:36.011005Z","end":"2026-03-31T22:35:36.275095Z","steps":["trace[632631639] 'agreement among raft nodes before linearized reading' (duration: 263.878179ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:35:36.275514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.42643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-03-31T22:35:36.275563Z","caller":"traceutil/trace.go:171","msg":"trace[1077955612] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8516; }","duration":"259.497532ms","start":"2026-03-31T22:35:36.016054Z","end":"2026-03-31T22:35:36.275552Z","steps":["trace[1077955612] 'agreement among raft nodes before linearized reading' (duration: 259.343368ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:35:36.275574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.049628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T22:35:36.275607Z","caller":"traceutil/trace.go:171","msg":"trace[1161261270] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:8516; }","duration":"234.12097ms","start":"2026-03-31T22:35:36.041477Z","end":"2026-03-31T22:35:36.275598Z","steps":["trace[1161261270] 'agreement among raft nodes before linearized reading' (duration: 234.041238ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:35:36.275609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.308487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-31T22:35:36.275852Z","caller":"traceutil/trace.go:171","msg":"trace[1788414996] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:8516; }","duration":"241.583555ms","start":"2026-03-31T22:35:36.034253Z","end":"2026-03-31T22:35:36.275837Z","steps":["trace[1788414996] 'agreement among raft nodes before linearized reading' (duration: 241.310687ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:35:36.275863Z","caller":"traceutil/trace.go:171","msg":"trace[762221194] transaction","detail":"{read_only:false; response_revision:8516; number_of_response:1; }","duration":"258.128032ms","start":"2026-03-31T22:35:36.017719Z","end":"2026-03-31T22:35:36.275847Z","steps":["trace[762221194] 'process raft request' (duration: 256.9917ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:35:36.275519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.889144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-03-31T22:35:36.276002Z","caller":"traceutil/trace.go:171","msg":"trace[733341393] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8516; }","duration":"225.402128ms","start":"2026-03-31T22:35:36.050586Z","end":"2026-03-31T22:35:36.275988Z","steps":["trace[733341393] 'agreement among raft nodes before linearized reading' (duration: 224.820092ms)"],"step_count":1} {"level":"warn","ts":"2026-03-31T22:35:36.275778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.360068ms","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-03-31T22:35:36.276071Z","caller":"traceutil/trace.go:171","msg":"trace[482436693] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8516; }","duration":"165.686707ms","start":"2026-03-31T22:35:36.110352Z","end":"2026-03-31T22:35:36.276039Z","steps":["trace[482436693] 'agreement among raft nodes before linearized reading' (duration: 165.163902ms)"],"step_count":1} {"level":"info","ts":"2026-03-31T22:36:23.089547Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002470.wal"} {"level":"info","ts":"2026-03-31T22:37:41.473454Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-31T22:37:41.478946Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-31T22:37:41.479094Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-31T22:39:41.573749Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8129} {"level":"info","ts":"2026-03-31T22:39:41.658855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8129,"took":"81.470805ms","hash":1057304194,"current-db-size-bytes":57290752,"current-db-size":"57 MB","current-db-size-in-use-bytes":24834048,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-03-31T22:39:41.658934Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1057304194,"revision":8129,"compact-revision":5904} {"level":"info","ts":"2026-03-31T22:44:41.58025Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10557} {"level":"info","ts":"2026-03-31T22:44:41.659991Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10557,"took":"77.206764ms","hash":1353028307,"current-db-size-bytes":57290752,"current-db-size":"57 MB","current-db-size-in-use-bytes":20135936,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-03-31T22:44:41.660103Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1353028307,"revision":10557,"compact-revision":8129}