{"level":"warn","ts":"2026-09-22T01:59:46.918871Z","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-22T01:59:46.918976Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.72: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.72:2380","--initial-cluster=instance=https://162.253.55.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.72: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-22T01:59:46.91905Z","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-22T01:59:46.91906Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.72:2380"]} {"level":"info","ts":"2026-09-22T01:59:46.919099Z","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-22T01:59:46.919664Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.72:2379"]} {"level":"info","ts":"2026-09-22T01:59:46.919727Z","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.72:2380"],"listen-peer-urls":["https://162.253.55.72:2380"],"advertise-client-urls":["https://162.253.55.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.72: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-22T01:59:46.926483Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.471045ms"} {"level":"info","ts":"2026-09-22T01:59:46.941163Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"638d1b11488f2a2e","cluster-id":"9ca31ccb1db898d"} {"level":"info","ts":"2026-09-22T01:59:46.941257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T01:59:46.941273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became follower at term 0"} {"level":"info","ts":"2026-09-22T01:59:46.941284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 638d1b11488f2a2e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T01:59:46.941298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became follower at term 1"} {"level":"info","ts":"2026-09-22T01:59:46.941332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e switched to configuration voters=(7173419542516804142)"} {"level":"warn","ts":"2026-09-22T01:59:46.949714Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T01:59:46.951433Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T01:59:46.952631Z","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-22T01:59:46.954572Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"638d1b11488f2a2e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T01:59:46.95507Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"638d1b11488f2a2e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T01:59:46.955321Z","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-22T01:59:46.955395Z","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-22T01:59:46.955414Z","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-22T01:59:46.957466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e switched to configuration voters=(7173419542516804142)"} {"level":"info","ts":"2026-09-22T01:59:46.958036Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ca31ccb1db898d","local-member-id":"638d1b11488f2a2e","added-peer-id":"638d1b11488f2a2e","added-peer-peer-urls":["https://162.253.55.72:2380"]} {"level":"info","ts":"2026-09-22T01:59:46.958838Z","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-22T01:59:46.958927Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.72:2380"} {"level":"info","ts":"2026-09-22T01:59:46.95896Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.72:2380"} {"level":"info","ts":"2026-09-22T01:59:46.959145Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"638d1b11488f2a2e","initial-advertise-peer-urls":["https://162.253.55.72:2380"],"listen-peer-urls":["https://162.253.55.72:2380"],"advertise-client-urls":["https://162.253.55.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T01:59:46.959185Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T01:59:47.141945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T01:59:47.141998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T01:59:47.142029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e received MsgPreVoteResp from 638d1b11488f2a2e at term 1"} {"level":"info","ts":"2026-09-22T01:59:47.142046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became candidate at term 2"} {"level":"info","ts":"2026-09-22T01:59:47.142057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e received MsgVoteResp from 638d1b11488f2a2e at term 2"} {"level":"info","ts":"2026-09-22T01:59:47.142209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"638d1b11488f2a2e became leader at term 2"} {"level":"info","ts":"2026-09-22T01:59:47.142233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 638d1b11488f2a2e elected leader 638d1b11488f2a2e at term 2"} {"level":"info","ts":"2026-09-22T01:59:47.143332Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"638d1b11488f2a2e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.72:2379]}","request-path":"/0/members/638d1b11488f2a2e/attributes","cluster-id":"9ca31ccb1db898d","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T01:59:47.144052Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:59:47.144189Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:59:47.144331Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:59:47.144623Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T01:59:47.144688Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T01:59:47.145186Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ca31ccb1db898d","local-member-id":"638d1b11488f2a2e","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:59:47.145323Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:59:47.145351Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:59:47.148016Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T01:59:47.152857Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.72:2379"} {"level":"warn","ts":"2026-09-22T01:59:50.89722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.098225ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:59:50.897348Z","caller":"traceutil/trace.go:171","msg":"trace[2135345872] transaction","detail":"{read_only:false; response_revision:170; number_of_response:1; }","duration":"382.974903ms","start":"2026-09-22T01:59:50.514352Z","end":"2026-09-22T01:59:50.897327Z","steps":["trace[2135345872] 'process raft request' (duration: 137.277797ms)","trace[2135345872] 'compare' (duration: 244.925482ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:59:50.897413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:59:50.514336Z","time spent":"383.054015ms","remote":"127.0.0.1:44744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":662,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T01:59:51.047379Z","caller":"traceutil/trace.go:171","msg":"trace[131378500] transaction","detail":"{read_only:false; response_revision:171; number_of_response:1; }","duration":"144.840093ms","start":"2026-09-22T01:59:50.902522Z","end":"2026-09-22T01:59:51.047362Z","steps":["trace[131378500] 'process raft request' (duration: 144.71693ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:00:38.951624Z","caller":"traceutil/trace.go:171","msg":"trace[49480152] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"121.502618ms","start":"2026-09-22T02:00:38.830097Z","end":"2026-09-22T02:00:38.9516Z","steps":["trace[49480152] 'process raft request' (duration: 119.817862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:00:39.676875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.23435ms","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-09-22T02:00:39.676954Z","caller":"traceutil/trace.go:171","msg":"trace[1733106012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:651; }","duration":"326.324673ms","start":"2026-09-22T02:00:39.35061Z","end":"2026-09-22T02:00:39.676935Z","steps":["trace[1733106012] 'range keys from in-memory index tree' (duration: 326.103736ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:00:39.676993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:00:39.350555Z","time spent":"326.428225ms","remote":"127.0.0.1:44660","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":"warn","ts":"2026-09-22T02:00:39.677165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.896993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4fmv2\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-22T02:00:39.677285Z","caller":"traceutil/trace.go:171","msg":"trace[1163023901] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4fmv2; range_end:; response_count:1; response_revision:651; }","duration":"221.113799ms","start":"2026-09-22T02:00:39.456145Z","end":"2026-09-22T02:00:39.677259Z","steps":["trace[1163023901] 'range keys from in-memory index tree' (duration: 220.498852ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:00:39.730931Z","caller":"traceutil/trace.go:171","msg":"trace[440089277] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"106.015216ms","start":"2026-09-22T02:00:39.624891Z","end":"2026-09-22T02:00:39.730906Z","steps":["trace[440089277] 'read index received' (duration: 105.254876ms)","trace[440089277] 'applied index is now lower than readState.Index' (duration: 758.93µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:00:39.731139Z","caller":"traceutil/trace.go:171","msg":"trace[304666226] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"231.940283ms","start":"2026-09-22T02:00:39.499045Z","end":"2026-09-22T02:00:39.730985Z","steps":["trace[304666226] 'process raft request' (duration: 231.356458ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:00:39.731364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.465338ms","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-22T02:00:39.731426Z","caller":"traceutil/trace.go:171","msg":"trace[228839040] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:652; }","duration":"106.563311ms","start":"2026-09-22T02:00:39.624846Z","end":"2026-09-22T02:00:39.731409Z","steps":["trace[228839040] 'agreement among raft nodes before linearized reading' (duration: 106.15215ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:01:29.154453Z","caller":"traceutil/trace.go:171","msg":"trace[1924606981] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"159.314032ms","start":"2026-09-22T02:01:28.995115Z","end":"2026-09-22T02:01:29.154429Z","steps":["trace[1924606981] 'process raft request' (duration: 159.132558ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:20.602092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.737173ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T02:02:20.602342Z","caller":"traceutil/trace.go:171","msg":"trace[898029698] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1983; }","duration":"169.950864ms","start":"2026-09-22T02:02:20.432369Z","end":"2026-09-22T02:02:20.60232Z","steps":["trace[898029698] 'read index received' (duration: 45.101µs)","trace[898029698] 'applied index is now lower than readState.Index' (duration: 169.903503ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:02:20.602343Z","caller":"traceutil/trace.go:171","msg":"trace[1403434961] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"201.81376ms","start":"2026-09-22T02:02:20.400505Z","end":"2026-09-22T02:02:20.602319Z","steps":["trace[1403434961] 'process raft request' (duration: 10.637399ms)","trace[1403434961] 'compare' (duration: 190.640051ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:02:20.602561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.188928ms","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-22T02:02:20.602614Z","caller":"traceutil/trace.go:171","msg":"trace[862274962] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1909; }","duration":"170.28166ms","start":"2026-09-22T02:02:20.432315Z","end":"2026-09-22T02:02:20.602597Z","steps":["trace[862274962] 'agreement among raft nodes before linearized reading' (duration: 170.109097ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:20.642698Z","caller":"traceutil/trace.go:171","msg":"trace[550241397] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"181.209555ms","start":"2026-09-22T02:02:20.461462Z","end":"2026-09-22T02:02:20.642672Z","steps":["trace[550241397] 'process raft request' (duration: 181.073512ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:20.642758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.702917ms","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-09-22T02:02:20.643059Z","caller":"traceutil/trace.go:171","msg":"trace[518487259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1910; }","duration":"203.016533ms","start":"2026-09-22T02:02:20.440002Z","end":"2026-09-22T02:02:20.643018Z","steps":["trace[518487259] 'agreement among raft nodes before linearized reading' (duration: 202.645996ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:54.645377Z","caller":"traceutil/trace.go:171","msg":"trace[1832522761] linearizableReadLoop","detail":"{readStateIndex:2235; appliedIndex:2234; }","duration":"225.070513ms","start":"2026-09-22T02:02:54.420281Z","end":"2026-09-22T02:02:54.645351Z","steps":["trace[1832522761] 'read index received' (duration: 224.975281ms)","trace[1832522761] 'applied index is now lower than readState.Index' (duration: 94.292µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:02:54.64559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.290857ms","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-22T02:02:54.645462Z","caller":"traceutil/trace.go:171","msg":"trace[373968866] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"244.376437ms","start":"2026-09-22T02:02:54.401037Z","end":"2026-09-22T02:02:54.645413Z","steps":["trace[373968866] 'process raft request' (duration: 244.167794ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:54.645675Z","caller":"traceutil/trace.go:171","msg":"trace[1630262804] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2152; }","duration":"225.43326ms","start":"2026-09-22T02:02:54.420227Z","end":"2026-09-22T02:02:54.64566Z","steps":["trace[1630262804] 'agreement among raft nodes before linearized reading' (duration: 225.271107ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:54.682922Z","caller":"traceutil/trace.go:171","msg":"trace[1382410618] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"229.703236ms","start":"2026-09-22T02:02:54.453197Z","end":"2026-09-22T02:02:54.6829Z","steps":["trace[1382410618] 'process raft request' (duration: 229.349979ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:55.175665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.979271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T02:02:55.175797Z","caller":"traceutil/trace.go:171","msg":"trace[2019119832] linearizableReadLoop","detail":"{readStateIndex:2239; appliedIndex:2238; }","duration":"336.985666ms","start":"2026-09-22T02:02:54.838788Z","end":"2026-09-22T02:02:55.175774Z","steps":["trace[2019119832] 'read index received' (duration: 80.7322ms)","trace[2019119832] 'applied index is now lower than readState.Index' (duration: 256.252006ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:02:55.175902Z","caller":"traceutil/trace.go:171","msg":"trace[1560346174] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"345.891784ms","start":"2026-09-22T02:02:54.829996Z","end":"2026-09-22T02:02:55.175888Z","steps":["trace[1560346174] 'process raft request' (duration: 89.545326ms)","trace[1560346174] 'compare' (duration: 255.844539ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:02:55.175983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:54.829971Z","time spent":"345.958296ms","remote":"127.0.0.1:44660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:02:55.176213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.192784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-22T02:02:55.176265Z","caller":"traceutil/trace.go:171","msg":"trace[1332292559] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2156; }","duration":"256.304066ms","start":"2026-09-22T02:02:54.919941Z","end":"2026-09-22T02:02:55.176245Z","steps":["trace[1332292559] 'agreement among raft nodes before linearized reading' (duration: 256.069432ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:55.176283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.163152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-09-22T02:02:55.176294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.462904ms","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-09-22T02:02:55.176358Z","caller":"traceutil/trace.go:171","msg":"trace[853181178] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2156; }","duration":"252.284645ms","start":"2026-09-22T02:02:54.924054Z","end":"2026-09-22T02:02:55.176339Z","steps":["trace[853181178] 'agreement among raft nodes before linearized reading' (duration: 252.042381ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:55.176368Z","caller":"traceutil/trace.go:171","msg":"trace[681116176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2156; }","duration":"337.584896ms","start":"2026-09-22T02:02:54.838765Z","end":"2026-09-22T02:02:55.17635Z","steps":["trace[681116176] 'agreement among raft nodes before linearized reading' (duration: 337.327372ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:55.176411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:54.838754Z","time spent":"337.647697ms","remote":"127.0.0.1:44660","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-09-22T02:02:55.507718Z","caller":"traceutil/trace.go:171","msg":"trace[1435586321] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"325.60215ms","start":"2026-09-22T02:02:55.182067Z","end":"2026-09-22T02:02:55.507669Z","steps":["trace[1435586321] 'process raft request' (duration: 325.456377ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:55.508006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:55.182055Z","time spent":"325.776283ms","remote":"127.0.0.1:44660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T02:02:55.69052Z","caller":"traceutil/trace.go:171","msg":"trace[1575185574] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"460.169167ms","start":"2026-09-22T02:02:55.230257Z","end":"2026-09-22T02:02:55.690426Z","steps":["trace[1575185574] 'process raft request' (duration: 406.984069ms)","trace[1575185574] 'compare' (duration: 52.853692ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:02:55.690993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:55.23023Z","time spent":"460.553233ms","remote":"127.0.0.1:44438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":819,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T02:08:53.987736Z","caller":"traceutil/trace.go:171","msg":"trace[872493969] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"121.162562ms","start":"2026-09-22T02:08:53.866559Z","end":"2026-09-22T02:08:53.987722Z","steps":["trace[872493969] 'process raft request' (duration: 121.06327ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:08:53.988039Z","caller":"traceutil/trace.go:171","msg":"trace[1995213582] linearizableReadLoop","detail":"{readStateIndex:4987; appliedIndex:4987; }","duration":"118.669334ms","start":"2026-09-22T02:08:53.869364Z","end":"2026-09-22T02:08:53.988033Z","steps":["trace[1995213582] 'read index received' (duration: 118.666794ms)","trace[1995213582] 'applied index is now lower than readState.Index' (duration: 2.22µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:08:53.988128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.753917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9ce2036d-ee68-4cc1-ba05-a116a1f26798\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-09-22T02:08:53.988144Z","caller":"traceutil/trace.go:171","msg":"trace[1938869269] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9ce2036d-ee68-4cc1-ba05-a116a1f26798; range_end:; response_count:1; response_revision:4803; }","duration":"118.808318ms","start":"2026-09-22T02:08:53.86933Z","end":"2026-09-22T02:08:53.988139Z","steps":["trace[1938869269] 'agreement among raft nodes before linearized reading' (duration: 118.737826ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:08:54.001722Z","caller":"traceutil/trace.go:171","msg":"trace[1883637990] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"107.744073ms","start":"2026-09-22T02:08:53.893969Z","end":"2026-09-22T02:08:54.001713Z","steps":["trace[1883637990] 'process raft request' (duration: 107.596989ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:01.977165Z","caller":"traceutil/trace.go:171","msg":"trace[1743553757] linearizableReadLoop","detail":"{readStateIndex:5132; appliedIndex:5131; }","duration":"131.419362ms","start":"2026-09-22T02:09:01.845727Z","end":"2026-09-22T02:09:01.977146Z","steps":["trace[1743553757] 'read index received' (duration: 102.234735ms)","trace[1743553757] 'applied index is now lower than readState.Index' (duration: 29.183517ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:09:01.977287Z","caller":"traceutil/trace.go:171","msg":"trace[416443300] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"135.937705ms","start":"2026-09-22T02:09:01.84132Z","end":"2026-09-22T02:09:01.977258Z","steps":["trace[416443300] 'process raft request' (duration: 106.686017ms)","trace[416443300] 'compare' (duration: 29.044454ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:09:01.977385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.640987ms","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-09-22T02:09:01.97742Z","caller":"traceutil/trace.go:171","msg":"trace[2045909562] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4941; }","duration":"131.718069ms","start":"2026-09-22T02:09:01.845691Z","end":"2026-09-22T02:09:01.977409Z","steps":["trace[2045909562] 'agreement among raft nodes before linearized reading' (duration: 131.568405ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:02.134455Z","caller":"traceutil/trace.go:171","msg":"trace[417060971] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"153.870792ms","start":"2026-09-22T02:09:01.980562Z","end":"2026-09-22T02:09:02.134433Z","steps":["trace[417060971] 'process raft request' (duration: 153.734279ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:02.152568Z","caller":"traceutil/trace.go:171","msg":"trace[126861138] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"169.204722ms","start":"2026-09-22T02:09:01.983346Z","end":"2026-09-22T02:09:02.15255Z","steps":["trace[126861138] 'process raft request' (duration: 168.817843ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:02.152559Z","caller":"traceutil/trace.go:171","msg":"trace[1101009409] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"169.138621ms","start":"2026-09-22T02:09:01.983373Z","end":"2026-09-22T02:09:02.152512Z","steps":["trace[1101009409] 'process raft request' (duration: 168.908785ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:02.15281Z","caller":"traceutil/trace.go:171","msg":"trace[130925033] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"169.244083ms","start":"2026-09-22T02:09:01.983554Z","end":"2026-09-22T02:09:02.152798Z","steps":["trace[130925033] 'process raft request' (duration: 168.771752ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:02.153163Z","caller":"traceutil/trace.go:171","msg":"trace[345837696] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"159.779236ms","start":"2026-09-22T02:09:01.993366Z","end":"2026-09-22T02:09:02.153145Z","steps":["trace[345837696] 'process raft request' (duration: 159.0692ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:02.153258Z","caller":"traceutil/trace.go:171","msg":"trace[889557502] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"169.065639ms","start":"2026-09-22T02:09:01.984169Z","end":"2026-09-22T02:09:02.153234Z","steps":["trace[889557502] 'process raft request' (duration: 168.20299ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:02.154572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.059069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130496"} {"level":"info","ts":"2026-09-22T02:09:02.154645Z","caller":"traceutil/trace.go:171","msg":"trace[1091903709] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4948; }","duration":"169.173631ms","start":"2026-09-22T02:09:01.985458Z","end":"2026-09-22T02:09:02.154632Z","steps":["trace[1091903709] 'agreement among raft nodes before linearized reading' (duration: 168.962396ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:02.152564Z","caller":"traceutil/trace.go:171","msg":"trace[1526985197] linearizableReadLoop","detail":"{readStateIndex:5137; appliedIndex:5132; }","duration":"167.053134ms","start":"2026-09-22T02:09:01.985493Z","end":"2026-09-22T02:09:02.152546Z","steps":["trace[1526985197] 'read index received' (duration: 148.757696ms)","trace[1526985197] 'applied index is now lower than readState.Index' (duration: 18.294457ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:09:02.15503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.462772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-22T02:09:02.155125Z","caller":"traceutil/trace.go:171","msg":"trace[1338480922] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4948; }","duration":"121.578095ms","start":"2026-09-22T02:09:02.033534Z","end":"2026-09-22T02:09:02.155112Z","steps":["trace[1338480922] 'agreement among raft nodes before linearized reading' (duration: 121.391871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:02.155201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.31307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-22T02:09:02.155293Z","caller":"traceutil/trace.go:171","msg":"trace[1117789794] 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:4948; }","duration":"125.411292ms","start":"2026-09-22T02:09:02.029856Z","end":"2026-09-22T02:09:02.155267Z","steps":["trace[1117789794] 'agreement among raft nodes before linearized reading' (duration: 125.215238ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:02.155476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.549897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:09:02.155565Z","caller":"traceutil/trace.go:171","msg":"trace[1440743026] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4948; }","duration":"115.659319ms","start":"2026-09-22T02:09:02.039892Z","end":"2026-09-22T02:09:02.155551Z","steps":["trace[1440743026] 'agreement among raft nodes before linearized reading' (duration: 115.526636ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:02.155018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.231133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:09:02.158965Z","caller":"traceutil/trace.go:171","msg":"trace[1182914920] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:4948; }","duration":"156.135224ms","start":"2026-09-22T02:09:01.999711Z","end":"2026-09-22T02:09:02.155846Z","steps":["trace[1182914920] 'agreement among raft nodes before linearized reading' (duration: 155.205292ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:06.341269Z","caller":"traceutil/trace.go:171","msg":"trace[402641315] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"118.474372ms","start":"2026-09-22T02:09:06.222772Z","end":"2026-09-22T02:09:06.341247Z","steps":["trace[402641315] 'process raft request' (duration: 118.266278ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:06.342742Z","caller":"traceutil/trace.go:171","msg":"trace[671443707] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"117.04067ms","start":"2026-09-22T02:09:06.225671Z","end":"2026-09-22T02:09:06.342712Z","steps":["trace[671443707] 'process raft request' (duration: 116.59096ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:15.339678Z","caller":"traceutil/trace.go:171","msg":"trace[1556729271] transaction","detail":"{read_only:false; response_revision:5181; number_of_response:1; }","duration":"171.393351ms","start":"2026-09-22T02:09:15.16826Z","end":"2026-09-22T02:09:15.339653Z","steps":["trace[1556729271] 'process raft request' (duration: 171.184416ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:15.339944Z","caller":"traceutil/trace.go:171","msg":"trace[127733020] linearizableReadLoop","detail":"{readStateIndex:5378; appliedIndex:5375; }","duration":"107.695676ms","start":"2026-09-22T02:09:15.232227Z","end":"2026-09-22T02:09:15.339923Z","steps":["trace[127733020] 'read index received' (duration: 107.210265ms)","trace[127733020] 'applied index is now lower than readState.Index' (duration: 484.651µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:09:15.340058Z","caller":"traceutil/trace.go:171","msg":"trace[953987390] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"165.255472ms","start":"2026-09-22T02:09:15.174718Z","end":"2026-09-22T02:09:15.339974Z","steps":["trace[953987390] 'process raft request' (duration: 165.118839ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:15.340168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.916856ms","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-22T02:09:15.340241Z","caller":"traceutil/trace.go:171","msg":"trace[1199710728] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5183; }","duration":"118.021279ms","start":"2026-09-22T02:09:15.222203Z","end":"2026-09-22T02:09:15.340224Z","steps":["trace[1199710728] 'agreement among raft nodes before linearized reading' (duration: 117.835865ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:09:15.340223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.43327ms","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-09-22T02:09:15.340322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.023236ms","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-09-22T02:09:15.34043Z","caller":"traceutil/trace.go:171","msg":"trace[91850541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5183; }","duration":"157.18374ms","start":"2026-09-22T02:09:15.183231Z","end":"2026-09-22T02:09:15.340415Z","steps":["trace[91850541] 'agreement among raft nodes before linearized reading' (duration: 156.826672ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:15.340373Z","caller":"traceutil/trace.go:171","msg":"trace[1545758186] 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:5183; }","duration":"103.688766ms","start":"2026-09-22T02:09:15.236667Z","end":"2026-09-22T02:09:15.340356Z","steps":["trace[1545758186] 'agreement among raft nodes before linearized reading' (duration: 103.399609ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:15.340003Z","caller":"traceutil/trace.go:171","msg":"trace[2079028736] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"171.582485ms","start":"2026-09-22T02:09:15.168356Z","end":"2026-09-22T02:09:15.339939Z","steps":["trace[2079028736] 'process raft request' (duration: 171.256928ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:09:15.453488Z","caller":"traceutil/trace.go:171","msg":"trace[602142724] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"106.835737ms","start":"2026-09-22T02:09:15.346602Z","end":"2026-09-22T02:09:15.453438Z","steps":["trace[602142724] 'process raft request' (duration: 85.19884ms)","trace[602142724] 'compare' (duration: 21.549705ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:09:47.51874Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868} {"level":"info","ts":"2026-09-22T02:09:47.586537Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"66.801805ms","hash":381055729,"current-db-size-bytes":53538816,"current-db-size":"54 MB","current-db-size-in-use-bytes":28475392,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-22T02:09:47.58661Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":381055729,"revision":2868,"compact-revision":-1} {"level":"info","ts":"2026-09-22T02:14:47.525821Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5468} {"level":"info","ts":"2026-09-22T02:14:47.603161Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5468,"took":"75.90017ms","hash":2229395341,"current-db-size-bytes":53538816,"current-db-size":"54 MB","current-db-size-in-use-bytes":18964480,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-22T02:14:47.60324Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2229395341,"revision":5468,"compact-revision":2868}