{"level":"warn","ts":"2026-09-09T01:05:04.371517Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-09T01:05:04.371603Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.143: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.143:2380","--initial-cluster=instance=https://162.253.55.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.143:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-09T01:05:04.371669Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-09T01:05:04.371681Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-09-09T01:05:04.371697Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-09T01:05:04.372294Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"]} {"level":"info","ts":"2026-09-09T01:05:04.372359Z","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":8,"max-cpu-available":8,"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.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.143:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-09T01:05:04.377706Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.155909ms"} {"level":"info","ts":"2026-09-09T01:05:04.383475Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7bf20b54406e85d1","cluster-id":"de54e01795e71fe2"} {"level":"info","ts":"2026-09-09T01:05:04.38353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=()"} {"level":"info","ts":"2026-09-09T01:05:04.383549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 0"} {"level":"info","ts":"2026-09-09T01:05:04.383559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7bf20b54406e85d1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-09T01:05:04.383578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 1"} {"level":"info","ts":"2026-09-09T01:05:04.383609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"warn","ts":"2026-09-09T01:05:04.395731Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-09T01:05:04.396972Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-09T01:05:04.398148Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-09T01:05:04.404641Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7bf20b54406e85d1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-09T01:05:04.405114Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7bf20b54406e85d1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-09T01:05:04.405152Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-09T01:05:04.405473Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-09T01:05:04.405495Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-09T01:05:04.407212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"info","ts":"2026-09-09T01:05:04.40749Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","added-peer-id":"7bf20b54406e85d1","added-peer-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-09-09T01:05:04.409697Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-09T01:05:04.409895Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-09-09T01:05:04.409932Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-09-09T01:05:04.410688Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7bf20b54406e85d1","initial-advertise-peer-urls":["https://162.253.55.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-09T01:05:04.410728Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-09T01:05:04.684106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 is starting a new election at term 1"} {"level":"info","ts":"2026-09-09T01:05:04.684171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-09T01:05:04.684192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgPreVoteResp from 7bf20b54406e85d1 at term 1"} {"level":"info","ts":"2026-09-09T01:05:04.684226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became candidate at term 2"} {"level":"info","ts":"2026-09-09T01:05:04.684237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgVoteResp from 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-09-09T01:05:04.684292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became leader at term 2"} {"level":"info","ts":"2026-09-09T01:05:04.684308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7bf20b54406e85d1 elected leader 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-09-09T01:05:04.685314Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7bf20b54406e85d1","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.143:2379]}","request-path":"/0/members/7bf20b54406e85d1/attributes","cluster-id":"de54e01795e71fe2","publish-timeout":"7s"} {"level":"info","ts":"2026-09-09T01:05:04.685355Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T01:05:04.685442Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T01:05:04.686027Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-09T01:05:04.686059Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-09T01:05:04.686178Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:05:04.689427Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-09T01:05:04.704901Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:05:04.705058Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:05:04.70511Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:05:04.713363Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.143:2379"} {"level":"info","ts":"2026-09-09T01:05:07.855285Z","caller":"traceutil/trace.go:171","msg":"trace[1636158964] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"137.897487ms","start":"2026-09-09T01:05:07.717357Z","end":"2026-09-09T01:05:07.855255Z","steps":["trace[1636158964] 'process raft request' (duration: 117.177089ms)","trace[1636158964] 'compare' (duration: 20.592683ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:05:41.781834Z","caller":"traceutil/trace.go:171","msg":"trace[1971699731] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"117.05316ms","start":"2026-09-09T01:05:41.664749Z","end":"2026-09-09T01:05:41.781802Z","steps":["trace[1971699731] 'process raft request' (duration: 113.166694ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:05:41.781831Z","caller":"traceutil/trace.go:171","msg":"trace[180977708] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"114.918271ms","start":"2026-09-09T01:05:41.666876Z","end":"2026-09-09T01:05:41.781794Z","steps":["trace[180977708] 'process raft request' (duration: 114.8621ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:05:41.781864Z","caller":"traceutil/trace.go:171","msg":"trace[1431192342] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"117.07665ms","start":"2026-09-09T01:05:41.664752Z","end":"2026-09-09T01:05:41.781828Z","steps":["trace[1431192342] 'process raft request' (duration: 116.924256ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:05:41.911262Z","caller":"traceutil/trace.go:171","msg":"trace[647194047] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"102.697293ms","start":"2026-09-09T01:05:41.808535Z","end":"2026-09-09T01:05:41.911232Z","steps":["trace[647194047] 'process raft request' (duration: 98.764145ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:05:41.915492Z","caller":"traceutil/trace.go:171","msg":"trace[802150313] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"100.659848ms","start":"2026-09-09T01:05:41.814811Z","end":"2026-09-09T01:05:41.915471Z","steps":["trace[802150313] 'process raft request' (duration: 100.492003ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:05:48.20408Z","caller":"traceutil/trace.go:171","msg":"trace[309022372] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"146.630391ms","start":"2026-09-09T01:05:48.057425Z","end":"2026-09-09T01:05:48.204055Z","steps":["trace[309022372] 'process raft request' (duration: 146.036347ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:05:48.420623Z","caller":"traceutil/trace.go:171","msg":"trace[378859349] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"144.745312ms","start":"2026-09-09T01:05:48.275825Z","end":"2026-09-09T01:05:48.42057Z","steps":["trace[378859349] 'process raft request' (duration: 144.422273ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:05:49.059755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.434141ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:05:49.060178Z","caller":"traceutil/trace.go:171","msg":"trace[559830841] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:656; }","duration":"568.610565ms","start":"2026-09-09T01:05:48.491547Z","end":"2026-09-09T01:05:49.060157Z","steps":["trace[559830841] 'read index received' (duration: 326.994493ms)","trace[559830841] 'applied index is now lower than readState.Index' (duration: 241.614862ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:05:49.060283Z","caller":"traceutil/trace.go:171","msg":"trace[1916130733] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"578.573366ms","start":"2026-09-09T01:05:48.481696Z","end":"2026-09-09T01:05:49.060269Z","steps":["trace[1916130733] 'process raft request' (duration: 578.343041ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:05:49.060309Z","caller":"traceutil/trace.go:171","msg":"trace[1538825764] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"578.869833ms","start":"2026-09-09T01:05:48.481409Z","end":"2026-09-09T01:05:49.060278Z","steps":["trace[1538825764] 'process raft request' (duration: 578.483524ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:05:49.060361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:05:48.48168Z","time spent":"578.634767ms","remote":"127.0.0.1:58748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:05:49.060474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:05:48.4814Z","time spent":"578.989146ms","remote":"127.0.0.1:58554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-09T01:05:49.060489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.912653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.143\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-09T01:05:49.060586Z","caller":"traceutil/trace.go:171","msg":"trace[789296572] range","detail":"{range_begin:/registry/masterleases/162.253.55.143; range_end:; response_count:1; response_revision:642; }","duration":"569.050486ms","start":"2026-09-09T01:05:48.491511Z","end":"2026-09-09T01:05:49.060561Z","steps":["trace[789296572] 'agreement among raft nodes before linearized reading' (duration: 568.83246ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:05:49.060637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:05:48.491462Z","time spent":"569.161389ms","remote":"127.0.0.1:58526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.143\" "} {"level":"info","ts":"2026-09-09T01:05:49.060809Z","caller":"traceutil/trace.go:171","msg":"trace[735175552] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"576.552273ms","start":"2026-09-09T01:05:48.484248Z","end":"2026-09-09T01:05:49.0608Z","steps":["trace[735175552] 'process raft request' (duration: 575.856716ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:05:49.060868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.541836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-09T01:05:49.060666Z","caller":"traceutil/trace.go:171","msg":"trace[1476844128] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"579.409538ms","start":"2026-09-09T01:05:48.481243Z","end":"2026-09-09T01:05:49.060652Z","steps":["trace[1476844128] 'process raft request' (duration: 337.304424ms)","trace[1476844128] 'compare' (duration: 240.289917ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:05:49.060909Z","caller":"traceutil/trace.go:171","msg":"trace[560038888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"384.615657ms","start":"2026-09-09T01:05:48.67628Z","end":"2026-09-09T01:05:49.060895Z","steps":["trace[560038888] 'agreement among raft nodes before linearized reading' (duration: 384.552056ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:05:49.061089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:05:48.481214Z","time spent":"579.754806ms","remote":"127.0.0.1:58716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:05:49.061101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:05:48.676262Z","time spent":"384.766581ms","remote":"127.0.0.1:58748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-09T01:05:49.060666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.979424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4cshz\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-09T01:05:49.061305Z","caller":"traceutil/trace.go:171","msg":"trace[506234483] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4cshz; range_end:; response_count:1; response_revision:642; }","duration":"515.624101ms","start":"2026-09-09T01:05:48.545651Z","end":"2026-09-09T01:05:49.061275Z","steps":["trace[506234483] 'agreement among raft nodes before linearized reading' (duration: 514.957844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:05:49.06136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:05:48.545636Z","time spent":"515.708073ms","remote":"127.0.0.1:58674","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-4cshz\" "} {"level":"warn","ts":"2026-09-09T01:05:49.061672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:05:48.484236Z","time spent":"576.600324ms","remote":"127.0.0.1:58674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:05:49.060805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.957885ms","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-09-09T01:05:49.061812Z","caller":"traceutil/trace.go:171","msg":"trace[1408751240] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:642; }","duration":"210.987061ms","start":"2026-09-09T01:05:48.850806Z","end":"2026-09-09T01:05:49.061793Z","steps":["trace[1408751240] 'agreement among raft nodes before linearized reading' (duration: 209.958084ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:05:49.063073Z","caller":"traceutil/trace.go:171","msg":"trace[348396892] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"581.519873ms","start":"2026-09-09T01:05:48.481468Z","end":"2026-09-09T01:05:49.062988Z","steps":["trace[348396892] 'process raft request' (duration: 578.495405ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:05:49.063174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:05:48.481461Z","time spent":"581.662846ms","remote":"127.0.0.1:58554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-09T01:06:16.277631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.155408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:06:16.277717Z","caller":"traceutil/trace.go:171","msg":"trace[34121502] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:835; }","duration":"271.276041ms","start":"2026-09-09T01:06:16.006423Z","end":"2026-09-09T01:06:16.277699Z","steps":["trace[34121502] 'count revisions from in-memory index tree' (duration: 271.042166ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:06:48.8676Z","caller":"traceutil/trace.go:171","msg":"trace[180966886] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"184.532872ms","start":"2026-09-09T01:06:48.683046Z","end":"2026-09-09T01:06:48.867579Z","steps":["trace[180966886] 'process raft request' (duration: 184.173015ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:36.352729Z","caller":"traceutil/trace.go:171","msg":"trace[1223235206] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"280.810678ms","start":"2026-09-09T01:07:36.071895Z","end":"2026-09-09T01:07:36.352706Z","steps":["trace[1223235206] 'process raft request' (duration: 280.654806ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:36.687069Z","caller":"traceutil/trace.go:171","msg":"trace[1263725776] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"327.209154ms","start":"2026-09-09T01:07:36.35984Z","end":"2026-09-09T01:07:36.687049Z","steps":["trace[1263725776] 'process raft request' (duration: 327.065271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:07:36.687201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:07:36.359804Z","time spent":"327.326076ms","remote":"127.0.0.1:58760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1512,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:07:36.842517Z","caller":"traceutil/trace.go:171","msg":"trace[1907695835] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"482.236399ms","start":"2026-09-09T01:07:36.360256Z","end":"2026-09-09T01:07:36.842493Z","steps":["trace[1907695835] 'process raft request' (duration: 480.133037ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:36.8426Z","caller":"traceutil/trace.go:171","msg":"trace[877618420] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"482.230529ms","start":"2026-09-09T01:07:36.360344Z","end":"2026-09-09T01:07:36.842575Z","steps":["trace[877618420] 'process raft request' (duration: 482.097537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:07:36.842706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:07:36.360338Z","time spent":"482.30512ms","remote":"127.0.0.1:58670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:07:36.84271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:07:36.360192Z","time spent":"482.389142ms","remote":"127.0.0.1:58670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":960,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:07:36.842819Z","caller":"traceutil/trace.go:171","msg":"trace[646257911] linearizableReadLoop","detail":"{readStateIndex:1962; appliedIndex:1958; }","duration":"468.848297ms","start":"2026-09-09T01:07:36.373927Z","end":"2026-09-09T01:07:36.842775Z","steps":["trace[646257911] 'read index received' (duration: 312.994119ms)","trace[646257911] 'applied index is now lower than readState.Index' (duration: 155.852308ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:07:36.842989Z","caller":"traceutil/trace.go:171","msg":"trace[633818337] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"480.346329ms","start":"2026-09-09T01:07:36.362569Z","end":"2026-09-09T01:07:36.842916Z","steps":["trace[633818337] 'process raft request' (duration: 479.927142ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:07:36.84307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.024276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-09T01:07:36.843105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.158602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-09-09T01:07:36.843169Z","caller":"traceutil/trace.go:171","msg":"trace[1609350893] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1907; }","duration":"186.179529ms","start":"2026-09-09T01:07:36.656976Z","end":"2026-09-09T01:07:36.843155Z","steps":["trace[1609350893] 'agreement among raft nodes before linearized reading' (duration: 186.027737ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:36.843195Z","caller":"traceutil/trace.go:171","msg":"trace[546953212] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1907; }","duration":"469.301474ms","start":"2026-09-09T01:07:36.373862Z","end":"2026-09-09T01:07:36.843164Z","steps":["trace[546953212] 'agreement among raft nodes before linearized reading' (duration: 469.089281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:07:36.843283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:07:36.373825Z","time spent":"469.433607ms","remote":"127.0.0.1:49612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":4614,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-09T01:07:36.843312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:07:36.362536Z","time spent":"480.574483ms","remote":"127.0.0.1:58760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:07:36.843373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.751386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc0ac2d1-893f-42e2-a1e9-837dd24d28df\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-09T01:07:36.84351Z","caller":"traceutil/trace.go:171","msg":"trace[61793601] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cc0ac2d1-893f-42e2-a1e9-837dd24d28df; range_end:; response_count:1; response_revision:1907; }","duration":"100.97601ms","start":"2026-09-09T01:07:36.742516Z","end":"2026-09-09T01:07:36.843492Z","steps":["trace[61793601] 'agreement among raft nodes before linearized reading' (duration: 100.485002ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:39.251154Z","caller":"traceutil/trace.go:171","msg":"trace[2064768478] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"105.094013ms","start":"2026-09-09T01:07:39.146037Z","end":"2026-09-09T01:07:39.251131Z","steps":["trace[2064768478] 'process raft request' (duration: 97.671377ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:45.933198Z","caller":"traceutil/trace.go:171","msg":"trace[2144068131] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"194.300778ms","start":"2026-09-09T01:07:45.73887Z","end":"2026-09-09T01:07:45.93317Z","steps":["trace[2144068131] 'process raft request' (duration: 183.803896ms)","trace[2144068131] 'compare' (duration: 10.307939ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:07:45.959077Z","caller":"traceutil/trace.go:171","msg":"trace[1308942620] linearizableReadLoop","detail":"{readStateIndex:2071; appliedIndex:2069; }","duration":"152.624262ms","start":"2026-09-09T01:07:45.806425Z","end":"2026-09-09T01:07:45.95905Z","steps":["trace[1308942620] 'read index received' (duration: 116.390109ms)","trace[1308942620] 'applied index is now lower than readState.Index' (duration: 36.233163ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:07:45.959186Z","caller":"traceutil/trace.go:171","msg":"trace[2118721300] transaction","detail":"{read_only:false; response_revision:2011; number_of_response:1; }","duration":"217.715943ms","start":"2026-09-09T01:07:45.741441Z","end":"2026-09-09T01:07:45.959157Z","steps":["trace[2118721300] 'process raft request' (duration: 217.482219ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:07:45.959359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.917746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-09T01:07:45.959399Z","caller":"traceutil/trace.go:171","msg":"trace[1372829762] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2011; }","duration":"153.046238ms","start":"2026-09-09T01:07:45.806342Z","end":"2026-09-09T01:07:45.959388Z","steps":["trace[1372829762] 'agreement among raft nodes before linearized reading' (duration: 152.898736ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:55.538926Z","caller":"traceutil/trace.go:171","msg":"trace[670347247] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"197.012894ms","start":"2026-09-09T01:07:55.341875Z","end":"2026-09-09T01:07:55.538888Z","steps":["trace[670347247] 'process raft request' (duration: 149.454159ms)","trace[670347247] 'compare' (duration: 47.23882ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:07:55.539227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.405588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-09T01:07:55.539316Z","caller":"traceutil/trace.go:171","msg":"trace[1983462853] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2083; }","duration":"124.52742ms","start":"2026-09-09T01:07:55.414768Z","end":"2026-09-09T01:07:55.539296Z","steps":["trace[1983462853] 'agreement among raft nodes before linearized reading' (duration: 124.219445ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:55.539443Z","caller":"traceutil/trace.go:171","msg":"trace[1613279254] linearizableReadLoop","detail":"{readStateIndex:2146; appliedIndex:2145; }","duration":"123.998431ms","start":"2026-09-09T01:07:55.414792Z","end":"2026-09-09T01:07:55.53879Z","steps":["trace[1613279254] 'read index received' (duration: 76.443916ms)","trace[1613279254] 'applied index is now lower than readState.Index' (duration: 47.552965ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:07:55.814479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.815595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:07:55.814901Z","caller":"traceutil/trace.go:171","msg":"trace[1293055086] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"268.796359ms","start":"2026-09-09T01:07:55.546067Z","end":"2026-09-09T01:07:55.814864Z","steps":["trace[1293055086] 'process raft request' (duration: 99.457998ms)","trace[1293055086] 'compare' (duration: 168.54903ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:07:55.815026Z","caller":"traceutil/trace.go:171","msg":"trace[568155460] linearizableReadLoop","detail":"{readStateIndex:2147; appliedIndex:2146; }","duration":"267.727742ms","start":"2026-09-09T01:07:55.547246Z","end":"2026-09-09T01:07:55.814974Z","steps":["trace[568155460] 'read index received' (duration: 98.263938ms)","trace[568155460] 'applied index is now lower than readState.Index' (duration: 169.450014ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:07:55.814978Z","caller":"traceutil/trace.go:171","msg":"trace[853943433] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"267.572499ms","start":"2026-09-09T01:07:55.547381Z","end":"2026-09-09T01:07:55.814954Z","steps":["trace[853943433] 'process raft request' (duration: 267.452408ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:07:55.815221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.937805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:07:55.815352Z","caller":"traceutil/trace.go:171","msg":"trace[1702904922] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:2085; }","duration":"268.301381ms","start":"2026-09-09T01:07:55.547001Z","end":"2026-09-09T01:07:55.815303Z","steps":["trace[1702904922] 'agreement among raft nodes before linearized reading' (duration: 268.098768ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:56.009738Z","caller":"traceutil/trace.go:171","msg":"trace[1789568790] linearizableReadLoop","detail":"{readStateIndex:2153; appliedIndex:2152; }","duration":"101.402536ms","start":"2026-09-09T01:07:55.908318Z","end":"2026-09-09T01:07:56.009721Z","steps":["trace[1789568790] 'read index received' (duration: 65.296275ms)","trace[1789568790] 'applied index is now lower than readState.Index' (duration: 36.105481ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:07:56.009808Z","caller":"traceutil/trace.go:171","msg":"trace[1479730985] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"106.010076ms","start":"2026-09-09T01:07:55.903757Z","end":"2026-09-09T01:07:56.009767Z","steps":["trace[1479730985] 'process raft request' (duration: 69.926646ms)","trace[1479730985] 'compare' (duration: 35.940798ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:07:56.009911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.602317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"} {"level":"info","ts":"2026-09-09T01:07:56.009972Z","caller":"traceutil/trace.go:171","msg":"trace[1636236576] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2089; }","duration":"114.694768ms","start":"2026-09-09T01:07:55.895265Z","end":"2026-09-09T01:07:56.00996Z","steps":["trace[1636236576] 'agreement among raft nodes before linearized reading' (duration: 114.553996ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:14.600254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.966905ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:08:14.600575Z","caller":"traceutil/trace.go:171","msg":"trace[1897573465] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2279; }","duration":"360.185334ms","start":"2026-09-09T01:08:14.240367Z","end":"2026-09-09T01:08:14.600553Z","steps":["trace[1897573465] 'read index received' (duration: 16.777519ms)","trace[1897573465] 'applied index is now lower than readState.Index' (duration: 343.406684ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:14.600665Z","caller":"traceutil/trace.go:171","msg":"trace[237023166] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"360.226794ms","start":"2026-09-09T01:08:14.240424Z","end":"2026-09-09T01:08:14.600651Z","steps":["trace[237023166] 'process raft request' (duration: 359.94242ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:14.600683Z","caller":"traceutil/trace.go:171","msg":"trace[1121871218] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"360.540598ms","start":"2026-09-09T01:08:14.240122Z","end":"2026-09-09T01:08:14.600662Z","steps":["trace[1121871218] 'process raft request' (duration: 182.070925ms)","trace[1121871218] 'compare' (duration: 177.832274ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:08:14.60075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:08:14.240416Z","time spent":"360.281585ms","remote":"127.0.0.1:58748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:08:14.600769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:08:14.240106Z","time spent":"360.615009ms","remote":"127.0.0.1:58748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:08:14.601051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.672691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:551"} {"level":"info","ts":"2026-09-09T01:08:14.601098Z","caller":"traceutil/trace.go:171","msg":"trace[598215167] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2209; }","duration":"360.749362ms","start":"2026-09-09T01:08:14.240334Z","end":"2026-09-09T01:08:14.601084Z","steps":["trace[598215167] 'agreement among raft nodes before linearized reading' (duration: 360.337645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:14.601129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:08:14.240326Z","time spent":"360.795582ms","remote":"127.0.0.1:58748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":574,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-09-09T01:08:14.622276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.29778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-09-09T01:08:14.62235Z","caller":"traceutil/trace.go:171","msg":"trace[843853082] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2210; }","duration":"357.405262ms","start":"2026-09-09T01:08:14.264924Z","end":"2026-09-09T01:08:14.622329Z","steps":["trace[843853082] 'agreement among raft nodes before linearized reading' (duration: 357.216519ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:14.622843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.5361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-09-09T01:08:14.622893Z","caller":"traceutil/trace.go:171","msg":"trace[1332090229] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2210; }","duration":"348.625762ms","start":"2026-09-09T01:08:14.274255Z","end":"2026-09-09T01:08:14.62288Z","steps":["trace[1332090229] 'agreement among raft nodes before linearized reading' (duration: 348.47372ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:14.622931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:08:14.274237Z","time spent":"348.680683ms","remote":"127.0.0.1:58590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":682,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-09-09T01:08:14.622421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:08:14.264898Z","time spent":"357.509174ms","remote":"127.0.0.1:58748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":547,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"info","ts":"2026-09-09T01:08:14.78528Z","caller":"traceutil/trace.go:171","msg":"trace[1647995501] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"155.388241ms","start":"2026-09-09T01:08:14.629867Z","end":"2026-09-09T01:08:14.785255Z","steps":["trace[1647995501] 'process raft request' (duration: 155.070476ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:14.792457Z","caller":"traceutil/trace.go:171","msg":"trace[1528515731] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"158.397837ms","start":"2026-09-09T01:08:14.634044Z","end":"2026-09-09T01:08:14.792442Z","steps":["trace[1528515731] 'process raft request' (duration: 158.314985ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:14.969836Z","caller":"traceutil/trace.go:171","msg":"trace[2133772080] linearizableReadLoop","detail":"{readStateIndex:2286; appliedIndex:2285; }","duration":"106.951763ms","start":"2026-09-09T01:08:14.862777Z","end":"2026-09-09T01:08:14.969728Z","steps":["trace[2133772080] 'read index received' (duration: 20.993661ms)","trace[2133772080] 'applied index is now lower than readState.Index' (duration: 85.956532ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:08:14.97007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.277478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:08:14.970115Z","caller":"traceutil/trace.go:171","msg":"trace[1818179234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2214; }","duration":"107.38129ms","start":"2026-09-09T01:08:14.862721Z","end":"2026-09-09T01:08:14.970102Z","steps":["trace[1818179234] 'agreement among raft nodes before linearized reading' (duration: 107.285008ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:14.970113Z","caller":"traceutil/trace.go:171","msg":"trace[2034601774] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"169.119243ms","start":"2026-09-09T01:08:14.800887Z","end":"2026-09-09T01:08:14.970006Z","steps":["trace[2034601774] 'process raft request' (duration: 83.037549ms)","trace[2034601774] 'compare' (duration: 85.673408ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:09:04.368106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.822439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-09T01:09:04.368185Z","caller":"traceutil/trace.go:171","msg":"trace[739037298] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2650; }","duration":"110.944034ms","start":"2026-09-09T01:09:04.257224Z","end":"2026-09-09T01:09:04.368168Z","steps":["trace[739037298] 'range keys from in-memory index tree' (duration: 110.63271ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:05.143937Z","caller":"traceutil/trace.go:171","msg":"trace[89759497] transaction","detail":"{read_only:false; response_revision:2655; number_of_response:1; }","duration":"107.683743ms","start":"2026-09-09T01:09:05.036219Z","end":"2026-09-09T01:09:05.143902Z","steps":["trace[89759497] 'process raft request' (duration: 107.435781ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:40.796716Z","caller":"traceutil/trace.go:171","msg":"trace[1846647974] transaction","detail":"{read_only:false; response_revision:2900; number_of_response:1; }","duration":"141.495464ms","start":"2026-09-09T01:09:40.6552Z","end":"2026-09-09T01:09:40.796696Z","steps":["trace[1846647974] 'process raft request' (duration: 141.254554ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:40.796688Z","caller":"traceutil/trace.go:171","msg":"trace[1728166827] linearizableReadLoop","detail":"{readStateIndex:3010; appliedIndex:3009; }","duration":"118.581433ms","start":"2026-09-09T01:09:40.678079Z","end":"2026-09-09T01:09:40.796661Z","steps":["trace[1728166827] 'read index received' (duration: 118.355544ms)","trace[1728166827] 'applied index is now lower than readState.Index' (duration: 224.699µs)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:09:40.796941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.835933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-09T01:09:40.797021Z","caller":"traceutil/trace.go:171","msg":"trace[1978747602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2900; }","duration":"118.957698ms","start":"2026-09-09T01:09:40.678044Z","end":"2026-09-09T01:09:40.797002Z","steps":["trace[1978747602] 'agreement among raft nodes before linearized reading' (duration: 118.75766ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:40.92943Z","caller":"traceutil/trace.go:171","msg":"trace[1924794658] transaction","detail":"{read_only:false; response_revision:2901; number_of_response:1; }","duration":"127.865226ms","start":"2026-09-09T01:09:40.801549Z","end":"2026-09-09T01:09:40.929414Z","steps":["trace[1924794658] 'process raft request' (duration: 127.531833ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:10:10.469471Z","caller":"traceutil/trace.go:171","msg":"trace[775739585] transaction","detail":"{read_only:false; response_revision:3111; number_of_response:1; }","duration":"106.132938ms","start":"2026-09-09T01:10:10.363297Z","end":"2026-09-09T01:10:10.46943Z","steps":["trace[775739585] 'process raft request' (duration: 105.91618ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:10:10.470443Z","caller":"traceutil/trace.go:171","msg":"trace[243139891] transaction","detail":"{read_only:false; number_of_response:1; response_revision:3111; }","duration":"103.459683ms","start":"2026-09-09T01:10:10.366953Z","end":"2026-09-09T01:10:10.470413Z","steps":["trace[243139891] 'process raft request' (duration: 102.439356ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:11:56.227284Z","caller":"traceutil/trace.go:171","msg":"trace[1230379596] transaction","detail":"{read_only:false; response_revision:4347; number_of_response:1; }","duration":"106.32148ms","start":"2026-09-09T01:11:56.120931Z","end":"2026-09-09T01:11:56.227252Z","steps":["trace[1230379596] 'process raft request' (duration: 79.196621ms)","trace[1230379596] 'compare' (duration: 26.654787ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:12:01.575439Z","caller":"traceutil/trace.go:171","msg":"trace[192733259] transaction","detail":"{read_only:false; response_revision:4510; number_of_response:1; }","duration":"109.497349ms","start":"2026-09-09T01:12:01.4659Z","end":"2026-09-09T01:12:01.575397Z","steps":["trace[192733259] 'process raft request' (duration: 91.857306ms)","trace[192733259] 'compare' (duration: 17.419367ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:12:01.575517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.436372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-h6vmt-tls\" ","response":"range_response_count:1 size:2130"} {"level":"info","ts":"2026-09-09T01:12:01.576092Z","caller":"traceutil/trace.go:171","msg":"trace[1808419710] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-h6vmt-tls; range_end:; response_count:1; response_revision:4510; }","duration":"107.043917ms","start":"2026-09-09T01:12:01.469023Z","end":"2026-09-09T01:12:01.576067Z","steps":["trace[1808419710] 'agreement among raft nodes before linearized reading' (duration: 106.36757ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:01.714752Z","caller":"traceutil/trace.go:171","msg":"trace[711390488] transaction","detail":"{read_only:false; response_revision:4512; number_of_response:1; }","duration":"113.89422ms","start":"2026-09-09T01:12:01.600844Z","end":"2026-09-09T01:12:01.714738Z","steps":["trace[711390488] 'process raft request' (duration: 86.307816ms)","trace[711390488] 'compare' (duration: 27.360078ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:12:01.714698Z","caller":"traceutil/trace.go:171","msg":"trace[888777727] linearizableReadLoop","detail":"{readStateIndex:4703; appliedIndex:4702; }","duration":"113.486909ms","start":"2026-09-09T01:12:01.601189Z","end":"2026-09-09T01:12:01.714676Z","steps":["trace[888777727] 'read index received' (duration: 86.013329ms)","trace[888777727] 'applied index is now lower than readState.Index' (duration: 27.47253ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:12:01.715065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.854717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-09T01:12:01.715214Z","caller":"traceutil/trace.go:171","msg":"trace[304185385] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4512; }","duration":"113.936289ms","start":"2026-09-09T01:12:01.601171Z","end":"2026-09-09T01:12:01.715108Z","steps":["trace[304185385] 'agreement among raft nodes before linearized reading' (duration: 113.686393ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:01.729709Z","caller":"traceutil/trace.go:171","msg":"trace[1006891937] transaction","detail":"{read_only:false; response_revision:4513; number_of_response:1; }","duration":"126.32547ms","start":"2026-09-09T01:12:01.603372Z","end":"2026-09-09T01:12:01.729698Z","steps":["trace[1006891937] 'process raft request' (duration: 126.215618ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:01.730129Z","caller":"traceutil/trace.go:171","msg":"trace[207099624] transaction","detail":"{read_only:false; response_revision:4514; number_of_response:1; }","duration":"124.506865ms","start":"2026-09-09T01:12:01.605615Z","end":"2026-09-09T01:12:01.730121Z","steps":["trace[207099624] 'process raft request' (duration: 124.043983ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:01.730317Z","caller":"traceutil/trace.go:171","msg":"trace[1995216159] transaction","detail":"{read_only:false; response_revision:4515; number_of_response:1; }","duration":"108.701748ms","start":"2026-09-09T01:12:01.621594Z","end":"2026-09-09T01:12:01.730296Z","steps":["trace[1995216159] 'process raft request' (duration: 108.328858ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:08.301011Z","caller":"traceutil/trace.go:171","msg":"trace[724146797] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"155.245574ms","start":"2026-09-09T01:12:08.14574Z","end":"2026-09-09T01:12:08.300986Z","steps":["trace[724146797] 'process raft request' (duration: 155.036959ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:08.466738Z","caller":"traceutil/trace.go:171","msg":"trace[613826399] linearizableReadLoop","detail":"{readStateIndex:4799; appliedIndex:4798; }","duration":"104.85541ms","start":"2026-09-09T01:12:08.361854Z","end":"2026-09-09T01:12:08.466709Z","steps":["trace[613826399] 'read index received' (duration: 104.626605ms)","trace[613826399] 'applied index is now lower than readState.Index' (duration: 227.505µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:12:08.466812Z","caller":"traceutil/trace.go:171","msg":"trace[1293724666] transaction","detail":"{read_only:false; response_revision:4603; number_of_response:1; }","duration":"158.787033ms","start":"2026-09-09T01:12:08.307978Z","end":"2026-09-09T01:12:08.466765Z","steps":["trace[1293724666] 'process raft request' (duration: 158.571057ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:12:08.46707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.198909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-09-09T01:12:08.467146Z","caller":"traceutil/trace.go:171","msg":"trace[194334016] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4603; }","duration":"105.325272ms","start":"2026-09-09T01:12:08.361802Z","end":"2026-09-09T01:12:08.467127Z","steps":["trace[194334016] 'agreement among raft nodes before linearized reading' (duration: 105.064525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:12:08.473942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.368831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-5f69444fbf-8xb8q.18d381ebf0beacd4\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-09-09T01:12:08.474025Z","caller":"traceutil/trace.go:171","msg":"trace[958763897] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-5f69444fbf-8xb8q.18d381ebf0beacd4; range_end:; response_count:1; response_revision:4604; }","duration":"111.476533ms","start":"2026-09-09T01:12:08.36253Z","end":"2026-09-09T01:12:08.474007Z","steps":["trace[958763897] 'agreement among raft nodes before linearized reading' (duration: 111.246227ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:08.757878Z","caller":"traceutil/trace.go:171","msg":"trace[1497101870] transaction","detail":"{read_only:false; response_revision:4613; number_of_response:1; }","duration":"110.652594ms","start":"2026-09-09T01:12:08.647191Z","end":"2026-09-09T01:12:08.757843Z","steps":["trace[1497101870] 'process raft request' (duration: 81.913344ms)","trace[1497101870] 'compare' (duration: 28.474463ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:12:09.002469Z","caller":"traceutil/trace.go:171","msg":"trace[265209518] transaction","detail":"{read_only:false; response_revision:4618; number_of_response:1; }","duration":"153.388268ms","start":"2026-09-09T01:12:08.849052Z","end":"2026-09-09T01:12:09.00244Z","steps":["trace[265209518] 'process raft request' (duration: 153.06032ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:09.042808Z","caller":"traceutil/trace.go:171","msg":"trace[313493686] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"130.421789ms","start":"2026-09-09T01:12:08.912329Z","end":"2026-09-09T01:12:09.042751Z","steps":["trace[313493686] 'process raft request' (duration: 130.241645ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:20.674222Z","caller":"traceutil/trace.go:171","msg":"trace[197707667] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"149.17531ms","start":"2026-09-09T01:12:20.525023Z","end":"2026-09-09T01:12:20.674198Z","steps":["trace[197707667] 'process raft request' (duration: 149.041617ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:20.693249Z","caller":"traceutil/trace.go:171","msg":"trace[1864238612] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"127.053716ms","start":"2026-09-09T01:12:20.566182Z","end":"2026-09-09T01:12:20.693236Z","steps":["trace[1864238612] 'process raft request' (duration: 126.639867ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:20.693561Z","caller":"traceutil/trace.go:171","msg":"trace[1694363163] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"127.341064ms","start":"2026-09-09T01:12:20.56621Z","end":"2026-09-09T01:12:20.693551Z","steps":["trace[1694363163] 'process raft request' (duration: 126.73333ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:20.693828Z","caller":"traceutil/trace.go:171","msg":"trace[1315121944] linearizableReadLoop","detail":"{readStateIndex:5063; appliedIndex:5058; }","duration":"115.662212ms","start":"2026-09-09T01:12:20.578157Z","end":"2026-09-09T01:12:20.693819Z","steps":["trace[1315121944] 'read index received' (duration: 95.980208ms)","trace[1315121944] 'applied index is now lower than readState.Index' (duration: 19.681194ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:12:20.693819Z","caller":"traceutil/trace.go:171","msg":"trace[1411387357] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"127.456016ms","start":"2026-09-09T01:12:20.566324Z","end":"2026-09-09T01:12:20.69378Z","steps":["trace[1411387357] 'process raft request' (duration: 126.78663ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:12:20.693972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.797405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-09T01:12:20.694008Z","caller":"traceutil/trace.go:171","msg":"trace[1328169910] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4858; }","duration":"115.867998ms","start":"2026-09-09T01:12:20.578128Z","end":"2026-09-09T01:12:20.693996Z","steps":["trace[1328169910] 'agreement among raft nodes before linearized reading' (duration: 115.726234ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:20.694156Z","caller":"traceutil/trace.go:171","msg":"trace[793627925] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"126.705559ms","start":"2026-09-09T01:12:20.56744Z","end":"2026-09-09T01:12:20.694145Z","steps":["trace[793627925] 'process raft request' (duration: 126.301489ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:59.11716Z","caller":"traceutil/trace.go:171","msg":"trace[602484336] linearizableReadLoop","detail":"{readStateIndex:5463; appliedIndex:5462; }","duration":"166.615537ms","start":"2026-09-09T01:12:58.95052Z","end":"2026-09-09T01:12:59.117135Z","steps":["trace[602484336] 'read index received' (duration: 98.203118ms)","trace[602484336] 'applied index is now lower than readState.Index' (duration: 68.411489ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:12:59.117369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.862123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-09-09T01:12:59.117409Z","caller":"traceutil/trace.go:171","msg":"trace[1815040989] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5241; }","duration":"166.959655ms","start":"2026-09-09T01:12:58.950436Z","end":"2026-09-09T01:12:59.117395Z","steps":["trace[1815040989] 'agreement among raft nodes before linearized reading' (duration: 166.798492ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:12:59.117507Z","caller":"traceutil/trace.go:171","msg":"trace[2146667016] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5241; }","duration":"188.141629ms","start":"2026-09-09T01:12:58.929132Z","end":"2026-09-09T01:12:59.117274Z","steps":["trace[2146667016] 'process raft request' (duration: 119.681429ms)","trace[2146667016] 'compare' (duration: 68.278286ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:15:04.756707Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3060} {"level":"info","ts":"2026-09-09T01:15:04.860333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3060,"took":"102.162831ms","hash":4023342508,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":30994432,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-09T01:15:04.8605Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4023342508,"revision":3060,"compact-revision":-1}