{"level":"warn","ts":"2026-04-07T01:24:44.242885Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T01:24:44.242966Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.110:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.110:2380","--initial-cluster=instance=https://162.253.55.110:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.110:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.110:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-07T01:24:44.24303Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T01:24:44.243039Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-04-07T01:24:44.243058Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T01:24:44.243696Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"]} {"level":"info","ts":"2026-04-07T01:24:44.243774Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.110:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-07T01:24:44.248142Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.182529ms"} {"level":"info","ts":"2026-04-07T01:24:44.255362Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f52f30d5714009d5","cluster-id":"650981a7a383c714"} {"level":"info","ts":"2026-04-07T01:24:44.255442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:24:44.255466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 0"} {"level":"info","ts":"2026-04-07T01:24:44.255488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f52f30d5714009d5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:24:44.255513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 1"} {"level":"info","ts":"2026-04-07T01:24:44.255642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"warn","ts":"2026-04-07T01:24:44.261206Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:24:44.26287Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:24:44.264233Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-07T01:24:44.266265Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f52f30d5714009d5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:24:44.266495Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f52f30d5714009d5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:24:44.26653Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T01:24:44.266665Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T01:24:44.266686Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T01:24:44.268627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"info","ts":"2026-04-07T01:24:44.269514Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","added-peer-id":"f52f30d5714009d5","added-peer-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-04-07T01:24:44.271203Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T01:24:44.271315Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-04-07T01:24:44.271391Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-04-07T01:24:44.271523Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f52f30d5714009d5","initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:24:44.271572Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:24:44.956053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:24:44.956123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:24:44.956172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgPreVoteResp from f52f30d5714009d5 at term 1"} {"level":"info","ts":"2026-04-07T01:24:44.956213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:24:44.956228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgVoteResp from f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-04-07T01:24:44.956248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became leader at term 2"} {"level":"info","ts":"2026-04-07T01:24:44.956262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f52f30d5714009d5 elected leader f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-04-07T01:24:44.957532Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:44.958774Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:24:44.958783Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f52f30d5714009d5","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.110:2379]}","request-path":"/0/members/f52f30d5714009d5/attributes","cluster-id":"650981a7a383c714","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:24:44.95884Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:24:44.959092Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:44.95927Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:44.95931Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:44.959306Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:24:44.959421Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:24:44.960453Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.110:2379"} {"level":"info","ts":"2026-04-07T01:24:44.962162Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T01:25:16.610984Z","caller":"traceutil/trace.go:171","msg":"trace[2125949970] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"121.265328ms","start":"2026-04-07T01:25:16.489683Z","end":"2026-04-07T01:25:16.610948Z","steps":["trace[2125949970] 'process raft request' (duration: 115.312364ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:22.623718Z","caller":"traceutil/trace.go:171","msg":"trace[102871050] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"154.240736ms","start":"2026-04-07T01:25:22.469456Z","end":"2026-04-07T01:25:22.623697Z","steps":["trace[102871050] 'process raft request' (duration: 153.756148ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:22.778621Z","caller":"traceutil/trace.go:171","msg":"trace[2063015448] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"100.883515ms","start":"2026-04-07T01:25:22.677701Z","end":"2026-04-07T01:25:22.778584Z","steps":["trace[2063015448] 'process raft request' (duration: 100.713061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:23.544884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.882486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:25:23.54501Z","caller":"traceutil/trace.go:171","msg":"trace[83902205] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"650.144331ms","start":"2026-04-07T01:25:22.894842Z","end":"2026-04-07T01:25:23.544987Z","steps":["trace[83902205] 'range keys from in-memory index tree' (duration: 649.793495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:23.54506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:22.894818Z","time spent":"650.231363ms","remote":"127.0.0.1:51692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:25:23.545076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.457304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gbgzk\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-07T01:25:23.545275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.290159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T01:25:23.545426Z","caller":"traceutil/trace.go:171","msg":"trace[2124766917] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"416.523423ms","start":"2026-04-07T01:25:23.128877Z","end":"2026-04-07T01:25:23.545401Z","steps":["trace[2124766917] 'range keys from in-memory index tree' (duration: 415.912882ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:25:23.545375Z","caller":"traceutil/trace.go:171","msg":"trace[1091767526] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gbgzk; range_end:; response_count:1; response_revision:623; }","duration":"357.702098ms","start":"2026-04-07T01:25:23.187517Z","end":"2026-04-07T01:25:23.545219Z","steps":["trace[1091767526] 'range keys from in-memory index tree' (duration: 357.178879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:23.545569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:23.1875Z","time spent":"358.054725ms","remote":"127.0.0.1:51864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-gbgzk\" "} {"level":"warn","ts":"2026-04-07T01:25:23.545497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:23.128844Z","time spent":"416.642135ms","remote":"127.0.0.1:51946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T01:25:23.60946Z","caller":"traceutil/trace.go:171","msg":"trace[1469367352] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"409.000882ms","start":"2026-04-07T01:25:23.200435Z","end":"2026-04-07T01:25:23.609435Z","steps":["trace[1469367352] 'process raft request' (duration: 408.238218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:25:23.610999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:25:23.200363Z","time spent":"409.180145ms","remote":"127.0.0.1:51790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:26:11.189266Z","caller":"traceutil/trace.go:171","msg":"trace[974868032] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"185.542344ms","start":"2026-04-07T01:26:11.003694Z","end":"2026-04-07T01:26:11.189236Z","steps":["trace[974868032] 'process raft request' (duration: 185.3345ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:11.200608Z","caller":"traceutil/trace.go:171","msg":"trace[165027821] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"193.458254ms","start":"2026-04-07T01:26:11.007114Z","end":"2026-04-07T01:26:11.200572Z","steps":["trace[165027821] 'process raft request' (duration: 193.393072ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:11.200648Z","caller":"traceutil/trace.go:171","msg":"trace[199466468] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"196.707835ms","start":"2026-04-07T01:26:11.003915Z","end":"2026-04-07T01:26:11.200622Z","steps":["trace[199466468] 'process raft request' (duration: 196.443179ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:52.315108Z","caller":"traceutil/trace.go:171","msg":"trace[484243850] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"253.146379ms","start":"2026-04-07T01:26:52.061935Z","end":"2026-04-07T01:26:52.315081Z","steps":["trace[484243850] 'process raft request' (duration: 252.993126ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:52.31515Z","caller":"traceutil/trace.go:171","msg":"trace[1109104149] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1913; }","duration":"163.93769ms","start":"2026-04-07T01:26:52.151178Z","end":"2026-04-07T01:26:52.315115Z","steps":["trace[1109104149] 'read index received' (duration: 163.92569ms)","trace[1109104149] 'applied index is now lower than readState.Index' (duration: 9.87µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:52.315388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.163444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-07T01:26:52.315437Z","caller":"traceutil/trace.go:171","msg":"trace[267316206] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1842; }","duration":"164.305577ms","start":"2026-04-07T01:26:52.15112Z","end":"2026-04-07T01:26:52.315426Z","steps":["trace[267316206] 'agreement among raft nodes before linearized reading' (duration: 164.089523ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:52.384333Z","caller":"traceutil/trace.go:171","msg":"trace[2031333725] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"155.929652ms","start":"2026-04-07T01:26:52.228379Z","end":"2026-04-07T01:26:52.384308Z","steps":["trace[2031333725] 'process raft request' (duration: 155.81641ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:59.882897Z","caller":"traceutil/trace.go:171","msg":"trace[179226100] transaction","detail":"{read_only:false; response_revision:2633; number_of_response:1; }","duration":"141.926752ms","start":"2026-04-07T01:28:59.740931Z","end":"2026-04-07T01:28:59.882858Z","steps":["trace[179226100] 'process raft request' (duration: 141.646477ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.223181Z","caller":"traceutil/trace.go:171","msg":"trace[1995103129] transaction","detail":"{read_only:false; response_revision:2636; number_of_response:1; }","duration":"115.728476ms","start":"2026-04-07T01:29:00.107425Z","end":"2026-04-07T01:29:00.223154Z","steps":["trace[1995103129] 'process raft request' (duration: 115.514402ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.261445Z","caller":"traceutil/trace.go:171","msg":"trace[1359961126] linearizableReadLoop","detail":"{readStateIndex:2738; appliedIndex:2734; }","duration":"115.216768ms","start":"2026-04-07T01:29:00.146192Z","end":"2026-04-07T01:29:00.261409Z","steps":["trace[1359961126] 'read index received' (duration: 76.792805ms)","trace[1359961126] 'applied index is now lower than readState.Index' (duration: 38.422403ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:29:00.261835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.613054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"info","ts":"2026-04-07T01:29:00.261904Z","caller":"traceutil/trace.go:171","msg":"trace[1537900737] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2639; }","duration":"115.753497ms","start":"2026-04-07T01:29:00.146133Z","end":"2026-04-07T01:29:00.261886Z","steps":["trace[1537900737] 'agreement among raft nodes before linearized reading' (duration: 115.434262ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.262102Z","caller":"traceutil/trace.go:171","msg":"trace[1782211393] transaction","detail":"{read_only:false; response_revision:2639; number_of_response:1; }","duration":"151.410588ms","start":"2026-04-07T01:29:00.110469Z","end":"2026-04-07T01:29:00.26188Z","steps":["trace[1782211393] 'process raft request' (duration: 150.893569ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.26186Z","caller":"traceutil/trace.go:171","msg":"trace[1039209142] transaction","detail":"{read_only:false; response_revision:2637; number_of_response:1; }","duration":"152.575199ms","start":"2026-04-07T01:29:00.109247Z","end":"2026-04-07T01:29:00.261822Z","steps":["trace[1039209142] 'process raft request' (duration: 151.872547ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.261917Z","caller":"traceutil/trace.go:171","msg":"trace[1049444337] transaction","detail":"{read_only:false; response_revision:2638; number_of_response:1; }","duration":"151.420418ms","start":"2026-04-07T01:29:00.110433Z","end":"2026-04-07T01:29:00.261853Z","steps":["trace[1049444337] 'process raft request' (duration: 150.880198ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:47.426405Z","caller":"traceutil/trace.go:171","msg":"trace[2125795323] transaction","detail":"{read_only:false; response_revision:4593; number_of_response:1; }","duration":"144.991332ms","start":"2026-04-07T01:32:47.281388Z","end":"2026-04-07T01:32:47.426379Z","steps":["trace[2125795323] 'process raft request' (duration: 138.48006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:32:51.157602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.516795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:32:51.157705Z","caller":"traceutil/trace.go:171","msg":"trace[1189850576] range","detail":"{range_begin:/registry/clusterroles/vector; range_end:; response_count:0; response_revision:4752; }","duration":"143.662888ms","start":"2026-04-07T01:32:51.014021Z","end":"2026-04-07T01:32:51.157684Z","steps":["trace[1189850576] 'range keys from in-memory index tree' (duration: 143.420132ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.336993Z","caller":"traceutil/trace.go:171","msg":"trace[1441261199] linearizableReadLoop","detail":"{readStateIndex:4933; appliedIndex:4932; }","duration":"111.189119ms","start":"2026-04-07T01:32:51.22578Z","end":"2026-04-07T01:32:51.336969Z","steps":["trace[1441261199] 'read index received' (duration: 81.452443ms)","trace[1441261199] 'applied index is now lower than readState.Index' (duration: 29.735996ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:32:51.337004Z","caller":"traceutil/trace.go:171","msg":"trace[1464313855] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4753; }","duration":"145.504301ms","start":"2026-04-07T01:32:51.191468Z","end":"2026-04-07T01:32:51.336972Z","steps":["trace[1464313855] 'process raft request' (duration: 115.765535ms)","trace[1464313855] 'compare' (duration: 29.696886ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:32:51.337211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.404523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-09735edf-ad59-42cf-9c44-5627b2d6e4f6\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-07T01:32:51.337287Z","caller":"traceutil/trace.go:171","msg":"trace[740383380] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-09735edf-ad59-42cf-9c44-5627b2d6e4f6; range_end:; response_count:1; response_revision:4753; }","duration":"111.503755ms","start":"2026-04-07T01:32:51.225764Z","end":"2026-04-07T01:32:51.337268Z","steps":["trace[740383380] 'agreement among raft nodes before linearized reading' (duration: 111.283721ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.700095Z","caller":"traceutil/trace.go:171","msg":"trace[1639316044] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"162.390907ms","start":"2026-04-07T01:32:51.537661Z","end":"2026-04-07T01:32:51.700052Z","steps":["trace[1639316044] 'process raft request' (duration: 83.773627ms)","trace[1639316044] 'compare' (duration: 78.297744ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:32:51.700595Z","caller":"traceutil/trace.go:171","msg":"trace[1775474750] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"162.888937ms","start":"2026-04-07T01:32:51.537671Z","end":"2026-04-07T01:32:51.70056Z","steps":["trace[1775474750] 'process raft request' (duration: 162.314876ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.700735Z","caller":"traceutil/trace.go:171","msg":"trace[2117909878] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"162.976709ms","start":"2026-04-07T01:32:51.537731Z","end":"2026-04-07T01:32:51.700708Z","steps":["trace[2117909878] 'process raft request' (duration: 162.522761ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.700749Z","caller":"traceutil/trace.go:171","msg":"trace[1995155440] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"162.953368ms","start":"2026-04-07T01:32:51.537769Z","end":"2026-04-07T01:32:51.700722Z","steps":["trace[1995155440] 'process raft request' (duration: 162.825946ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.70074Z","caller":"traceutil/trace.go:171","msg":"trace[757496607] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"147.753764ms","start":"2026-04-07T01:32:51.552951Z","end":"2026-04-07T01:32:51.700705Z","steps":["trace[757496607] 'process raft request' (duration: 147.703113ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.879663Z","caller":"traceutil/trace.go:171","msg":"trace[763351667] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"124.522609ms","start":"2026-04-07T01:32:51.75511Z","end":"2026-04-07T01:32:51.879632Z","steps":["trace[763351667] 'process raft request' (duration: 124.453448ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.879692Z","caller":"traceutil/trace.go:171","msg":"trace[1179846172] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"125.011189ms","start":"2026-04-07T01:32:51.754657Z","end":"2026-04-07T01:32:51.879668Z","steps":["trace[1179846172] 'process raft request' (duration: 124.751354ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:52.023523Z","caller":"traceutil/trace.go:171","msg":"trace[1354033347] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"138.345496ms","start":"2026-04-07T01:32:51.885151Z","end":"2026-04-07T01:32:52.023497Z","steps":["trace[1354033347] 'process raft request' (duration: 61.51271ms)","trace[1354033347] 'compare' (duration: 76.50303ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:32:52.023515Z","caller":"traceutil/trace.go:171","msg":"trace[1709150612] linearizableReadLoop","detail":"{readStateIndex:4948; appliedIndex:4947; }","duration":"130.179665ms","start":"2026-04-07T01:32:51.893308Z","end":"2026-04-07T01:32:52.023488Z","steps":["trace[1709150612] 'read index received' (duration: 53.42609ms)","trace[1709150612] 'applied index is now lower than readState.Index' (duration: 76.751735ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:32:52.023684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.352179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:32:52.02374Z","caller":"traceutil/trace.go:171","msg":"trace[1045179277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4768; }","duration":"130.456761ms","start":"2026-04-07T01:32:51.893266Z","end":"2026-04-07T01:32:52.023723Z","steps":["trace[1045179277] 'agreement among raft nodes before linearized reading' (duration: 130.326608ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:52.031251Z","caller":"traceutil/trace.go:171","msg":"trace[178058275] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"133.699792ms","start":"2026-04-07T01:32:51.897539Z","end":"2026-04-07T01:32:52.031239Z","steps":["trace[178058275] 'process raft request' (duration: 133.508178ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:58.82637Z","caller":"traceutil/trace.go:171","msg":"trace[1674303957] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"108.955625ms","start":"2026-04-07T01:32:58.717381Z","end":"2026-04-07T01:32:58.826337Z","steps":["trace[1674303957] 'process raft request' (duration: 74.319268ms)","trace[1674303957] 'compare' (duration: 34.27872ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:32:59.010029Z","caller":"traceutil/trace.go:171","msg":"trace[2103674850] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"170.787419ms","start":"2026-04-07T01:32:58.839214Z","end":"2026-04-07T01:32:59.010002Z","steps":["trace[2103674850] 'process raft request' (duration: 93.002438ms)","trace[2103674850] 'compare' (duration: 77.594418ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:32:59.010246Z","caller":"traceutil/trace.go:171","msg":"trace[476098590] linearizableReadLoop","detail":"{readStateIndex:5098; appliedIndex:5096; }","duration":"116.685398ms","start":"2026-04-07T01:32:58.893546Z","end":"2026-04-07T01:32:59.010231Z","steps":["trace[476098590] 'read index received' (duration: 38.757104ms)","trace[476098590] 'applied index is now lower than readState.Index' (duration: 77.927324ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:32:59.010348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.794531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:32:59.010384Z","caller":"traceutil/trace.go:171","msg":"trace[147310381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4913; }","duration":"116.870213ms","start":"2026-04-07T01:32:58.893506Z","end":"2026-04-07T01:32:59.010376Z","steps":["trace[147310381] 'agreement among raft nodes before linearized reading' (duration: 116.785361ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:59.010413Z","caller":"traceutil/trace.go:171","msg":"trace[1656066548] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"117.471233ms","start":"2026-04-07T01:32:58.89293Z","end":"2026-04-07T01:32:59.010402Z","steps":["trace[1656066548] 'process raft request' (duration: 117.038265ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:59.222912Z","caller":"traceutil/trace.go:171","msg":"trace[999515009] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"203.903647ms","start":"2026-04-07T01:32:59.018983Z","end":"2026-04-07T01:32:59.222887Z","steps":["trace[999515009] 'process raft request' (duration: 203.772964ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:59.222968Z","caller":"traceutil/trace.go:171","msg":"trace[782030167] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"205.795652ms","start":"2026-04-07T01:32:59.017122Z","end":"2026-04-07T01:32:59.222917Z","steps":["trace[782030167] 'process raft request' (duration: 182.252993ms)","trace[782030167] 'compare' (duration: 23.217133ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:02.562966Z","caller":"traceutil/trace.go:171","msg":"trace[1508154978] transaction","detail":"{read_only:false; response_revision:4983; number_of_response:1; }","duration":"122.767972ms","start":"2026-04-07T01:33:02.44016Z","end":"2026-04-07T01:33:02.562928Z","steps":["trace[1508154978] 'process raft request' (duration: 88.378049ms)","trace[1508154978] 'compare' (duration: 34.24885ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:02.566908Z","caller":"traceutil/trace.go:171","msg":"trace[332171146] transaction","detail":"{read_only:false; response_revision:4987; number_of_response:1; }","duration":"103.944941ms","start":"2026-04-07T01:33:02.46294Z","end":"2026-04-07T01:33:02.566885Z","steps":["trace[332171146] 'process raft request' (duration: 103.907401ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:02.566931Z","caller":"traceutil/trace.go:171","msg":"trace[1462664449] transaction","detail":"{read_only:false; response_revision:4984; number_of_response:1; }","duration":"104.370389ms","start":"2026-04-07T01:33:02.462524Z","end":"2026-04-07T01:33:02.566894Z","steps":["trace[1462664449] 'process raft request' (duration: 104.117535ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:02.566994Z","caller":"traceutil/trace.go:171","msg":"trace[1803778359] transaction","detail":"{read_only:false; response_revision:4985; number_of_response:1; }","duration":"104.444481ms","start":"2026-04-07T01:33:02.462524Z","end":"2026-04-07T01:33:02.566969Z","steps":["trace[1803778359] 'process raft request' (duration: 104.232527ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:02.567135Z","caller":"traceutil/trace.go:171","msg":"trace[1173346888] transaction","detail":"{read_only:false; response_revision:4986; number_of_response:1; }","duration":"104.492731ms","start":"2026-04-07T01:33:02.462618Z","end":"2026-04-07T01:33:02.567111Z","steps":["trace[1173346888] 'process raft request' (duration: 104.193096ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:23.432531Z","caller":"traceutil/trace.go:171","msg":"trace[1044563962] linearizableReadLoop","detail":"{readStateIndex:5488; appliedIndex:5487; }","duration":"293.082941ms","start":"2026-04-07T01:33:23.139429Z","end":"2026-04-07T01:33:23.432512Z","steps":["trace[1044563962] 'read index received' (duration: 292.936409ms)","trace[1044563962] 'applied index is now lower than readState.Index' (duration: 145.242µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:23.432595Z","caller":"traceutil/trace.go:171","msg":"trace[1906609778] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"295.912094ms","start":"2026-04-07T01:33:23.136651Z","end":"2026-04-07T01:33:23.432564Z","steps":["trace[1906609778] 'process raft request' (duration: 295.725971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:23.432731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.293685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9635"} {"level":"info","ts":"2026-04-07T01:33:23.432771Z","caller":"traceutil/trace.go:171","msg":"trace[1326838489] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5294; }","duration":"293.368326ms","start":"2026-04-07T01:33:23.139394Z","end":"2026-04-07T01:33:23.432762Z","steps":["trace[1326838489] 'agreement among raft nodes before linearized reading' (duration: 293.234384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:23.540071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.524485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:33:23.540124Z","caller":"traceutil/trace.go:171","msg":"trace[990545645] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5294; }","duration":"371.600668ms","start":"2026-04-07T01:33:23.168513Z","end":"2026-04-07T01:33:23.540114Z","steps":["trace[990545645] 'agreement among raft nodes before linearized reading' (duration: 371.494916ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:23.540112Z","caller":"traceutil/trace.go:171","msg":"trace[1131837457] linearizableReadLoop","detail":"{readStateIndex:5489; appliedIndex:5488; }","duration":"107.388205ms","start":"2026-04-07T01:33:23.432605Z","end":"2026-04-07T01:33:23.539993Z","steps":["trace[1131837457] 'read index received' (duration: 21.266508ms)","trace[1131837457] 'applied index is now lower than readState.Index' (duration: 86.120377ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:33:23.540173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:33:23.168503Z","time spent":"371.661979ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-07T01:33:23.540267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.281439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x76nh\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-07T01:33:23.540333Z","caller":"traceutil/trace.go:171","msg":"trace[866822785] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x76nh; range_end:; response_count:1; response_revision:5294; }","duration":"110.382731ms","start":"2026-04-07T01:33:23.429932Z","end":"2026-04-07T01:33:23.540315Z","steps":["trace[866822785] 'agreement among raft nodes before linearized reading' (duration: 110.188018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:23.540313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.301873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-04-07T01:33:23.540357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.150287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:33:23.540403Z","caller":"traceutil/trace.go:171","msg":"trace[1510193172] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5294; }","duration":"115.425024ms","start":"2026-04-07T01:33:23.424961Z","end":"2026-04-07T01:33:23.540386Z","steps":["trace[1510193172] 'agreement among raft nodes before linearized reading' (duration: 115.1882ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:23.540481Z","caller":"traceutil/trace.go:171","msg":"trace[1490141274] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:5294; }","duration":"147.322561ms","start":"2026-04-07T01:33:23.393132Z","end":"2026-04-07T01:33:23.540454Z","steps":["trace[1490141274] 'agreement among raft nodes before linearized reading' (duration: 147.100717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:23.540405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.100383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18a3ef1d844f923b\" ","response":"range_response_count:1 size:740"} {"level":"info","ts":"2026-04-07T01:33:23.540588Z","caller":"traceutil/trace.go:171","msg":"trace[1165022507] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18a3ef1d844f923b; range_end:; response_count:1; response_revision:5294; }","duration":"104.291997ms","start":"2026-04-07T01:33:23.436277Z","end":"2026-04-07T01:33:23.540568Z","steps":["trace[1165022507] 'agreement among raft nodes before linearized reading' (duration: 103.977431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:23.540402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.595474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-07T01:33:23.54066Z","caller":"traceutil/trace.go:171","msg":"trace[275827808] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5294; }","duration":"103.87436ms","start":"2026-04-07T01:33:23.436774Z","end":"2026-04-07T01:33:23.540649Z","steps":["trace[275827808] 'agreement among raft nodes before linearized reading' (duration: 103.530753ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:23.861912Z","caller":"traceutil/trace.go:171","msg":"trace[1104434359] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"168.484155ms","start":"2026-04-07T01:33:23.693395Z","end":"2026-04-07T01:33:23.861879Z","steps":["trace[1104434359] 'process raft request' (duration: 141.065863ms)","trace[1104434359] 'compare' (duration: 27.067206ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:23.861926Z","caller":"traceutil/trace.go:171","msg":"trace[804874723] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"168.492435ms","start":"2026-04-07T01:33:23.693405Z","end":"2026-04-07T01:33:23.861898Z","steps":["trace[804874723] 'process raft request' (duration: 168.328022ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:23.862037Z","caller":"traceutil/trace.go:171","msg":"trace[1304557326] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"168.19874ms","start":"2026-04-07T01:33:23.693816Z","end":"2026-04-07T01:33:23.862015Z","steps":["trace[1304557326] 'process raft request' (duration: 168.017687ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:44.991009Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2871} {"level":"info","ts":"2026-04-07T01:34:45.057241Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2871,"took":"64.936912ms","hash":3879320279,"current-db-size-bytes":57868288,"current-db-size":"58 MB","current-db-size-in-use-bytes":33042432,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-07T01:34:45.057601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3879320279,"revision":2871,"compact-revision":-1} {"level":"info","ts":"2026-04-07T01:39:02.366985Z","caller":"traceutil/trace.go:171","msg":"trace[1374979978] transaction","detail":"{read_only:false; response_revision:7921; number_of_response:1; }","duration":"254.358447ms","start":"2026-04-07T01:39:02.1126Z","end":"2026-04-07T01:39:02.366959Z","steps":["trace[1374979978] 'process raft request' (duration: 254.203305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:13.42939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.544575ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T01:39:14.278407Z","caller":"traceutil/trace.go:171","msg":"trace[264565222] transaction","detail":"{read_only:false; response_revision:7980; number_of_response:1; }","duration":"330.570547ms","start":"2026-04-07T01:39:13.947808Z","end":"2026-04-07T01:39:14.278378Z","steps":["trace[264565222] 'process raft request' (duration: 330.306712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:14.278599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:13.947777Z","time spent":"330.714829ms","remote":"127.0.0.1:51946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:39:14.30388Z","caller":"traceutil/trace.go:171","msg":"trace[2086200478] transaction","detail":"{read_only:false; response_revision:7981; number_of_response:1; }","duration":"355.062687ms","start":"2026-04-07T01:39:13.948793Z","end":"2026-04-07T01:39:14.303855Z","steps":["trace[2086200478] 'process raft request' (duration: 354.896924ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:14.304064Z","caller":"traceutil/trace.go:171","msg":"trace[700780751] linearizableReadLoop","detail":"{readStateIndex:8259; appliedIndex:8257; }","duration":"317.93237ms","start":"2026-04-07T01:39:13.986092Z","end":"2026-04-07T01:39:14.304024Z","steps":["trace[700780751] 'read index received' (duration: 292.114886ms)","trace[700780751] 'applied index is now lower than readState.Index' (duration: 25.815724ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:39:14.304193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.073322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:39:14.304236Z","caller":"traceutil/trace.go:171","msg":"trace[1046898245] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:7982; }","duration":"318.156184ms","start":"2026-04-07T01:39:13.986066Z","end":"2026-04-07T01:39:14.304222Z","steps":["trace[1046898245] 'agreement among raft nodes before linearized reading' (duration: 318.064913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:14.304277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:13.986053Z","time spent":"318.214655ms","remote":"127.0.0.1:48150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T01:39:14.304383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:13.948778Z","time spent":"355.174588ms","remote":"127.0.0.1:51946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:39:44.997269Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5980} {"level":"info","ts":"2026-04-07T01:39:45.095384Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5980,"took":"96.228914ms","hash":786552502,"current-db-size-bytes":57868288,"current-db-size":"58 MB","current-db-size-in-use-bytes":22589440,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-07T01:39:45.095453Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":786552502,"revision":5980,"compact-revision":2871} {"level":"info","ts":"2026-04-07T01:39:54.805322Z","caller":"traceutil/trace.go:171","msg":"trace[510499876] transaction","detail":"{read_only:false; response_revision:8290; number_of_response:1; }","duration":"234.252072ms","start":"2026-04-07T01:39:54.571042Z","end":"2026-04-07T01:39:54.805294Z","steps":["trace[510499876] 'process raft request' (duration: 193.205702ms)","trace[510499876] 'compare' (duration: 40.941388ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:54.83158Z","caller":"traceutil/trace.go:171","msg":"trace[28940274] linearizableReadLoop","detail":"{readStateIndex:8582; appliedIndex:8580; }","duration":"185.06412ms","start":"2026-04-07T01:39:54.646498Z","end":"2026-04-07T01:39:54.831562Z","steps":["trace[28940274] 'read index received' (duration: 117.85728ms)","trace[28940274] 'applied index is now lower than readState.Index' (duration: 67.20585ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:54.831716Z","caller":"traceutil/trace.go:171","msg":"trace[1460751114] transaction","detail":"{read_only:false; response_revision:8291; number_of_response:1; }","duration":"185.836344ms","start":"2026-04-07T01:39:54.645838Z","end":"2026-04-07T01:39:54.831674Z","steps":["trace[1460751114] 'process raft request' (duration: 185.589638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:54.831851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.348126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-mns5m\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-07T01:39:54.831902Z","caller":"traceutil/trace.go:171","msg":"trace[1587255383] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-mns5m; range_end:; response_count:1; response_revision:8291; }","duration":"185.458027ms","start":"2026-04-07T01:39:54.646435Z","end":"2026-04-07T01:39:54.831893Z","steps":["trace[1587255383] 'agreement among raft nodes before linearized reading' (duration: 185.277763ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:54.992251Z","caller":"traceutil/trace.go:171","msg":"trace[512749752] transaction","detail":"{read_only:false; response_revision:8292; number_of_response:1; }","duration":"151.391778ms","start":"2026-04-07T01:39:54.840829Z","end":"2026-04-07T01:39:54.992221Z","steps":["trace[512749752] 'process raft request' (duration: 64.923557ms)","trace[512749752] 'compare' (duration: 86.215806ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:54.992242Z","caller":"traceutil/trace.go:171","msg":"trace[2053214153] transaction","detail":"{read_only:false; response_revision:8293; number_of_response:1; }","duration":"135.493341ms","start":"2026-04-07T01:39:54.85671Z","end":"2026-04-07T01:39:54.992204Z","steps":["trace[2053214153] 'process raft request' (duration: 135.379578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:56.170491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.164324ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:39:56.170642Z","caller":"traceutil/trace.go:171","msg":"trace[2141666152] transaction","detail":"{read_only:false; response_revision:8296; number_of_response:1; }","duration":"208.282715ms","start":"2026-04-07T01:39:55.962323Z","end":"2026-04-07T01:39:56.170605Z","steps":["trace[2141666152] 'process raft request' (duration: 80.877017ms)","trace[2141666152] 'compare' (duration: 127.034302ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:56.170672Z","caller":"traceutil/trace.go:171","msg":"trace[2003929838] transaction","detail":"{read_only:false; response_revision:8297; number_of_response:1; }","duration":"171.045406ms","start":"2026-04-07T01:39:55.999608Z","end":"2026-04-07T01:39:56.170654Z","steps":["trace[2003929838] 'process raft request' (duration: 170.986595ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:56.170678Z","caller":"traceutil/trace.go:171","msg":"trace[94307563] linearizableReadLoop","detail":"{readStateIndex:8587; appliedIndex:8586; }","duration":"207.51423ms","start":"2026-04-07T01:39:55.963142Z","end":"2026-04-07T01:39:56.170656Z","steps":["trace[94307563] 'read index received' (duration: 80.069791ms)","trace[94307563] 'applied index is now lower than readState.Index' (duration: 127.442099ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:39:56.170954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.776205ms","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-04-07T01:39:56.171047Z","caller":"traceutil/trace.go:171","msg":"trace[360529449] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8297; }","duration":"207.910847ms","start":"2026-04-07T01:39:55.963116Z","end":"2026-04-07T01:39:56.171027Z","steps":["trace[360529449] 'agreement among raft nodes before linearized reading' (duration: 207.652912ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:56.213359Z","caller":"traceutil/trace.go:171","msg":"trace[917513249] transaction","detail":"{read_only:false; response_revision:8298; number_of_response:1; }","duration":"113.202481ms","start":"2026-04-07T01:39:56.100101Z","end":"2026-04-07T01:39:56.213304Z","steps":["trace[917513249] 'process raft request' (duration: 113.025378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:56.2134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.869698ms","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-04-07T01:39:56.213514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.371451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x76nh\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-07T01:39:56.213547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.167764ms","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-04-07T01:39:56.213564Z","caller":"traceutil/trace.go:171","msg":"trace[1014184811] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8298; }","duration":"215.077573ms","start":"2026-04-07T01:39:55.998467Z","end":"2026-04-07T01:39:56.213544Z","steps":["trace[1014184811] 'agreement among raft nodes before linearized reading' (duration: 214.814337ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:56.213625Z","caller":"traceutil/trace.go:171","msg":"trace[2127777505] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x76nh; range_end:; response_count:1; response_revision:8298; }","duration":"212.513444ms","start":"2026-04-07T01:39:56.001074Z","end":"2026-04-07T01:39:56.213588Z","steps":["trace[2127777505] 'agreement among raft nodes before linearized reading' (duration: 212.187968ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:56.213611Z","caller":"traceutil/trace.go:171","msg":"trace[1288973735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8298; }","duration":"215.256925ms","start":"2026-04-07T01:39:55.998338Z","end":"2026-04-07T01:39:56.213595Z","steps":["trace[1288973735] 'agreement among raft nodes before linearized reading' (duration: 214.98041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:56.213897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.488399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T01:39:56.213974Z","caller":"traceutil/trace.go:171","msg":"trace[1389201040] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8298; }","duration":"215.597052ms","start":"2026-04-07T01:39:55.998361Z","end":"2026-04-07T01:39:56.213958Z","steps":["trace[1389201040] 'agreement among raft nodes before linearized reading' (duration: 215.057961ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:56.373404Z","caller":"traceutil/trace.go:171","msg":"trace[331270005] transaction","detail":"{read_only:false; response_revision:8300; number_of_response:1; }","duration":"155.22671ms","start":"2026-04-07T01:39:56.218151Z","end":"2026-04-07T01:39:56.373377Z","steps":["trace[331270005] 'process raft request' (duration: 55.371558ms)","trace[331270005] 'compare' (duration: 99.690479ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:56.373612Z","caller":"traceutil/trace.go:171","msg":"trace[38825896] linearizableReadLoop","detail":"{readStateIndex:8592; appliedIndex:8589; }","duration":"149.92052ms","start":"2026-04-07T01:39:56.223661Z","end":"2026-04-07T01:39:56.373581Z","steps":["trace[38825896] 'read index received' (duration: 12.651797ms)","trace[38825896] 'applied index is now lower than readState.Index' (duration: 137.267053ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:56.373693Z","caller":"traceutil/trace.go:171","msg":"trace[1603944477] transaction","detail":"{read_only:false; response_revision:8301; number_of_response:1; }","duration":"155.201139ms","start":"2026-04-07T01:39:56.218429Z","end":"2026-04-07T01:39:56.37363Z","steps":["trace[1603944477] 'process raft request' (duration: 154.902764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:56.373842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.162135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-04-07T01:39:56.373891Z","caller":"traceutil/trace.go:171","msg":"trace[652254231] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8301; }","duration":"150.259026ms","start":"2026-04-07T01:39:56.223615Z","end":"2026-04-07T01:39:56.373874Z","steps":["trace[652254231] 'agreement among raft nodes before linearized reading' (duration: 150.070013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:56.918125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.504714ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:39:56.91822Z","caller":"traceutil/trace.go:171","msg":"trace[1063935372] linearizableReadLoop","detail":"{readStateIndex:8597; appliedIndex:8596; }","duration":"104.892017ms","start":"2026-04-07T01:39:56.813312Z","end":"2026-04-07T01:39:56.918204Z","steps":["trace[1063935372] 'read index received' (duration: 4.195789ms)","trace[1063935372] 'applied index is now lower than readState.Index' (duration: 100.695218ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:39:56.91844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.115811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rook-ceph-config\" ","response":"range_response_count:1 size:598"} {"level":"info","ts":"2026-04-07T01:39:56.918519Z","caller":"traceutil/trace.go:171","msg":"trace[374321052] transaction","detail":"{read_only:false; response_revision:8306; number_of_response:1; }","duration":"108.31384ms","start":"2026-04-07T01:39:56.810167Z","end":"2026-04-07T01:39:56.91848Z","steps":["trace[374321052] 'compare' (duration: 100.390062ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:56.918567Z","caller":"traceutil/trace.go:171","msg":"trace[1081097336] range","detail":"{range_begin:/registry/secrets/openstack/rook-ceph-config; range_end:; response_count:1; response_revision:8306; }","duration":"105.268543ms","start":"2026-04-07T01:39:56.813277Z","end":"2026-04-07T01:39:56.918546Z","steps":["trace[1081097336] 'agreement among raft nodes before linearized reading' (duration: 105.011638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:56.918775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.351735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-07T01:39:56.918864Z","caller":"traceutil/trace.go:171","msg":"trace[1370812899] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:8306; }","duration":"105.436166ms","start":"2026-04-07T01:39:56.813406Z","end":"2026-04-07T01:39:56.918842Z","steps":["trace[1370812899] 'agreement among raft nodes before linearized reading' (duration: 105.245083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:56.918936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.475076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-07T01:39:56.919047Z","caller":"traceutil/trace.go:171","msg":"trace[677145866] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:8306; }","duration":"105.66475ms","start":"2026-04-07T01:39:56.813364Z","end":"2026-04-07T01:39:56.919029Z","steps":["trace[677145866] 'agreement among raft nodes before linearized reading' (duration: 105.279233ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:52.994739Z","caller":"traceutil/trace.go:171","msg":"trace[734571876] transaction","detail":"{read_only:false; response_revision:8882; number_of_response:1; }","duration":"168.435688ms","start":"2026-04-07T01:40:52.826268Z","end":"2026-04-07T01:40:52.994704Z","steps":["trace[734571876] 'process raft request' (duration: 153.542509ms)","trace[734571876] 'compare' (duration: 14.713866ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:13.301768Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002494.wal"} {"level":"info","ts":"2026-04-07T01:42:29.12823Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f52f30d5714009d5","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T01:42:29.134396Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T01:42:29.134488Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T01:44:45.004114Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8198} {"level":"info","ts":"2026-04-07T01:44:45.085457Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8198,"took":"78.910572ms","hash":2652174382,"current-db-size-bytes":57868288,"current-db-size":"58 MB","current-db-size-in-use-bytes":24322048,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-07T01:44:45.085543Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2652174382,"revision":8198,"compact-revision":5980} {"level":"info","ts":"2026-04-07T01:49:45.009338Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10577} {"level":"info","ts":"2026-04-07T01:49:45.087044Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10577,"took":"76.01021ms","hash":3974042354,"current-db-size-bytes":57868288,"current-db-size":"58 MB","current-db-size-in-use-bytes":19668992,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-07T01:49:45.087118Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3974042354,"revision":10577,"compact-revision":8198}