{"level":"warn","ts":"2026-07-12T01:44:09.082313Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-12T01:44:09.082399Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-07-12T01:44:09.082464Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-12T01:44:09.082478Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-07-12T01:44:09.082497Z","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-07-12T01:44:09.083128Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-07-12T01:44:09.083196Z","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://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-07-12T01:44:09.086559Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.173676ms"} {"level":"info","ts":"2026-07-12T01:44:09.091943Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-07-12T01:44:09.092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-07-12T01:44:09.092016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-07-12T01:44:09.09203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-12T01:44:09.092036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-07-12T01:44:09.092067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-07-12T01:44:09.098279Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-12T01:44:09.099454Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-12T01:44:09.101979Z","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-07-12T01:44:09.104938Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-12T01:44:09.105035Z","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-07-12T01:44:09.105101Z","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-07-12T01:44:09.105109Z","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-07-12T01:44:09.105065Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-12T01:44:09.106019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-07-12T01:44:09.106644Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-07-12T01:44:09.113764Z","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-07-12T01:44:09.114056Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-12T01:44:09.114085Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-12T01:44:09.114215Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-07-12T01:44:09.114226Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-07-12T01:44:09.292944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-07-12T01:44:09.29304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-12T01:44:09.293767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-07-12T01:44:09.293815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-07-12T01:44:09.293829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-07-12T01:44:09.293842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-07-12T01:44:09.293857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-07-12T01:44:09.294484Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-12T01:44:09.295364Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-07-12T01:44:09.295411Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-12T01:44:09.29538Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-12T01:44:09.29717Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-12T01:44:09.29721Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-12T01:44:09.297537Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-07-12T01:44:09.297667Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-12T01:44:09.297733Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-12T01:44:09.297942Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-12T01:44:09.299365Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"info","ts":"2026-07-12T01:44:29.886193Z","caller":"traceutil/trace.go:171","msg":"trace[1993122833] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"347.607811ms","start":"2026-07-12T01:44:29.538545Z","end":"2026-07-12T01:44:29.886153Z","steps":["trace[1993122833] 'process raft request' (duration: 347.364152ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:29.887067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:29.538496Z","time spent":"347.83931ms","remote":"127.0.0.1:40392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-12T01:44:29.933616Z","caller":"traceutil/trace.go:171","msg":"trace[696362910] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:433; }","duration":"215.715483ms","start":"2026-07-12T01:44:29.717869Z","end":"2026-07-12T01:44:29.933584Z","steps":["trace[696362910] 'read index received' (duration: 168.094887ms)","trace[696362910] 'applied index is now lower than readState.Index' (duration: 47.619276ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:44:29.933684Z","caller":"traceutil/trace.go:171","msg":"trace[379573065] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"392.494071ms","start":"2026-07-12T01:44:29.541167Z","end":"2026-07-12T01:44:29.933661Z","steps":["trace[379573065] 'process raft request' (duration: 392.275022ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:29.933908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:29.541157Z","time spent":"392.628116ms","remote":"127.0.0.1:40392","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-07-12T01:44:29.933922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.993674ms","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-07-12T01:44:29.934034Z","caller":"traceutil/trace.go:171","msg":"trace[1124056380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:423; }","duration":"216.198873ms","start":"2026-07-12T01:44:29.717811Z","end":"2026-07-12T01:44:29.93401Z","steps":["trace[1124056380] 'agreement among raft nodes before linearized reading' (duration: 215.944713ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:46.521387Z","caller":"traceutil/trace.go:171","msg":"trace[2015274989] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"135.252648ms","start":"2026-07-12T01:44:46.386099Z","end":"2026-07-12T01:44:46.521351Z","steps":["trace[2015274989] 'process raft request' (duration: 134.876486ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:46.521589Z","caller":"traceutil/trace.go:171","msg":"trace[75415049] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"132.060114ms","start":"2026-07-12T01:44:46.389498Z","end":"2026-07-12T01:44:46.521558Z","steps":["trace[75415049] 'process raft request' (duration: 131.741003ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:46.52145Z","caller":"traceutil/trace.go:171","msg":"trace[1916768822] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"132.124325ms","start":"2026-07-12T01:44:46.3893Z","end":"2026-07-12T01:44:46.521424Z","steps":["trace[1916768822] 'process raft request' (duration: 131.809975ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:46.521775Z","caller":"traceutil/trace.go:171","msg":"trace[510311929] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"131.975652ms","start":"2026-07-12T01:44:46.38979Z","end":"2026-07-12T01:44:46.521766Z","steps":["trace[510311929] 'process raft request' (duration: 131.905399ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:46.521797Z","caller":"traceutil/trace.go:171","msg":"trace[974142634] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"130.245225ms","start":"2026-07-12T01:44:46.39154Z","end":"2026-07-12T01:44:46.521785Z","steps":["trace[974142634] 'process raft request' (duration: 130.201244ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:46.529526Z","caller":"traceutil/trace.go:171","msg":"trace[263768739] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"119.521695ms","start":"2026-07-12T01:44:46.409979Z","end":"2026-07-12T01:44:46.529501Z","steps":["trace[263768739] 'process raft request' (duration: 117.628474ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:46.5301Z","caller":"traceutil/trace.go:171","msg":"trace[1981969018] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"120.045962ms","start":"2026-07-12T01:44:46.410042Z","end":"2026-07-12T01:44:46.530088Z","steps":["trace[1981969018] 'process raft request' (duration: 117.749508ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:46.53072Z","caller":"traceutil/trace.go:171","msg":"trace[833793378] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"120.580329ms","start":"2026-07-12T01:44:46.410086Z","end":"2026-07-12T01:44:46.530667Z","steps":["trace[833793378] 'process raft request' (duration: 118.775601ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:46.53082Z","caller":"traceutil/trace.go:171","msg":"trace[1308912684] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"120.644812ms","start":"2026-07-12T01:44:46.410151Z","end":"2026-07-12T01:44:46.530795Z","steps":["trace[1308912684] 'process raft request' (duration: 119.252296ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:52.143409Z","caller":"traceutil/trace.go:171","msg":"trace[1853000004] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"107.511665ms","start":"2026-07-12T01:44:52.035856Z","end":"2026-07-12T01:44:52.143367Z","steps":["trace[1853000004] 'process raft request' (duration: 107.264378ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:52.257822Z","caller":"traceutil/trace.go:171","msg":"trace[1546006951] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"109.219217ms","start":"2026-07-12T01:44:52.148526Z","end":"2026-07-12T01:44:52.257745Z","steps":["trace[1546006951] 'process raft request' (duration: 109.040232ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:52.25821Z","caller":"traceutil/trace.go:171","msg":"trace[1314563628] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"109.035342ms","start":"2026-07-12T01:44:52.148854Z","end":"2026-07-12T01:44:52.25789Z","steps":["trace[1314563628] 'process raft request' (duration: 108.856656ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:52.653918Z","caller":"traceutil/trace.go:171","msg":"trace[1979095019] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"357.769617ms","start":"2026-07-12T01:44:52.296122Z","end":"2026-07-12T01:44:52.653892Z","steps":["trace[1979095019] 'process raft request' (duration: 357.23269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:52.654084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:52.296081Z","time spent":"357.915961ms","remote":"127.0.0.1:40234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-12T01:44:52.734666Z","caller":"traceutil/trace.go:171","msg":"trace[1421783320] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"260.024ms","start":"2026-07-12T01:44:52.474602Z","end":"2026-07-12T01:44:52.734626Z","steps":["trace[1421783320] 'process raft request' (duration: 235.044955ms)","trace[1421783320] 'compare' (duration: 24.81448ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:44:52.734682Z","caller":"traceutil/trace.go:171","msg":"trace[2023779606] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"200.923559ms","start":"2026-07-12T01:44:52.533725Z","end":"2026-07-12T01:44:52.734649Z","steps":["trace[2023779606] 'read index received' (duration: 119.428401ms)","trace[2023779606] 'applied index is now lower than readState.Index' (duration: 81.491248ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:44:52.735082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.324951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:44:52.735202Z","caller":"traceutil/trace.go:171","msg":"trace[220264981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"201.494696ms","start":"2026-07-12T01:44:52.533678Z","end":"2026-07-12T01:44:52.735172Z","steps":["trace[220264981] 'agreement among raft nodes before linearized reading' (duration: 201.088603ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:53.431222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.454176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-12T01:44:53.431435Z","caller":"traceutil/trace.go:171","msg":"trace[1940508777] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:636; }","duration":"326.685583ms","start":"2026-07-12T01:44:53.104689Z","end":"2026-07-12T01:44:53.431375Z","steps":["trace[1940508777] 'range keys from in-memory index tree' (duration: 326.310202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:53.431564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.800146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-d5pbq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-12T01:44:53.431664Z","caller":"traceutil/trace.go:171","msg":"trace[1455509193] range","detail":"{range_begin:/registry/pods/kube-system/cilium-d5pbq; range_end:; response_count:1; response_revision:636; }","duration":"570.918289ms","start":"2026-07-12T01:44:52.860722Z","end":"2026-07-12T01:44:53.43164Z","steps":["trace[1455509193] 'range keys from in-memory index tree' (duration: 570.633791ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:44:53.431705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:52.860664Z","time spent":"571.032523ms","remote":"127.0.0.1:40314","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-d5pbq\" "} {"level":"warn","ts":"2026-07-12T01:44:53.432127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:44:53.104674Z","time spent":"326.812387ms","remote":"127.0.0.1:40168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.153\" "} {"level":"info","ts":"2026-07-12T01:44:53.433218Z","caller":"traceutil/trace.go:171","msg":"trace[479054888] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"297.118076ms","start":"2026-07-12T01:44:53.136075Z","end":"2026-07-12T01:44:53.433193Z","steps":["trace[479054888] 'process raft request' (duration: 296.468577ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:55.995118Z","caller":"traceutil/trace.go:171","msg":"trace[1730227041] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"112.134785ms","start":"2026-07-12T01:44:55.882957Z","end":"2026-07-12T01:44:55.995091Z","steps":["trace[1730227041] 'process raft request' (duration: 111.657151ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:55.995199Z","caller":"traceutil/trace.go:171","msg":"trace[842843110] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"102.892611ms","start":"2026-07-12T01:44:55.892291Z","end":"2026-07-12T01:44:55.995183Z","steps":["trace[842843110] 'process raft request' (duration: 102.479549ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:56.436507Z","caller":"traceutil/trace.go:171","msg":"trace[1449441323] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"145.317441ms","start":"2026-07-12T01:44:56.291165Z","end":"2026-07-12T01:44:56.436482Z","steps":["trace[1449441323] 'process raft request' (duration: 115.298847ms)","trace[1449441323] 'compare' (duration: 29.809408ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:44:56.436721Z","caller":"traceutil/trace.go:171","msg":"trace[190407242] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"145.2856ms","start":"2026-07-12T01:44:56.291413Z","end":"2026-07-12T01:44:56.436698Z","steps":["trace[190407242] 'process raft request' (duration: 145.022722ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:56.436987Z","caller":"traceutil/trace.go:171","msg":"trace[1645162123] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"137.759548ms","start":"2026-07-12T01:44:56.299216Z","end":"2026-07-12T01:44:56.436975Z","steps":["trace[1645162123] 'process raft request' (duration: 137.416618ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:44:57.288802Z","caller":"traceutil/trace.go:171","msg":"trace[1508490478] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"101.782769ms","start":"2026-07-12T01:44:57.186993Z","end":"2026-07-12T01:44:57.288775Z","steps":["trace[1508490478] 'process raft request' (duration: 56.944142ms)","trace[1508490478] 'compare' (duration: 44.613121ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:45:08.718804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.908242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:45:08.718934Z","caller":"traceutil/trace.go:171","msg":"trace[222129065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"185.099697ms","start":"2026-07-12T01:45:08.533804Z","end":"2026-07-12T01:45:08.718904Z","steps":["trace[222129065] 'range keys from in-memory index tree' (duration: 184.82424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:45:08.718945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.651776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-12T01:45:08.718951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.998644ms","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-07-12T01:45:08.719011Z","caller":"traceutil/trace.go:171","msg":"trace[659579059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:796; }","duration":"381.764629ms","start":"2026-07-12T01:45:08.337232Z","end":"2026-07-12T01:45:08.718997Z","steps":["trace[659579059] 'range keys from in-memory index tree' (duration: 381.488492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:45:08.719041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:45:08.337214Z","time spent":"381.821131ms","remote":"127.0.0.1:40392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-12T01:45:08.719051Z","caller":"traceutil/trace.go:171","msg":"trace[433506176] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:796; }","duration":"223.142508ms","start":"2026-07-12T01:45:08.495887Z","end":"2026-07-12T01:45:08.719029Z","steps":["trace[433506176] 'range keys from in-memory index tree' (duration: 222.83099ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:45:08.71912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.666617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-12T01:45:08.719168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.215186ms","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-07-12T01:45:08.719203Z","caller":"traceutil/trace.go:171","msg":"trace[2020768857] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:796; }","duration":"224.276278ms","start":"2026-07-12T01:45:08.49491Z","end":"2026-07-12T01:45:08.719187Z","steps":["trace[2020768857] 'range keys from in-memory index tree' (duration: 224.087022ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:45:08.71921Z","caller":"traceutil/trace.go:171","msg":"trace[1550548994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:796; }","duration":"378.813111ms","start":"2026-07-12T01:45:08.340374Z","end":"2026-07-12T01:45:08.719187Z","steps":["trace[1550548994] 'range keys from in-memory index tree' (duration: 378.491383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:45:08.719251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:45:08.340356Z","time spent":"378.885653ms","remote":"127.0.0.1:40392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-12T01:46:24.36885Z","caller":"traceutil/trace.go:171","msg":"trace[212876025] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"121.865612ms","start":"2026-07-12T01:46:24.246957Z","end":"2026-07-12T01:46:24.368822Z","steps":["trace[212876025] 'process raft request' (duration: 121.682989ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:24.375051Z","caller":"traceutil/trace.go:171","msg":"trace[1324790664] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"116.040561ms","start":"2026-07-12T01:46:24.258992Z","end":"2026-07-12T01:46:24.375032Z","steps":["trace[1324790664] 'process raft request' (duration: 115.805227ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:46:40.570921Z","caller":"traceutil/trace.go:171","msg":"trace[138695460] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"147.845569ms","start":"2026-07-12T01:46:40.423049Z","end":"2026-07-12T01:46:40.570894Z","steps":["trace[138695460] 'process raft request' (duration: 147.715777ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:47:04.932642Z","caller":"traceutil/trace.go:171","msg":"trace[969961011] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"273.123379ms","start":"2026-07-12T01:47:04.65949Z","end":"2026-07-12T01:47:04.932613Z","steps":["trace[969961011] 'process raft request' (duration: 272.966487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:47:05.593401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.954398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-12T01:47:05.593493Z","caller":"traceutil/trace.go:171","msg":"trace[970956833] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2151; }","duration":"165.087419ms","start":"2026-07-12T01:47:05.428385Z","end":"2026-07-12T01:47:05.593473Z","steps":["trace[970956833] 'range keys from in-memory index tree' (duration: 164.617613ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:47:45.833259Z","caller":"traceutil/trace.go:171","msg":"trace[1037491087] transaction","detail":"{read_only:false; response_revision:2420; number_of_response:1; }","duration":"100.500194ms","start":"2026-07-12T01:47:45.732737Z","end":"2026-07-12T01:47:45.833237Z","steps":["trace[1037491087] 'process raft request' (duration: 100.363242ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:47:50.163194Z","caller":"traceutil/trace.go:171","msg":"trace[2078410402] transaction","detail":"{read_only:false; response_revision:2455; number_of_response:1; }","duration":"103.671544ms","start":"2026-07-12T01:47:50.059504Z","end":"2026-07-12T01:47:50.163175Z","steps":["trace[2078410402] 'process raft request' (duration: 103.635833ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:47:50.163254Z","caller":"traceutil/trace.go:171","msg":"trace[340148832] transaction","detail":"{read_only:false; response_revision:2454; number_of_response:1; }","duration":"110.324515ms","start":"2026-07-12T01:47:50.052901Z","end":"2026-07-12T01:47:50.163226Z","steps":["trace[340148832] 'process raft request' (duration: 106.60164ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:48:27.326801Z","caller":"traceutil/trace.go:171","msg":"trace[1188313657] transaction","detail":"{read_only:false; response_revision:2706; number_of_response:1; }","duration":"220.400312ms","start":"2026-07-12T01:48:27.106372Z","end":"2026-07-12T01:48:27.326772Z","steps":["trace[1188313657] 'process raft request' (duration: 220.18525ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:48:40.326428Z","caller":"traceutil/trace.go:171","msg":"trace[1888130891] transaction","detail":"{read_only:false; response_revision:2775; number_of_response:1; }","duration":"108.544407ms","start":"2026-07-12T01:48:40.217857Z","end":"2026-07-12T01:48:40.326402Z","steps":["trace[1888130891] 'process raft request' (duration: 108.461035ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:48:40.326443Z","caller":"traceutil/trace.go:171","msg":"trace[1860240062] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"108.653812ms","start":"2026-07-12T01:48:40.217751Z","end":"2026-07-12T01:48:40.326405Z","steps":["trace[1860240062] 'process raft request' (duration: 58.093891ms)","trace[1860240062] 'compare' (duration: 50.298702ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:48:40.32672Z","caller":"traceutil/trace.go:171","msg":"trace[618110489] transaction","detail":"{read_only:false; response_revision:2776; number_of_response:1; }","duration":"108.757365ms","start":"2026-07-12T01:48:40.217941Z","end":"2026-07-12T01:48:40.326698Z","steps":["trace[618110489] 'process raft request' (duration: 108.427264ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:48:58.340516Z","caller":"traceutil/trace.go:171","msg":"trace[1688418081] transaction","detail":"{read_only:false; response_revision:2867; number_of_response:1; }","duration":"138.229661ms","start":"2026-07-12T01:48:58.202263Z","end":"2026-07-12T01:48:58.340493Z","steps":["trace[1688418081] 'process raft request' (duration: 138.020305ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:48:58.361122Z","caller":"traceutil/trace.go:171","msg":"trace[1711000713] transaction","detail":"{read_only:false; response_revision:2868; number_of_response:1; }","duration":"101.493804ms","start":"2026-07-12T01:48:58.259607Z","end":"2026-07-12T01:48:58.3611Z","steps":["trace[1711000713] 'process raft request' (duration: 101.213246ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:48:58.560551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.459883ms","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-07-12T01:48:58.562466Z","caller":"traceutil/trace.go:171","msg":"trace[1707564905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2870; }","duration":"125.457012ms","start":"2026-07-12T01:48:58.436986Z","end":"2026-07-12T01:48:58.562443Z","steps":["trace[1707564905] 'range keys from in-memory index tree' (duration: 123.275508ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:48:58.566513Z","caller":"traceutil/trace.go:171","msg":"trace[1520912304] transaction","detail":"{read_only:false; response_revision:2871; number_of_response:1; }","duration":"108.787789ms","start":"2026-07-12T01:48:58.457702Z","end":"2026-07-12T01:48:58.56649Z","steps":["trace[1520912304] 'process raft request' (duration: 108.595653ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:48:58.566635Z","caller":"traceutil/trace.go:171","msg":"trace[1427633677] linearizableReadLoop","detail":"{readStateIndex:2978; appliedIndex:2975; }","duration":"105.333857ms","start":"2026-07-12T01:48:58.461289Z","end":"2026-07-12T01:48:58.566623Z","steps":["trace[1427633677] 'read index received' (duration: 17.057715ms)","trace[1427633677] 'applied index is now lower than readState.Index' (duration: 88.274752ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:48:58.566772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.474761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-12T01:48:58.567914Z","caller":"traceutil/trace.go:171","msg":"trace[1613557397] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2872; }","duration":"106.662156ms","start":"2026-07-12T01:48:58.461242Z","end":"2026-07-12T01:48:58.567904Z","steps":["trace[1613557397] 'agreement among raft nodes before linearized reading' (duration: 105.414759ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:48:58.566848Z","caller":"traceutil/trace.go:171","msg":"trace[432242797] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"109.102498ms","start":"2026-07-12T01:48:58.457738Z","end":"2026-07-12T01:48:58.56684Z","steps":["trace[432242797] 'process raft request' (duration: 108.708397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:48:58.57892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.423915ms","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-07-12T01:48:58.578979Z","caller":"traceutil/trace.go:171","msg":"trace[1506361052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2873; }","duration":"117.558348ms","start":"2026-07-12T01:48:58.461407Z","end":"2026-07-12T01:48:58.578965Z","steps":["trace[1506361052] 'agreement among raft nodes before linearized reading' (duration: 117.343522ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:49:18.709631Z","caller":"traceutil/trace.go:171","msg":"trace[740255568] linearizableReadLoop","detail":"{readStateIndex:3088; appliedIndex:3087; }","duration":"176.41995ms","start":"2026-07-12T01:49:18.533181Z","end":"2026-07-12T01:49:18.709601Z","steps":["trace[740255568] 'read index received' (duration: 176.305587ms)","trace[740255568] 'applied index is now lower than readState.Index' (duration: 113.243µs)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:49:18.709682Z","caller":"traceutil/trace.go:171","msg":"trace[951864170] transaction","detail":"{read_only:false; response_revision:2977; number_of_response:1; }","duration":"192.9374ms","start":"2026-07-12T01:49:18.516708Z","end":"2026-07-12T01:49:18.709645Z","steps":["trace[951864170] 'process raft request' (duration: 192.723384ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:49:18.709798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.594234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:49:18.709976Z","caller":"traceutil/trace.go:171","msg":"trace[1444176800] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2977; }","duration":"176.839602ms","start":"2026-07-12T01:49:18.533121Z","end":"2026-07-12T01:49:18.70996Z","steps":["trace[1444176800] 'agreement among raft nodes before linearized reading' (duration: 176.605085ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:49:18.750259Z","caller":"traceutil/trace.go:171","msg":"trace[723414756] transaction","detail":"{read_only:false; response_revision:2978; number_of_response:1; }","duration":"105.492576ms","start":"2026-07-12T01:49:18.644736Z","end":"2026-07-12T01:49:18.750228Z","steps":["trace[723414756] 'process raft request' (duration: 93.202941ms)","trace[723414756] 'compare' (duration: 12.08545ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:49:18.751122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.157695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-12T01:49:18.751208Z","caller":"traceutil/trace.go:171","msg":"trace[1375112017] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2979; }","duration":"124.37231ms","start":"2026-07-12T01:49:18.626813Z","end":"2026-07-12T01:49:18.751186Z","steps":["trace[1375112017] 'agreement among raft nodes before linearized reading' (duration: 123.782814ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:50:30.208777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.85622ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-12T01:50:30.208909Z","caller":"traceutil/trace.go:171","msg":"trace[981659110] transaction","detail":"{read_only:false; response_revision:3434; number_of_response:1; }","duration":"155.743202ms","start":"2026-07-12T01:50:30.053145Z","end":"2026-07-12T01:50:30.208889Z","steps":["trace[981659110] 'process raft request' (duration: 40.432073ms)","trace[981659110] 'compare' (duration: 114.662085ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:50:30.226976Z","caller":"traceutil/trace.go:171","msg":"trace[1438386058] transaction","detail":"{read_only:false; response_revision:3435; number_of_response:1; }","duration":"149.535399ms","start":"2026-07-12T01:50:30.077414Z","end":"2026-07-12T01:50:30.22695Z","steps":["trace[1438386058] 'process raft request' (duration: 149.407157ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:50:42.180492Z","caller":"traceutil/trace.go:171","msg":"trace[20166031] transaction","detail":"{read_only:false; response_revision:3501; number_of_response:1; }","duration":"183.448514ms","start":"2026-07-12T01:50:41.997018Z","end":"2026-07-12T01:50:42.180466Z","steps":["trace[20166031] 'process raft request' (duration: 183.296161ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:11.12468Z","caller":"traceutil/trace.go:171","msg":"trace[2098080004] transaction","detail":"{read_only:false; response_revision:4439; number_of_response:1; }","duration":"126.237942ms","start":"2026-07-12T01:52:10.998414Z","end":"2026-07-12T01:52:11.124652Z","steps":["trace[2098080004] 'process raft request' (duration: 125.949437ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:11.128225Z","caller":"traceutil/trace.go:171","msg":"trace[2050407374] linearizableReadLoop","detail":"{readStateIndex:4609; appliedIndex:4607; }","duration":"123.76368ms","start":"2026-07-12T01:52:11.004447Z","end":"2026-07-12T01:52:11.12821Z","steps":["trace[2050407374] 'read index received' (duration: 119.728821ms)","trace[2050407374] 'applied index is now lower than readState.Index' (duration: 4.034349ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:52:11.128314Z","caller":"traceutil/trace.go:171","msg":"trace[1904557074] transaction","detail":"{read_only:false; response_revision:4440; number_of_response:1; }","duration":"129.600779ms","start":"2026-07-12T01:52:10.998696Z","end":"2026-07-12T01:52:11.128297Z","steps":["trace[1904557074] 'process raft request' (duration: 129.411026ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:11.128537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.082996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/local-path-storage/\" range_end:\"/registry/resourcequotas/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:52:11.128568Z","caller":"traceutil/trace.go:171","msg":"trace[726589867] range","detail":"{range_begin:/registry/resourcequotas/local-path-storage/; range_end:/registry/resourcequotas/local-path-storage0; response_count:0; response_revision:4441; }","duration":"124.130057ms","start":"2026-07-12T01:52:11.00443Z","end":"2026-07-12T01:52:11.12856Z","steps":["trace[726589867] 'agreement among raft nodes before linearized reading' (duration: 124.068676ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:11.128879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.368132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:46617"} {"level":"info","ts":"2026-07-12T01:52:11.128901Z","caller":"traceutil/trace.go:171","msg":"trace[824648211] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4441; }","duration":"120.411622ms","start":"2026-07-12T01:52:11.008484Z","end":"2026-07-12T01:52:11.128895Z","steps":["trace[824648211] 'agreement among raft nodes before linearized reading' (duration: 120.24625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:11.129034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.503794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:52:11.129053Z","caller":"traceutil/trace.go:171","msg":"trace[1166571044] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4441; }","duration":"120.537395ms","start":"2026-07-12T01:52:11.008511Z","end":"2026-07-12T01:52:11.129048Z","steps":["trace[1166571044] 'agreement among raft nodes before linearized reading' (duration: 120.505615ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:20.660423Z","caller":"traceutil/trace.go:171","msg":"trace[1663665621] linearizableReadLoop","detail":"{readStateIndex:4788; appliedIndex:4786; }","duration":"124.567793ms","start":"2026-07-12T01:52:20.535825Z","end":"2026-07-12T01:52:20.660393Z","steps":["trace[1663665621] 'read index received' (duration: 11.441712ms)","trace[1663665621] 'applied index is now lower than readState.Index' (duration: 113.124811ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:52:20.660448Z","caller":"traceutil/trace.go:171","msg":"trace[6359691] transaction","detail":"{read_only:false; response_revision:4615; number_of_response:1; }","duration":"125.962867ms","start":"2026-07-12T01:52:20.534433Z","end":"2026-07-12T01:52:20.660396Z","steps":["trace[6359691] 'process raft request' (duration: 125.53304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:20.660784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.91298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-07-12T01:52:20.66087Z","caller":"traceutil/trace.go:171","msg":"trace[18916794] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4616; }","duration":"125.041562ms","start":"2026-07-12T01:52:20.535811Z","end":"2026-07-12T01:52:20.660853Z","steps":["trace[18916794] 'agreement among raft nodes before linearized reading' (duration: 124.713356ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:20.662182Z","caller":"traceutil/trace.go:171","msg":"trace[967970727] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"117.625998ms","start":"2026-07-12T01:52:20.542843Z","end":"2026-07-12T01:52:20.660469Z","steps":["trace[967970727] 'process raft request' (duration: 117.409654ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:21.500053Z","caller":"traceutil/trace.go:171","msg":"trace[475663035] linearizableReadLoop","detail":"{readStateIndex:4854; appliedIndex:4853; }","duration":"108.754255ms","start":"2026-07-12T01:52:21.391263Z","end":"2026-07-12T01:52:21.500017Z","steps":["trace[475663035] 'read index received' (duration: 99.421479ms)","trace[475663035] 'applied index is now lower than readState.Index' (duration: 9.330436ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:52:21.500264Z","caller":"traceutil/trace.go:171","msg":"trace[1084435972] transaction","detail":"{read_only:false; response_revision:4678; number_of_response:1; }","duration":"110.363592ms","start":"2026-07-12T01:52:21.38988Z","end":"2026-07-12T01:52:21.500243Z","steps":["trace[1084435972] 'process raft request' (duration: 100.881453ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:21.500804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.508518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-07-12T01:52:21.501016Z","caller":"traceutil/trace.go:171","msg":"trace[420450289] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4680; }","duration":"109.747921ms","start":"2026-07-12T01:52:21.391248Z","end":"2026-07-12T01:52:21.500995Z","steps":["trace[420450289] 'agreement among raft nodes before linearized reading' (duration: 108.984979ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:22.261944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.350596ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-12T01:52:22.262045Z","caller":"traceutil/trace.go:171","msg":"trace[1204047093] linearizableReadLoop","detail":"{readStateIndex:4873; appliedIndex:4872; }","duration":"171.775158ms","start":"2026-07-12T01:52:22.090253Z","end":"2026-07-12T01:52:22.262028Z","steps":["trace[1204047093] 'read index received' (duration: 23.203619ms)","trace[1204047093] 'applied index is now lower than readState.Index' (duration: 148.570179ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:52:22.262139Z","caller":"traceutil/trace.go:171","msg":"trace[1525656420] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"187.931389ms","start":"2026-07-12T01:52:22.074194Z","end":"2026-07-12T01:52:22.262126Z","steps":["trace[1525656420] 'process raft request' (duration: 39.300608ms)","trace[1525656420] 'compare' (duration: 148.237914ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:52:22.262504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.254457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de0d0221-1756-482d-8ed5-f9e9a8b9317a\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-12T01:52:22.262538Z","caller":"traceutil/trace.go:171","msg":"trace[1593370256] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-de0d0221-1756-482d-8ed5-f9e9a8b9317a; range_end:; response_count:1; response_revision:4697; }","duration":"172.322307ms","start":"2026-07-12T01:52:22.090204Z","end":"2026-07-12T01:52:22.262526Z","steps":["trace[1593370256] 'agreement among raft nodes before linearized reading' (duration: 172.138594ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:22.262701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.663981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-12T01:52:22.262727Z","caller":"traceutil/trace.go:171","msg":"trace[975443213] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:4697; }","duration":"108.735763ms","start":"2026-07-12T01:52:22.153984Z","end":"2026-07-12T01:52:22.26272Z","steps":["trace[975443213] 'agreement among raft nodes before linearized reading' (duration: 108.689782ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:39.487607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.566603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-12T01:52:39.487837Z","caller":"traceutil/trace.go:171","msg":"trace[1617312671] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"270.888409ms","start":"2026-07-12T01:52:39.216932Z","end":"2026-07-12T01:52:39.487821Z","steps":["trace[1617312671] 'process raft request' (duration: 270.834668ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:39.487971Z","caller":"traceutil/trace.go:171","msg":"trace[186106993] linearizableReadLoop","detail":"{readStateIndex:5075; appliedIndex:5074; }","duration":"394.752645ms","start":"2026-07-12T01:52:39.093193Z","end":"2026-07-12T01:52:39.487945Z","steps":["trace[186106993] 'read index received' (duration: 32.741µs)","trace[186106993] 'applied index is now lower than readState.Index' (duration: 394.717454ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:52:39.487936Z","caller":"traceutil/trace.go:171","msg":"trace[1541999553] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"665.671518ms","start":"2026-07-12T01:52:38.822228Z","end":"2026-07-12T01:52:39.487899Z","steps":["trace[1541999553] 'process raft request' (duration: 133.738109ms)","trace[1541999553] 'compare' (duration: 531.474442ms)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:52:39.488097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.885767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-12T01:52:39.488119Z","caller":"traceutil/trace.go:171","msg":"trace[1259597278] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:4893; }","duration":"394.960238ms","start":"2026-07-12T01:52:39.093151Z","end":"2026-07-12T01:52:39.488111Z","steps":["trace[1259597278] 'agreement among raft nodes before linearized reading' (duration: 394.896916ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:39.488138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:52:39.093131Z","time spent":"395.001099ms","remote":"127.0.0.1:40604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-07-12T01:52:39.488144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-12T01:52:38.82219Z","time spent":"665.859212ms","remote":"127.0.0.1:40392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-12T01:52:39.488193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.410187ms","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-07-12T01:52:39.488249Z","caller":"traceutil/trace.go:171","msg":"trace[1917563652] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4893; }","duration":"192.497098ms","start":"2026-07-12T01:52:39.295735Z","end":"2026-07-12T01:52:39.488232Z","steps":["trace[1917563652] 'agreement among raft nodes before linearized reading' (duration: 192.340715ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:39.711495Z","caller":"traceutil/trace.go:171","msg":"trace[239760922] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"145.058752ms","start":"2026-07-12T01:52:39.566418Z","end":"2026-07-12T01:52:39.711477Z","steps":["trace[239760922] 'process raft request' (duration: 144.898379ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:39.711682Z","caller":"traceutil/trace.go:171","msg":"trace[657985132] linearizableReadLoop","detail":"{readStateIndex:5079; appliedIndex:5077; }","duration":"111.470163ms","start":"2026-07-12T01:52:39.600193Z","end":"2026-07-12T01:52:39.711663Z","steps":["trace[657985132] 'read index received' (duration: 111.111447ms)","trace[657985132] 'applied index is now lower than readState.Index' (duration: 357.786µs)"],"step_count":2} {"level":"warn","ts":"2026-07-12T01:52:39.712017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.808468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-12T01:52:39.712061Z","caller":"traceutil/trace.go:171","msg":"trace[1013717074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4896; }","duration":"111.91468ms","start":"2026-07-12T01:52:39.600136Z","end":"2026-07-12T01:52:39.71205Z","steps":["trace[1013717074] 'agreement among raft nodes before linearized reading' (duration: 111.788188ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:39.712067Z","caller":"traceutil/trace.go:171","msg":"trace[112570956] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"144.95931ms","start":"2026-07-12T01:52:39.567076Z","end":"2026-07-12T01:52:39.712035Z","steps":["trace[112570956] 'process raft request' (duration: 144.37365ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:40.450556Z","caller":"traceutil/trace.go:171","msg":"trace[978401940] linearizableReadLoop","detail":"{readStateIndex:5085; appliedIndex:5084; }","duration":"215.020481ms","start":"2026-07-12T01:52:40.235518Z","end":"2026-07-12T01:52:40.450538Z","steps":["trace[978401940] 'read index received' (duration: 214.863809ms)","trace[978401940] 'applied index is now lower than readState.Index' (duration: 156.102µs)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:52:40.450634Z","caller":"traceutil/trace.go:171","msg":"trace[2064736959] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"216.213651ms","start":"2026-07-12T01:52:40.234415Z","end":"2026-07-12T01:52:40.450628Z","steps":["trace[2064736959] 'process raft request' (duration: 216.027758ms)"],"step_count":1} {"level":"warn","ts":"2026-07-12T01:52:40.451005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.085884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-07-12T01:52:40.451062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.512279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16552"} {"level":"info","ts":"2026-07-12T01:52:40.451106Z","caller":"traceutil/trace.go:171","msg":"trace[1757682468] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4902; }","duration":"149.213417ms","start":"2026-07-12T01:52:40.301851Z","end":"2026-07-12T01:52:40.451065Z","steps":["trace[1757682468] 'agreement among raft nodes before linearized reading' (duration: 148.871301ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:52:40.451139Z","caller":"traceutil/trace.go:171","msg":"trace[1199418400] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4902; }","duration":"215.634371ms","start":"2026-07-12T01:52:40.235483Z","end":"2026-07-12T01:52:40.451118Z","steps":["trace[1199418400] 'agreement among raft nodes before linearized reading' (duration: 215.371416ms)"],"step_count":1} {"level":"info","ts":"2026-07-12T01:53:33.802414Z","caller":"traceutil/trace.go:171","msg":"trace[1371735787] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"103.630813ms","start":"2026-07-12T01:53:33.698736Z","end":"2026-07-12T01:53:33.802367Z","steps":["trace[1371735787] 'process raft request' (duration: 54.810092ms)","trace[1371735787] 'compare' (duration: 47.974828ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:54:10.068334Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2929} {"level":"info","ts":"2026-07-12T01:54:10.205666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2929,"took":"135.733593ms","hash":3142914547,"current-db-size-bytes":53948416,"current-db-size":"54 MB","current-db-size-in-use-bytes":29560832,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-12T01:54:10.205727Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3142914547,"revision":2929,"compact-revision":-1} {"level":"warn","ts":"2026-07-12T01:56:26.625675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.675206ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-12T01:56:26.62614Z","caller":"traceutil/trace.go:171","msg":"trace[1745435443] transaction","detail":"{read_only:false; response_revision:6540; number_of_response:1; }","duration":"163.656929ms","start":"2026-07-12T01:56:26.462461Z","end":"2026-07-12T01:56:26.626118Z","steps":["trace[1745435443] 'process raft request' (duration: 40.431875ms)","trace[1745435443] 'compare' (duration: 122.460003ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:56:47.303887Z","caller":"traceutil/trace.go:171","msg":"trace[1586030741] transaction","detail":"{read_only:false; response_revision:6702; number_of_response:1; }","duration":"176.546227ms","start":"2026-07-12T01:56:47.127301Z","end":"2026-07-12T01:56:47.303847Z","steps":["trace[1586030741] 'process raft request' (duration: 116.42064ms)","trace[1586030741] 'compare' (duration: 60.040555ms)"],"step_count":2} {"level":"info","ts":"2026-07-12T01:59:10.073566Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5644} {"level":"info","ts":"2026-07-12T01:59:10.160702Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5644,"took":"86.009244ms","hash":1199308988,"current-db-size-bytes":53948416,"current-db-size":"54 MB","current-db-size-in-use-bytes":18468864,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-12T01:59:10.160759Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1199308988,"revision":5644,"compact-revision":2929}