{"level":"warn","ts":"2026-09-01T04:17:05.237496Z","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-01T04:17:05.237584Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195: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.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-01T04:17:05.237652Z","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-01T04:17:05.237662Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-09-01T04:17:05.237684Z","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-01T04:17:05.238441Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]} {"level":"info","ts":"2026-09-01T04:17:05.238518Z","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.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-01T04:17:05.245899Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.152934ms"} {"level":"info","ts":"2026-09-01T04:17:05.268067Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-09-01T04:17:05.268295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T04:17:05.268345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-09-01T04:17:05.268368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T04:17:05.268385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-09-01T04:17:05.268463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-09-01T04:17:05.274824Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T04:17:05.276265Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T04:17:05.277263Z","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-01T04:17:05.279143Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T04:17:05.279388Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T04:17:05.279545Z","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-01T04:17:05.279599Z","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-01T04:17:05.279607Z","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-01T04:17:05.286234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-09-01T04:17:05.290247Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-09-01T04:17:05.291995Z","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-01T04:17:05.292199Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-09-01T04:17:05.292278Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-09-01T04:17:05.292319Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T04:17:05.292356Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T04:17:05.56954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T04:17:05.569784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T04:17:05.569919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-09-01T04:17:05.570013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-09-01T04:17:05.570111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-09-01T04:17:05.570189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-09-01T04:17:05.570279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-09-01T04:17:05.571881Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T04:17:05.572243Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:17:05.572332Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T04:17:05.572426Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T04:17:05.57238Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:17:05.572281Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:17:05.573295Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:17:05.5735Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:17:05.573574Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:17:05.574938Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T04:17:05.577139Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-09-01T04:17:08.248145Z","caller":"traceutil/trace.go:171","msg":"trace[2089854523] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"120.35343ms","start":"2026-09-01T04:17:08.127779Z","end":"2026-09-01T04:17:08.248133Z","steps":["trace[2089854523] 'process raft request' (duration: 120.173436ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:17:08.248128Z","caller":"traceutil/trace.go:171","msg":"trace[893457022] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"118.688811ms","start":"2026-09-01T04:17:08.129409Z","end":"2026-09-01T04:17:08.248098Z","steps":["trace[893457022] 'read index received' (duration: 118.473236ms)","trace[893457022] 'applied index is now lower than readState.Index' (duration: 214.745µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:17:08.24835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.882915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-01T04:17:08.248502Z","caller":"traceutil/trace.go:171","msg":"trace[614152809] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:72; }","duration":"119.098631ms","start":"2026-09-01T04:17:08.129384Z","end":"2026-09-01T04:17:08.248483Z","steps":["trace[614152809] 'agreement among raft nodes before linearized reading' (duration: 118.826753ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:14.472108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.873043ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:17:14.472246Z","caller":"traceutil/trace.go:171","msg":"trace[1408822194] linearizableReadLoop","detail":"{readStateIndex:346; appliedIndex:345; }","duration":"795.2002ms","start":"2026-09-01T04:17:13.677026Z","end":"2026-09-01T04:17:14.472226Z","steps":["trace[1408822194] 'read index received' (duration: 273.893566ms)","trace[1408822194] 'applied index is now lower than readState.Index' (duration: 521.305343ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:17:14.472368Z","caller":"traceutil/trace.go:171","msg":"trace[1265716928] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"846.397201ms","start":"2026-09-01T04:17:13.625906Z","end":"2026-09-01T04:17:14.472303Z","steps":["trace[1265716928] 'process raft request' (duration: 324.75269ms)","trace[1265716928] 'compare' (duration: 520.69164ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:17:14.472517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.469466ms","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-01T04:17:14.472578Z","caller":"traceutil/trace.go:171","msg":"trace[767459387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:332; }","duration":"795.594489ms","start":"2026-09-01T04:17:13.676965Z","end":"2026-09-01T04:17:14.47256Z","steps":["trace[767459387] 'agreement among raft nodes before linearized reading' (duration: 795.426905ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:14.472582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.426704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-01T04:17:14.472638Z","caller":"traceutil/trace.go:171","msg":"trace[767439141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:332; }","duration":"411.527086ms","start":"2026-09-01T04:17:14.061095Z","end":"2026-09-01T04:17:14.472622Z","steps":["trace[767439141] 'agreement among raft nodes before linearized reading' (duration: 411.438204ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:14.472608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:13.625836Z","time spent":"846.662316ms","remote":"127.0.0.1:35692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":176,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T04:17:14.472631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:13.67694Z","time spent":"795.67347ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-01T04:17:14.472824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:14.061067Z","time spent":"411.612287ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-01T04:17:14.472796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.477663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-09-01T04:17:14.472945Z","caller":"traceutil/trace.go:171","msg":"trace[2038735874] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:332; }","duration":"374.694837ms","start":"2026-09-01T04:17:14.098219Z","end":"2026-09-01T04:17:14.472914Z","steps":["trace[2038735874] 'agreement among raft nodes before linearized reading' (duration: 374.405911ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:14.473011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:14.098192Z","time spent":"374.80492ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-01T04:17:15.165294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.481287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:17:15.165423Z","caller":"traceutil/trace.go:171","msg":"trace[143456622] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"688.128261ms","start":"2026-09-01T04:17:14.477273Z","end":"2026-09-01T04:17:15.165401Z","steps":["trace[143456622] 'process raft request' (duration: 461.241424ms)","trace[143456622] 'compare' (duration: 226.303443ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:17:15.165486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:14.477255Z","time spent":"688.203102ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:17:15.286521Z","caller":"traceutil/trace.go:171","msg":"trace[74375060] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"809.128775ms","start":"2026-09-01T04:17:14.477362Z","end":"2026-09-01T04:17:15.286491Z","steps":["trace[74375060] 'process raft request' (duration: 790.654684ms)","trace[74375060] 'compare' (duration: 18.301288ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:17:15.286699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:14.477343Z","time spent":"809.269428ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:17:15.286704Z","caller":"traceutil/trace.go:171","msg":"trace[148376537] linearizableReadLoop","detail":"{readStateIndex:349; appliedIndex:346; }","duration":"807.056908ms","start":"2026-09-01T04:17:14.479604Z","end":"2026-09-01T04:17:15.286661Z","steps":["trace[148376537] 'read index received' (duration: 458.89451ms)","trace[148376537] 'applied index is now lower than readState.Index' (duration: 348.159368ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:17:15.286928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.289704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-01T04:17:15.286916Z","caller":"traceutil/trace.go:171","msg":"trace[168635911] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"808.800698ms","start":"2026-09-01T04:17:14.478037Z","end":"2026-09-01T04:17:15.286838Z","steps":["trace[168635911] 'process raft request' (duration: 808.415068ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:17:15.286967Z","caller":"traceutil/trace.go:171","msg":"trace[1032759167] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:335; }","duration":"807.400566ms","start":"2026-09-01T04:17:14.479551Z","end":"2026-09-01T04:17:15.286952Z","steps":["trace[1032759167] 'agreement among raft nodes before linearized reading' (duration: 807.235272ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:17:15.287017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:14.479528Z","time spent":"807.479968ms","remote":"127.0.0.1:35600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-01T04:17:15.287091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:17:14.478005Z","time spent":"808.994752ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:18:08.661493Z","caller":"traceutil/trace.go:171","msg":"trace[944450191] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"132.335583ms","start":"2026-09-01T04:18:08.529121Z","end":"2026-09-01T04:18:08.661457Z","steps":["trace[944450191] 'process raft request' (duration: 131.442729ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:09.214476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.919415ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:18:09.21465Z","caller":"traceutil/trace.go:171","msg":"trace[814684297] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:679; }","duration":"130.151019ms","start":"2026-09-01T04:18:09.084473Z","end":"2026-09-01T04:18:09.214624Z","steps":["trace[814684297] 'range keys from in-memory index tree' (duration: 129.901285ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:09.214706Z","caller":"traceutil/trace.go:171","msg":"trace[568138451] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"163.733134ms","start":"2026-09-01T04:18:09.050941Z","end":"2026-09-01T04:18:09.214674Z","steps":["trace[568138451] 'process raft request' (duration: 139.070355ms)","trace[568138451] 'compare' (duration: 24.016409ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:18:09.709158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.529222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:18:09.709632Z","caller":"traceutil/trace.go:171","msg":"trace[2107867019] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"471.523212ms","start":"2026-09-01T04:18:09.238028Z","end":"2026-09-01T04:18:09.709552Z","steps":["trace[2107867019] 'process raft request' (duration: 85.497094ms)","trace[2107867019] 'compare' (duration: 385.148185ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:18:09.709736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.503137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-01T04:18:09.709828Z","caller":"traceutil/trace.go:171","msg":"trace[1530597616] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:682; }","duration":"420.63206ms","start":"2026-09-01T04:18:09.289173Z","end":"2026-09-01T04:18:09.709806Z","steps":["trace[1530597616] 'agreement among raft nodes before linearized reading' (duration: 420.493588ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:09.709849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:09.237999Z","time spent":"471.737325ms","remote":"127.0.0.1:35672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:18:09.70988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:09.289152Z","time spent":"420.718381ms","remote":"127.0.0.1:35762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-09-01T04:18:09.709794Z","caller":"traceutil/trace.go:171","msg":"trace[60241721] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:712; }","duration":"420.126972ms","start":"2026-09-01T04:18:09.289219Z","end":"2026-09-01T04:18:09.709346Z","steps":["trace[60241721] 'read index received' (duration: 34.210485ms)","trace[60241721] 'applied index is now lower than readState.Index' (duration: 385.914707ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:18:09.929212Z","caller":"traceutil/trace.go:171","msg":"trace[601357959] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:713; }","duration":"218.993013ms","start":"2026-09-01T04:18:09.71019Z","end":"2026-09-01T04:18:09.929183Z","steps":["trace[601357959] 'read index received' (duration: 217.556881ms)","trace[601357959] 'applied index is now lower than readState.Index' (duration: 1.434302ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:18:09.92931Z","caller":"traceutil/trace.go:171","msg":"trace[1842905543] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"558.70907ms","start":"2026-09-01T04:18:09.370558Z","end":"2026-09-01T04:18:09.929267Z","steps":["trace[1842905543] 'process raft request' (duration: 557.111926ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:09.92948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.417524ms","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-01T04:18:09.929514Z","caller":"traceutil/trace.go:171","msg":"trace[1295430025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:683; }","duration":"289.534466ms","start":"2026-09-01T04:18:09.639969Z","end":"2026-09-01T04:18:09.929504Z","steps":["trace[1295430025] 'agreement among raft nodes before linearized reading' (duration: 289.368533ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:09.929552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:09.370516Z","time spent":"558.863833ms","remote":"127.0.0.1:36014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T04:18:09.92987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.974593ms","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-01T04:18:09.929949Z","caller":"traceutil/trace.go:171","msg":"trace[1467009323] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:683; }","duration":"329.154655ms","start":"2026-09-01T04:18:09.600774Z","end":"2026-09-01T04:18:09.929928Z","steps":["trace[1467009323] 'agreement among raft nodes before linearized reading' (duration: 328.839859ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:09.929936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.61992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-01T04:18:09.930028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:09.600682Z","time spent":"329.306028ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-01T04:18:09.930167Z","caller":"traceutil/trace.go:171","msg":"trace[207268554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:683; }","duration":"168.832624ms","start":"2026-09-01T04:18:09.761206Z","end":"2026-09-01T04:18:09.930039Z","steps":["trace[207268554] 'agreement among raft nodes before linearized reading' (duration: 168.420177ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:09.930198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.401742ms","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-09-01T04:18:09.93024Z","caller":"traceutil/trace.go:171","msg":"trace[1913493416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:683; }","duration":"419.499322ms","start":"2026-09-01T04:18:09.510728Z","end":"2026-09-01T04:18:09.930227Z","steps":["trace[1913493416] 'agreement among raft nodes before linearized reading' (duration: 419.407741ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:09.930265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:18:09.510695Z","time spent":"419.563244ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-01T04:18:11.466543Z","caller":"traceutil/trace.go:171","msg":"trace[260481745] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:742; }","duration":"137.54418ms","start":"2026-09-01T04:18:11.328984Z","end":"2026-09-01T04:18:11.466528Z","steps":["trace[260481745] 'read index received' (duration: 3.227959ms)","trace[260481745] 'applied index is now lower than readState.Index' (duration: 134.315701ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:18:11.466636Z","caller":"traceutil/trace.go:171","msg":"trace[696566246] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"137.707802ms","start":"2026-09-01T04:18:11.328909Z","end":"2026-09-01T04:18:11.466617Z","steps":["trace[696566246] 'process raft request' (duration: 137.59049ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:11.466735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.724082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:18:11.466946Z","caller":"traceutil/trace.go:171","msg":"trace[966440866] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"137.954926ms","start":"2026-09-01T04:18:11.328938Z","end":"2026-09-01T04:18:11.466893Z","steps":["trace[966440866] 'agreement among raft nodes before linearized reading' (duration: 137.692082ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:11.467175Z","caller":"traceutil/trace.go:171","msg":"trace[1089764817] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"137.898495ms","start":"2026-09-01T04:18:11.328697Z","end":"2026-09-01T04:18:11.466596Z","steps":["trace[1089764817] 'process raft request' (duration: 132.227869ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:11.477427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.282404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:18:11.477486Z","caller":"traceutil/trace.go:171","msg":"trace[410039436] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"135.241046ms","start":"2026-09-01T04:18:11.342203Z","end":"2026-09-01T04:18:11.477444Z","steps":["trace[410039436] 'process raft request' (duration: 135.068274ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:11.477508Z","caller":"traceutil/trace.go:171","msg":"trace[888857310] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:715; }","duration":"148.372375ms","start":"2026-09-01T04:18:11.32911Z","end":"2026-09-01T04:18:11.477482Z","steps":["trace[888857310] 'agreement among raft nodes before linearized reading' (duration: 148.227203ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:11.477779Z","caller":"traceutil/trace.go:171","msg":"trace[1149592179] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"135.589361ms","start":"2026-09-01T04:18:11.342173Z","end":"2026-09-01T04:18:11.477762Z","steps":["trace[1149592179] 'process raft request' (duration: 134.968462ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:19:52.228814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.820937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:19:52.228935Z","caller":"traceutil/trace.go:171","msg":"trace[291830948] linearizableReadLoop","detail":"{readStateIndex:2040; appliedIndex:2039; }","duration":"127.420329ms","start":"2026-09-01T04:19:52.101494Z","end":"2026-09-01T04:19:52.228915Z","steps":["trace[291830948] 'read index received' (duration: 71.201µs)","trace[291830948] 'applied index is now lower than readState.Index' (duration: 127.348188ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:19:52.229012Z","caller":"traceutil/trace.go:171","msg":"trace[2084439174] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"268.218369ms","start":"2026-09-01T04:19:51.96077Z","end":"2026-09-01T04:19:52.228989Z","steps":["trace[2084439174] 'process raft request' (duration: 121.112249ms)","trace[2084439174] 'compare' (duration: 146.663676ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:19:52.229076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.253677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:19:52.229114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.621502ms","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-09-01T04:19:52.229119Z","caller":"traceutil/trace.go:171","msg":"trace[516853822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1959; }","duration":"118.329877ms","start":"2026-09-01T04:19:52.110776Z","end":"2026-09-01T04:19:52.229106Z","steps":["trace[516853822] 'agreement among raft nodes before linearized reading' (duration: 118.260957ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:19:52.229138Z","caller":"traceutil/trace.go:171","msg":"trace[1926847066] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1959; }","duration":"127.687122ms","start":"2026-09-01T04:19:52.101443Z","end":"2026-09-01T04:19:52.22913Z","steps":["trace[1926847066] 'agreement among raft nodes before linearized reading' (duration: 127.56116ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:19:52.866672Z","caller":"traceutil/trace.go:171","msg":"trace[363749039] linearizableReadLoop","detail":"{readStateIndex:2046; appliedIndex:2045; }","duration":"151.061224ms","start":"2026-09-01T04:19:52.715569Z","end":"2026-09-01T04:19:52.86663Z","steps":["trace[363749039] 'read index received' (duration: 150.595849ms)","trace[363749039] 'applied index is now lower than readState.Index' (duration: 463.665µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:19:52.867194Z","caller":"traceutil/trace.go:171","msg":"trace[1462340214] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"173.891981ms","start":"2026-09-01T04:19:52.693232Z","end":"2026-09-01T04:19:52.867124Z","steps":["trace[1462340214] 'process raft request' (duration: 173.069242ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:19:52.867255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.293227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T04:19:52.867328Z","caller":"traceutil/trace.go:171","msg":"trace[1280308113] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"127.590221ms","start":"2026-09-01T04:19:52.739693Z","end":"2026-09-01T04:19:52.867283Z","steps":["trace[1280308113] 'process raft request' (duration: 127.405119ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:19:52.867471Z","caller":"traceutil/trace.go:171","msg":"trace[1531664020] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1965; }","duration":"151.871994ms","start":"2026-09-01T04:19:52.715495Z","end":"2026-09-01T04:19:52.867367Z","steps":["trace[1531664020] 'agreement among raft nodes before linearized reading' (duration: 151.285137ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:20:05.01878Z","caller":"traceutil/trace.go:171","msg":"trace[1298678280] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"111.144807ms","start":"2026-09-01T04:20:04.907612Z","end":"2026-09-01T04:20:05.018757Z","steps":["trace[1298678280] 'process raft request' (duration: 110.995736ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:20:26.621985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.376181ms","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-09-01T04:20:26.622135Z","caller":"traceutil/trace.go:171","msg":"trace[1276588238] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2196; }","duration":"153.57776ms","start":"2026-09-01T04:20:26.46853Z","end":"2026-09-01T04:20:26.622108Z","steps":["trace[1276588238] 'range keys from in-memory index tree' (duration: 153.154491ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:20:27.34803Z","caller":"traceutil/trace.go:171","msg":"trace[284285702] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"236.762464ms","start":"2026-09-01T04:20:27.111253Z","end":"2026-09-01T04:20:27.348016Z","steps":["trace[284285702] 'process raft request' (duration: 236.66ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:20:27.348145Z","caller":"traceutil/trace.go:171","msg":"trace[1422585524] linearizableReadLoop","detail":"{readStateIndex:2290; appliedIndex:2290; }","duration":"236.195869ms","start":"2026-09-01T04:20:27.11194Z","end":"2026-09-01T04:20:27.348136Z","steps":["trace[1422585524] 'read index received' (duration: 236.189638ms)","trace[1422585524] 'applied index is now lower than readState.Index' (duration: 4.901µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:20:27.348204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.256212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:20:27.348227Z","caller":"traceutil/trace.go:171","msg":"trace[970856202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2201; }","duration":"236.311343ms","start":"2026-09-01T04:20:27.11191Z","end":"2026-09-01T04:20:27.348221Z","steps":["trace[970856202] 'agreement among raft nodes before linearized reading' (duration: 236.259031ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:20:28.637618Z","caller":"traceutil/trace.go:171","msg":"trace[952871919] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"183.073555ms","start":"2026-09-01T04:20:28.454506Z","end":"2026-09-01T04:20:28.637579Z","steps":["trace[952871919] 'process raft request' (duration: 182.657497ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:32.346173Z","caller":"traceutil/trace.go:171","msg":"trace[1371665073] transaction","detail":"{read_only:false; response_revision:2617; number_of_response:1; }","duration":"101.617348ms","start":"2026-09-01T04:21:32.244423Z","end":"2026-09-01T04:21:32.34604Z","steps":["trace[1371665073] 'process raft request' (duration: 68.386125ms)","trace[1371665073] 'compare' (duration: 33.080708ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:21:36.601839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.493342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-01T04:21:36.601939Z","caller":"traceutil/trace.go:171","msg":"trace[2074940409] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2675; }","duration":"168.649636ms","start":"2026-09-01T04:21:36.433262Z","end":"2026-09-01T04:21:36.601912Z","steps":["trace[2074940409] 'range keys from in-memory index tree' (duration: 168.282325ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:21:37.870282Z","caller":"traceutil/trace.go:171","msg":"trace[1080903646] transaction","detail":"{read_only:false; response_revision:2683; number_of_response:1; }","duration":"163.800118ms","start":"2026-09-01T04:21:37.706438Z","end":"2026-09-01T04:21:37.870238Z","steps":["trace[1080903646] 'process raft request' (duration: 160.841323ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:14.151718Z","caller":"traceutil/trace.go:171","msg":"trace[1861934158] transaction","detail":"{read_only:false; response_revision:2881; number_of_response:1; }","duration":"119.655336ms","start":"2026-09-01T04:22:14.032021Z","end":"2026-09-01T04:22:14.151677Z","steps":["trace[1861934158] 'process raft request' (duration: 119.361738ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:14.166712Z","caller":"traceutil/trace.go:171","msg":"trace[175193960] transaction","detail":"{read_only:false; response_revision:2882; number_of_response:1; }","duration":"106.448484ms","start":"2026-09-01T04:22:14.060225Z","end":"2026-09-01T04:22:14.166674Z","steps":["trace[175193960] 'process raft request' (duration: 106.190117ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:14.166948Z","caller":"traceutil/trace.go:171","msg":"trace[1574734952] transaction","detail":"{read_only:false; response_revision:2883; number_of_response:1; }","duration":"103.995936ms","start":"2026-09-01T04:22:14.062835Z","end":"2026-09-01T04:22:14.166831Z","steps":["trace[1574734952] 'process raft request' (duration: 103.747519ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:14.427119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.354096ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-01T04:22:14.42748Z","caller":"traceutil/trace.go:171","msg":"trace[715338406] transaction","detail":"{read_only:false; response_revision:2885; number_of_response:1; }","duration":"196.837106ms","start":"2026-09-01T04:22:14.230618Z","end":"2026-09-01T04:22:14.427455Z","steps":["trace[715338406] 'process raft request' (duration: 196.657491ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:14.427541Z","caller":"traceutil/trace.go:171","msg":"trace[1456506055] linearizableReadLoop","detail":"{readStateIndex:2997; appliedIndex:2996; }","duration":"258.848639ms","start":"2026-09-01T04:22:14.168627Z","end":"2026-09-01T04:22:14.427476Z","steps":["trace[1456506055] 'read index received' (duration: 134.144884ms)","trace[1456506055] 'applied index is now lower than readState.Index' (duration: 124.699405ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:22:14.427836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.182478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:22:14.427904Z","caller":"traceutil/trace.go:171","msg":"trace[2126735796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2885; }","duration":"259.360683ms","start":"2026-09-01T04:22:14.168529Z","end":"2026-09-01T04:22:14.42789Z","steps":["trace[2126735796] 'agreement among raft nodes before linearized reading' (duration: 259.090776ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:48.315049Z","caller":"traceutil/trace.go:171","msg":"trace[1667572559] linearizableReadLoop","detail":"{readStateIndex:3502; appliedIndex:3501; }","duration":"150.245163ms","start":"2026-09-01T04:23:48.164777Z","end":"2026-09-01T04:23:48.315022Z","steps":["trace[1667572559] 'read index received' (duration: 104.172851ms)","trace[1667572559] 'applied index is now lower than readState.Index' (duration: 46.070992ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:23:48.315139Z","caller":"traceutil/trace.go:171","msg":"trace[996988453] transaction","detail":"{read_only:false; response_revision:3369; number_of_response:1; }","duration":"152.399428ms","start":"2026-09-01T04:23:48.1627Z","end":"2026-09-01T04:23:48.315099Z","steps":["trace[996988453] 'process raft request' (duration: 106.278205ms)","trace[996988453] 'compare' (duration: 45.871138ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:23:48.315386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.739314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-01T04:23:48.315423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.57132ms","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-09-01T04:23:48.31546Z","caller":"traceutil/trace.go:171","msg":"trace[1923655876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3369; }","duration":"135.863296ms","start":"2026-09-01T04:23:48.179577Z","end":"2026-09-01T04:23:48.31544Z","steps":["trace[1923655876] 'agreement among raft nodes before linearized reading' (duration: 135.658382ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:48.315555Z","caller":"traceutil/trace.go:171","msg":"trace[1430107369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3369; }","duration":"150.721613ms","start":"2026-09-01T04:23:48.164748Z","end":"2026-09-01T04:23:48.315469Z","steps":["trace[1430107369] 'agreement among raft nodes before linearized reading' (duration: 150.431187ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:48.421265Z","caller":"traceutil/trace.go:171","msg":"trace[394798327] transaction","detail":"{read_only:false; response_revision:3371; number_of_response:1; }","duration":"100.935235ms","start":"2026-09-01T04:23:48.320301Z","end":"2026-09-01T04:23:48.421237Z","steps":["trace[394798327] 'process raft request' (duration: 97.997555ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:48.421443Z","caller":"traceutil/trace.go:171","msg":"trace[70866048] transaction","detail":"{read_only:false; response_revision:3372; number_of_response:1; }","duration":"101.092318ms","start":"2026-09-01T04:23:48.320322Z","end":"2026-09-01T04:23:48.421414Z","steps":["trace[70866048] 'process raft request' (duration: 100.857323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:02.038685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.774068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-09-01T04:27:02.038843Z","caller":"traceutil/trace.go:171","msg":"trace[32533428] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4976; }","duration":"129.915691ms","start":"2026-09-01T04:27:01.90885Z","end":"2026-09-01T04:27:02.038766Z","steps":["trace[32533428] 'range keys from in-memory index tree' (duration: 129.590405ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:02.039571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.702019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-01T04:27:02.03965Z","caller":"traceutil/trace.go:171","msg":"trace[469817757] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4976; }","duration":"105.82009ms","start":"2026-09-01T04:27:01.933813Z","end":"2026-09-01T04:27:02.039633Z","steps":["trace[469817757] 'range keys from in-memory index tree' (duration: 104.52225ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:05.681167Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2837} {"level":"info","ts":"2026-09-01T04:27:05.772226Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2837,"took":"90.076239ms","hash":1803666692,"current-db-size-bytes":51802112,"current-db-size":"52 MB","current-db-size-in-use-bytes":26419200,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-01T04:27:05.772302Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1803666692,"revision":2837,"compact-revision":-1} {"level":"info","ts":"2026-09-01T04:27:09.670519Z","caller":"traceutil/trace.go:171","msg":"trace[1675778390] transaction","detail":"{read_only:false; response_revision:5124; number_of_response:1; }","duration":"104.897488ms","start":"2026-09-01T04:27:09.565559Z","end":"2026-09-01T04:27:09.670456Z","steps":["trace[1675778390] 'process raft request' (duration: 102.085023ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:14.044198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.823613ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:27:14.044317Z","caller":"traceutil/trace.go:171","msg":"trace[1307213990] linearizableReadLoop","detail":"{readStateIndex:5409; appliedIndex:5408; }","duration":"345.466391ms","start":"2026-09-01T04:27:13.69883Z","end":"2026-09-01T04:27:14.044296Z","steps":["trace[1307213990] 'read index received' (duration: 6.282378ms)","trace[1307213990] 'applied index is now lower than readState.Index' (duration: 339.182353ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:27:14.044346Z","caller":"traceutil/trace.go:171","msg":"trace[809369903] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"353.69942ms","start":"2026-09-01T04:27:13.690623Z","end":"2026-09-01T04:27:14.044323Z","steps":["trace[809369903] 'process raft request' (duration: 156.667534ms)","trace[809369903] 'compare' (duration: 196.69824ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:27:14.04446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:27:13.690607Z","time spent":"353.789951ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:27:14.044518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.516004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:27:14.044561Z","caller":"traceutil/trace.go:171","msg":"trace[752467929] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5205; }","duration":"296.579756ms","start":"2026-09-01T04:27:13.747967Z","end":"2026-09-01T04:27:14.044546Z","steps":["trace[752467929] 'agreement among raft nodes before linearized reading' (duration: 296.468354ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:14.044599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.961983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6b2caeee-91e5-4a89-a085-98fd69a945c4\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-09-01T04:27:14.044609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.164217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6b2caeee-91e5-4a89-a085-98fd69a945c4\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-01T04:27:14.044662Z","caller":"traceutil/trace.go:171","msg":"trace[2020776502] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6b2caeee-91e5-4a89-a085-98fd69a945c4; range_end:; response_count:1; response_revision:5205; }","duration":"112.077085ms","start":"2026-09-01T04:27:13.932568Z","end":"2026-09-01T04:27:14.044645Z","steps":["trace[2020776502] 'agreement among raft nodes before linearized reading' (duration: 111.880752ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:14.044689Z","caller":"traceutil/trace.go:171","msg":"trace[1864130739] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6b2caeee-91e5-4a89-a085-98fd69a945c4; range_end:; response_count:1; response_revision:5205; }","duration":"142.287478ms","start":"2026-09-01T04:27:13.902375Z","end":"2026-09-01T04:27:14.044662Z","steps":["trace[1864130739] 'agreement among raft nodes before linearized reading' (duration: 142.079875ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:14.045853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.005185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-01T04:27:14.045923Z","caller":"traceutil/trace.go:171","msg":"trace[717617643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5205; }","duration":"347.100487ms","start":"2026-09-01T04:27:13.698807Z","end":"2026-09-01T04:27:14.045907Z","steps":["trace[717617643] 'agreement among raft nodes before linearized reading' (duration: 345.591173ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:14.045965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:27:13.698797Z","time spent":"347.156168ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-01T04:27:14.172676Z","caller":"traceutil/trace.go:171","msg":"trace[188173914] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"122.137502ms","start":"2026-09-01T04:27:14.050521Z","end":"2026-09-01T04:27:14.172658Z","steps":["trace[188173914] 'process raft request' (duration: 100.563474ms)","trace[188173914] 'compare' (duration: 21.494466ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:27:14.176197Z","caller":"traceutil/trace.go:171","msg":"trace[128991339] linearizableReadLoop","detail":"{readStateIndex:5411; appliedIndex:5409; }","duration":"124.084553ms","start":"2026-09-01T04:27:14.052081Z","end":"2026-09-01T04:27:14.176166Z","steps":["trace[128991339] 'read index received' (duration: 99.01409ms)","trace[128991339] 'applied index is now lower than readState.Index' (duration: 25.069033ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:27:14.17633Z","caller":"traceutil/trace.go:171","msg":"trace[1623903809] transaction","detail":"{read_only:false; response_revision:5207; number_of_response:1; }","duration":"125.643937ms","start":"2026-09-01T04:27:14.05065Z","end":"2026-09-01T04:27:14.176294Z","steps":["trace[1623903809] 'process raft request' (duration: 125.340792ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:14.176532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.430848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-01T04:27:14.176594Z","caller":"traceutil/trace.go:171","msg":"trace[1928140870] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5207; }","duration":"124.524579ms","start":"2026-09-01T04:27:14.052051Z","end":"2026-09-01T04:27:14.176576Z","steps":["trace[1928140870] 'agreement among raft nodes before linearized reading' (duration: 124.270855ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:28.659914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.229023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-01T04:27:28.659958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.16649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-01T04:27:28.660009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.671518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-7867bf45b8-4z9ds\" ","response":"range_response_count:1 size:11848"} {"level":"info","ts":"2026-09-01T04:27:28.660044Z","caller":"traceutil/trace.go:171","msg":"trace[649505600] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:5377; }","duration":"344.431757ms","start":"2026-09-01T04:27:28.315587Z","end":"2026-09-01T04:27:28.660019Z","steps":["trace[649505600] 'count revisions from in-memory index tree' (duration: 344.04898ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:28.660059Z","caller":"traceutil/trace.go:171","msg":"trace[1444739129] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-7867bf45b8-4z9ds; range_end:; response_count:1; response_revision:5377; }","duration":"222.761969ms","start":"2026-09-01T04:27:28.437282Z","end":"2026-09-01T04:27:28.660044Z","steps":["trace[1444739129] 'range keys from in-memory index tree' (duration: 222.517853ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:28.660104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:27:28.315565Z","time spent":"344.521149ms","remote":"127.0.0.1:35986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":17,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-09-01T04:27:28.660044Z","caller":"traceutil/trace.go:171","msg":"trace[1314281493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5377; }","duration":"405.295373ms","start":"2026-09-01T04:27:28.254731Z","end":"2026-09-01T04:27:28.660026Z","steps":["trace[1314281493] 'range keys from in-memory index tree' (duration: 404.990467ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:27:28.660249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:27:28.254705Z","time spent":"405.527846ms","remote":"127.0.0.1:35758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-01T04:27:28.844234Z","caller":"traceutil/trace.go:171","msg":"trace[1459831584] transaction","detail":"{read_only:false; response_revision:5381; number_of_response:1; }","duration":"105.0364ms","start":"2026-09-01T04:27:28.739147Z","end":"2026-09-01T04:27:28.844183Z","steps":["trace[1459831584] 'process raft request' (duration: 104.37302ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:29.229752Z","caller":"traceutil/trace.go:171","msg":"trace[742268726] transaction","detail":"{read_only:false; response_revision:5384; number_of_response:1; }","duration":"154.420215ms","start":"2026-09-01T04:27:29.075305Z","end":"2026-09-01T04:27:29.229725Z","steps":["trace[742268726] 'process raft request' (duration: 154.157772ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:29.230044Z","caller":"traceutil/trace.go:171","msg":"trace[1635963153] transaction","detail":"{read_only:false; response_revision:5385; number_of_response:1; }","duration":"154.576689ms","start":"2026-09-01T04:27:29.075373Z","end":"2026-09-01T04:27:29.229949Z","steps":["trace[1635963153] 'process raft request' (duration: 154.303734ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:29.264527Z","caller":"traceutil/trace.go:171","msg":"trace[271952236] transaction","detail":"{read_only:false; response_revision:5386; number_of_response:1; }","duration":"116.265794ms","start":"2026-09-01T04:27:29.148215Z","end":"2026-09-01T04:27:29.264481Z","steps":["trace[271952236] 'process raft request' (duration: 115.930609ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:29.264563Z","caller":"traceutil/trace.go:171","msg":"trace[572191820] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"111.964597ms","start":"2026-09-01T04:27:29.152564Z","end":"2026-09-01T04:27:29.264529Z","steps":["trace[572191820] 'process raft request' (duration: 111.761974ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:27:29.264973Z","caller":"traceutil/trace.go:171","msg":"trace[1328658522] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"105.971465ms","start":"2026-09-01T04:27:29.158982Z","end":"2026-09-01T04:27:29.264953Z","steps":["trace[1328658522] 'process raft request' (duration: 105.422596ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:32:05.689182Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5038} {"level":"info","ts":"2026-09-01T04:32:05.763437Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5038,"took":"72.243398ms","hash":2122756732,"current-db-size-bytes":51802112,"current-db-size":"52 MB","current-db-size-in-use-bytes":19542016,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-01T04:32:05.763505Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2122756732,"revision":5038,"compact-revision":2837}