{"level":"warn","ts":"2026-09-01T07:09:52.613772Z","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-01T07:09:52.613888Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.82: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.82:2380","--initial-cluster=instance=https://162.253.55.82:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.82:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.82: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-01T07:09:52.614003Z","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-01T07:09:52.614023Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.82:2380"]} {"level":"info","ts":"2026-09-01T07:09:52.614043Z","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-01T07:09:52.614733Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"]} {"level":"info","ts":"2026-09-01T07:09:52.614817Z","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.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.82: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-01T07:09:52.620185Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.04707ms"} {"level":"info","ts":"2026-09-01T07:09:52.627138Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c5298098e2dc0f92","cluster-id":"e15b04acbd0c3f73"} {"level":"info","ts":"2026-09-01T07:09:52.627212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T07:09:52.627236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 0"} {"level":"info","ts":"2026-09-01T07:09:52.627249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c5298098e2dc0f92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T07:09:52.627256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 1"} {"level":"info","ts":"2026-09-01T07:09:52.627301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"} {"level":"warn","ts":"2026-09-01T07:09:52.63468Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T07:09:52.636034Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T07:09:52.637145Z","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-01T07:09:52.638984Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c5298098e2dc0f92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T07:09:52.63995Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c5298098e2dc0f92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T07:09:52.640671Z","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-01T07:09:52.64081Z","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-01T07:09:52.640958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"} {"level":"info","ts":"2026-09-01T07:09:52.64106Z","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-01T07:09:52.641096Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","added-peer-id":"c5298098e2dc0f92","added-peer-peer-urls":["https://162.253.55.82:2380"]} {"level":"info","ts":"2026-09-01T07:09:52.643067Z","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-01T07:09:52.643253Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.82:2380"} {"level":"info","ts":"2026-09-01T07:09:52.643359Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.82:2380"} {"level":"info","ts":"2026-09-01T07:09:52.64382Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c5298098e2dc0f92","initial-advertise-peer-urls":["https://162.253.55.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T07:09:52.643858Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T07:09:52.928234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T07:09:52.928324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T07:09:52.928399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgPreVoteResp from c5298098e2dc0f92 at term 1"} {"level":"info","ts":"2026-09-01T07:09:52.928488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became candidate at term 2"} {"level":"info","ts":"2026-09-01T07:09:52.928506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgVoteResp from c5298098e2dc0f92 at term 2"} {"level":"info","ts":"2026-09-01T07:09:52.92861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became leader at term 2"} {"level":"info","ts":"2026-09-01T07:09:52.928631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c5298098e2dc0f92 elected leader c5298098e2dc0f92 at term 2"} {"level":"info","ts":"2026-09-01T07:09:52.930022Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c5298098e2dc0f92","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.82:2379]}","request-path":"/0/members/c5298098e2dc0f92/attributes","cluster-id":"e15b04acbd0c3f73","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T07:09:52.930045Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T07:09:52.930553Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T07:09:52.930633Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T07:09:52.930156Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T07:09:52.930175Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T07:09:52.934521Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T07:09:52.934764Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T07:09:52.934896Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T07:09:52.935683Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T07:09:52.936594Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.82:2379"} {"level":"info","ts":"2026-09-01T07:10:45.646661Z","caller":"traceutil/trace.go:171","msg":"trace[678493462] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"164.161652ms","start":"2026-09-01T07:10:45.482468Z","end":"2026-09-01T07:10:45.64663Z","steps":["trace[678493462] 'read index received' (duration: 162.732309ms)","trace[678493462] 'applied index is now lower than readState.Index' (duration: 1.427953ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:10:45.646784Z","caller":"traceutil/trace.go:171","msg":"trace[2080062926] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"289.619335ms","start":"2026-09-01T07:10:45.357103Z","end":"2026-09-01T07:10:45.646722Z","steps":["trace[2080062926] 'process raft request' (duration: 288.350915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:10:45.647252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.482674ms","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-01T07:10:45.647654Z","caller":"traceutil/trace.go:171","msg":"trace[1679686688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:602; }","duration":"115.967031ms","start":"2026-09-01T07:10:45.531663Z","end":"2026-09-01T07:10:45.64763Z","steps":["trace[1679686688] 'agreement among raft nodes before linearized reading' (duration: 115.420843ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:10:45.648183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.631786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kxrjg\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-01T07:10:45.648453Z","caller":"traceutil/trace.go:171","msg":"trace[213619329] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kxrjg; range_end:; response_count:1; response_revision:602; }","duration":"166.000762ms","start":"2026-09-01T07:10:45.482382Z","end":"2026-09-01T07:10:45.648383Z","steps":["trace[213619329] 'agreement among raft nodes before linearized reading' (duration: 164.439277ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:12:25.363405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.632346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T07:12:25.363489Z","caller":"traceutil/trace.go:171","msg":"trace[1272642074] linearizableReadLoop","detail":"{readStateIndex:1949; appliedIndex:1948; }","duration":"304.404263ms","start":"2026-09-01T07:12:25.059072Z","end":"2026-09-01T07:12:25.363476Z","steps":["trace[1272642074] 'read index received' (duration: 109.15425ms)","trace[1272642074] 'applied index is now lower than readState.Index' (duration: 195.248803ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:12:25.363688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.615545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T07:12:25.363708Z","caller":"traceutil/trace.go:171","msg":"trace[1271855635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1880; }","duration":"304.662735ms","start":"2026-09-01T07:12:25.059038Z","end":"2026-09-01T07:12:25.363701Z","steps":["trace[1271855635] 'agreement among raft nodes before linearized reading' (duration: 304.619415ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:12:25.363686Z","caller":"traceutil/trace.go:171","msg":"trace[99552343] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"309.067315ms","start":"2026-09-01T07:12:25.054551Z","end":"2026-09-01T07:12:25.363618Z","steps":["trace[99552343] 'process raft request' (duration: 113.720851ms)","trace[99552343] 'compare' (duration: 194.513695ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:12:25.363733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:12:25.059025Z","time spent":"304.702557ms","remote":"127.0.0.1:48686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-01T07:12:25.363958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:12:25.054525Z","time spent":"309.281397ms","remote":"127.0.0.1:48846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T07:12:25.36396Z","caller":"traceutil/trace.go:171","msg":"trace[549801402] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"188.403216ms","start":"2026-09-01T07:12:25.175533Z","end":"2026-09-01T07:12:25.363936Z","steps":["trace[549801402] 'process raft request' (duration: 188.268185ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:12:25.367129Z","caller":"traceutil/trace.go:171","msg":"trace[1905506495] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"167.372911ms","start":"2026-09-01T07:12:25.199745Z","end":"2026-09-01T07:12:25.367118Z","steps":["trace[1905506495] 'process raft request' (duration: 167.259479ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:12:25.367451Z","caller":"traceutil/trace.go:171","msg":"trace[615648121] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"141.27883ms","start":"2026-09-01T07:12:25.226155Z","end":"2026-09-01T07:12:25.367434Z","steps":["trace[615648121] 'process raft request' (duration: 140.907525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:12:25.367484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.592046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T07:12:25.367514Z","caller":"traceutil/trace.go:171","msg":"trace[1250081061] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1883; }","duration":"279.699667ms","start":"2026-09-01T07:12:25.087806Z","end":"2026-09-01T07:12:25.367505Z","steps":["trace[1250081061] 'agreement among raft nodes before linearized reading' (duration: 279.651776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:12:25.367452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.926441ms","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-01T07:12:25.367716Z","caller":"traceutil/trace.go:171","msg":"trace[1977551365] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1883; }","duration":"289.117192ms","start":"2026-09-01T07:12:25.078443Z","end":"2026-09-01T07:12:25.36756Z","steps":["trace[1977551365] 'agreement among raft nodes before linearized reading' (duration: 288.735387ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:12:37.895308Z","caller":"traceutil/trace.go:171","msg":"trace[306343154] linearizableReadLoop","detail":"{readStateIndex:2057; appliedIndex:2056; }","duration":"151.43216ms","start":"2026-09-01T07:12:37.743837Z","end":"2026-09-01T07:12:37.895269Z","steps":["trace[306343154] 'read index received' (duration: 151.287999ms)","trace[306343154] 'applied index is now lower than readState.Index' (duration: 142.891µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:12:37.895445Z","caller":"traceutil/trace.go:171","msg":"trace[544652181] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"153.269311ms","start":"2026-09-01T07:12:37.742164Z","end":"2026-09-01T07:12:37.895434Z","steps":["trace[544652181] 'process raft request' (duration: 152.953478ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:12:37.895606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.171708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11988"} {"level":"info","ts":"2026-09-01T07:12:37.89569Z","caller":"traceutil/trace.go:171","msg":"trace[891277273] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1985; }","duration":"110.27781ms","start":"2026-09-01T07:12:37.78539Z","end":"2026-09-01T07:12:37.895668Z","steps":["trace[891277273] 'agreement among raft nodes before linearized reading' (duration: 110.069438ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:12:37.895947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.099017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-8p7pp\" ","response":"range_response_count:1 size:5854"} {"level":"info","ts":"2026-09-01T07:12:37.896001Z","caller":"traceutil/trace.go:171","msg":"trace[1048325550] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-8p7pp; range_end:; response_count:1; response_revision:1985; }","duration":"152.164998ms","start":"2026-09-01T07:12:37.743821Z","end":"2026-09-01T07:12:37.895986Z","steps":["trace[1048325550] 'agreement among raft nodes before linearized reading' (duration: 151.995276ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:12:38.077931Z","caller":"traceutil/trace.go:171","msg":"trace[244267223] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"139.335467ms","start":"2026-09-01T07:12:37.938565Z","end":"2026-09-01T07:12:38.0779Z","steps":["trace[244267223] 'process raft request' (duration: 139.263446ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:12:38.077962Z","caller":"traceutil/trace.go:171","msg":"trace[136031870] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"139.374857ms","start":"2026-09-01T07:12:37.938555Z","end":"2026-09-01T07:12:38.07793Z","steps":["trace[136031870] 'process raft request' (duration: 134.621275ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:12:59.743948Z","caller":"traceutil/trace.go:171","msg":"trace[282333216] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"217.457309ms","start":"2026-09-01T07:12:59.526448Z","end":"2026-09-01T07:12:59.743905Z","steps":["trace[282333216] 'process raft request' (duration: 135.90619ms)","trace[282333216] 'compare' (duration: 81.243146ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:12:59.74392Z","caller":"traceutil/trace.go:171","msg":"trace[1162030353] linearizableReadLoop","detail":"{readStateIndex:2198; appliedIndex:2196; }","duration":"113.056664ms","start":"2026-09-01T07:12:59.630828Z","end":"2026-09-01T07:12:59.743885Z","steps":["trace[1162030353] 'read index received' (duration: 31.430575ms)","trace[1162030353] 'applied index is now lower than readState.Index' (duration: 81.617089ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:12:59.744199Z","caller":"traceutil/trace.go:171","msg":"trace[192428740] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"215.335095ms","start":"2026-09-01T07:12:59.528831Z","end":"2026-09-01T07:12:59.744166Z","steps":["trace[192428740] 'process raft request' (duration: 214.977042ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:12:59.744455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.58141ms","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-01T07:12:59.744579Z","caller":"traceutil/trace.go:171","msg":"trace[1348472949] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2122; }","duration":"113.785843ms","start":"2026-09-01T07:12:59.630776Z","end":"2026-09-01T07:12:59.744562Z","steps":["trace[1348472949] 'agreement among raft nodes before linearized reading' (duration: 113.234617ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:13:00.223477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.977776ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T07:13:00.223722Z","caller":"traceutil/trace.go:171","msg":"trace[639767907] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2199; }","duration":"165.31742ms","start":"2026-09-01T07:13:00.058381Z","end":"2026-09-01T07:13:00.223698Z","steps":["trace[639767907] 'read index received' (duration: 14.95891ms)","trace[639767907] 'applied index is now lower than readState.Index' (duration: 150.35738ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:13:00.223846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.468022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T07:13:00.223872Z","caller":"traceutil/trace.go:171","msg":"trace[289525489] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2125; }","duration":"165.532952ms","start":"2026-09-01T07:13:00.058329Z","end":"2026-09-01T07:13:00.223862Z","steps":["trace[289525489] 'agreement among raft nodes before linearized reading' (duration: 165.426551ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:13:00.224223Z","caller":"traceutil/trace.go:171","msg":"trace[383379624] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"181.062218ms","start":"2026-09-01T07:13:00.043148Z","end":"2026-09-01T07:13:00.224211Z","steps":["trace[383379624] 'process raft request' (duration: 180.482782ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:13:00.224346Z","caller":"traceutil/trace.go:171","msg":"trace[1174220] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"181.561692ms","start":"2026-09-01T07:13:00.042709Z","end":"2026-09-01T07:13:00.224271Z","steps":["trace[1174220] 'process raft request' (duration: 30.618376ms)","trace[1174220] 'compare' (duration: 149.783234ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:13:00.57313Z","caller":"traceutil/trace.go:171","msg":"trace[1113541438] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"139.00059ms","start":"2026-09-01T07:13:00.434099Z","end":"2026-09-01T07:13:00.5731Z","steps":["trace[1113541438] 'process raft request' (duration: 138.813998ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:13:00.857144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.876066ms","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-01T07:13:00.857225Z","caller":"traceutil/trace.go:171","msg":"trace[483531511] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2126; }","duration":"105.984448ms","start":"2026-09-01T07:13:00.75122Z","end":"2026-09-01T07:13:00.857204Z","steps":["trace[483531511] 'range keys from in-memory index tree' (duration: 105.723076ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:13:00.857414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.168823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-01T07:13:00.857557Z","caller":"traceutil/trace.go:171","msg":"trace[1009422912] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2126; }","duration":"111.385456ms","start":"2026-09-01T07:13:00.746142Z","end":"2026-09-01T07:13:00.857528Z","steps":["trace[1009422912] 'range keys from in-memory index tree' (duration: 110.83439ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:13:01.029934Z","caller":"traceutil/trace.go:171","msg":"trace[229250273] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"166.985358ms","start":"2026-09-01T07:13:00.862931Z","end":"2026-09-01T07:13:01.029917Z","steps":["trace[229250273] 'process raft request' (duration: 166.885897ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:14:14.178905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.620965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T07:14:14.179055Z","caller":"traceutil/trace.go:171","msg":"trace[1343156322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2621; }","duration":"122.836737ms","start":"2026-09-01T07:14:14.056193Z","end":"2026-09-01T07:14:14.17903Z","steps":["trace[1343156322] 'range keys from in-memory index tree' (duration: 122.475434ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:14:14.179241Z","caller":"traceutil/trace.go:171","msg":"trace[291995285] transaction","detail":"{read_only:false; response_revision:2622; number_of_response:1; }","duration":"117.397522ms","start":"2026-09-01T07:14:14.061813Z","end":"2026-09-01T07:14:14.179211Z","steps":["trace[291995285] 'process raft request' (duration: 107.839696ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:14:14.18667Z","caller":"traceutil/trace.go:171","msg":"trace[1197433748] transaction","detail":"{read_only:false; response_revision:2623; number_of_response:1; }","duration":"122.336482ms","start":"2026-09-01T07:14:14.064318Z","end":"2026-09-01T07:14:14.186654Z","steps":["trace[1197433748] 'process raft request' (duration: 122.238401ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:14:44.427853Z","caller":"traceutil/trace.go:171","msg":"trace[1828113582] transaction","detail":"{read_only:false; response_revision:2789; number_of_response:1; }","duration":"128.741476ms","start":"2026-09-01T07:14:44.29908Z","end":"2026-09-01T07:14:44.427822Z","steps":["trace[1828113582] 'process raft request' (duration: 128.545844ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:14:44.452703Z","caller":"traceutil/trace.go:171","msg":"trace[312226493] transaction","detail":"{read_only:false; response_revision:2790; number_of_response:1; }","duration":"136.333532ms","start":"2026-09-01T07:14:44.316346Z","end":"2026-09-01T07:14:44.452679Z","steps":["trace[312226493] 'process raft request' (duration: 135.982769ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:14:49.944441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.570297ms","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-01T07:14:49.944552Z","caller":"traceutil/trace.go:171","msg":"trace[44133059] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2816; }","duration":"181.703288ms","start":"2026-09-01T07:14:49.762823Z","end":"2026-09-01T07:14:49.944526Z","steps":["trace[44133059] 'range keys from in-memory index tree' (duration: 181.289022ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:19:38.850656Z","caller":"traceutil/trace.go:171","msg":"trace[1235303451] transaction","detail":"{read_only:false; response_revision:5095; number_of_response:1; }","duration":"105.017553ms","start":"2026-09-01T07:19:38.74561Z","end":"2026-09-01T07:19:38.850627Z","steps":["trace[1235303451] 'process raft request' (duration: 104.832021ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:19:38.866866Z","caller":"traceutil/trace.go:171","msg":"trace[1650325356] transaction","detail":"{read_only:false; response_revision:5096; number_of_response:1; }","duration":"120.841209ms","start":"2026-09-01T07:19:38.745968Z","end":"2026-09-01T07:19:38.866809Z","steps":["trace[1650325356] 'process raft request' (duration: 120.663808ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:19:53.341397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.075912ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T07:19:53.341519Z","caller":"traceutil/trace.go:171","msg":"trace[2048010629] linearizableReadLoop","detail":"{readStateIndex:5484; appliedIndex:5483; }","duration":"299.277102ms","start":"2026-09-01T07:19:53.042222Z","end":"2026-09-01T07:19:53.341499Z","steps":["trace[2048010629] 'read index received' (duration: 48.900966ms)","trace[2048010629] 'applied index is now lower than readState.Index' (duration: 250.374755ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:19:53.341787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.284553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T07:19:53.341843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.582184ms","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-01T07:19:53.341971Z","caller":"traceutil/trace.go:171","msg":"trace[86707229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5288; }","duration":"299.799897ms","start":"2026-09-01T07:19:53.042141Z","end":"2026-09-01T07:19:53.341941Z","steps":["trace[86707229] 'agreement among raft nodes before linearized reading' (duration: 299.427173ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:19:53.341973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.721506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-6b8f77b789-2l8cp\" ","response":"range_response_count:1 size:11844"} {"level":"info","ts":"2026-09-01T07:19:53.342069Z","caller":"traceutil/trace.go:171","msg":"trace[1617883009] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-6b8f77b789-2l8cp; range_end:; response_count:1; response_revision:5288; }","duration":"157.844547ms","start":"2026-09-01T07:19:53.184202Z","end":"2026-09-01T07:19:53.342047Z","steps":["trace[1617883009] 'agreement among raft nodes before linearized reading' (duration: 157.475363ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:19:53.34175Z","caller":"traceutil/trace.go:171","msg":"trace[433309191] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"365.136845ms","start":"2026-09-01T07:19:52.976386Z","end":"2026-09-01T07:19:53.341523Z","steps":["trace[433309191] 'process raft request' (duration: 114.80331ms)","trace[433309191] 'compare' (duration: 249.229424ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:19:53.34199Z","caller":"traceutil/trace.go:171","msg":"trace[1103843284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5288; }","duration":"283.470814ms","start":"2026-09-01T07:19:53.058427Z","end":"2026-09-01T07:19:53.341898Z","steps":["trace[1103843284] 'agreement among raft nodes before linearized reading' (duration: 283.245062ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:19:53.342628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T07:19:52.976368Z","time spent":"365.988103ms","remote":"127.0.0.1:48930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T07:19:53.352296Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2836} {"level":"info","ts":"2026-09-01T07:19:53.534181Z","caller":"traceutil/trace.go:171","msg":"trace[767000086] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"175.476192ms","start":"2026-09-01T07:19:53.358662Z","end":"2026-09-01T07:19:53.534138Z","steps":["trace[767000086] 'process raft request' (duration: 91.263206ms)","trace[767000086] 'compare' (duration: 64.872364ms)","trace[767000086] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/pods/monitoring/kube-prometheus-stack-grafana-6b8f77b789-2l8cp; req_size:11648; } (duration: 19.0886ms)"],"step_count":3} {"level":"info","ts":"2026-09-01T07:19:53.535501Z","caller":"traceutil/trace.go:171","msg":"trace[1186188994] transaction","detail":"{read_only:false; response_revision:5292; number_of_response:1; }","duration":"140.576466ms","start":"2026-09-01T07:19:53.394108Z","end":"2026-09-01T07:19:53.534684Z","steps":["trace[1186188994] 'process raft request' (duration: 139.941149ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:19:53.733152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.684535ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T07:19:53.733478Z","caller":"traceutil/trace.go:171","msg":"trace[2119789464] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"182.560532ms","start":"2026-09-01T07:19:53.55081Z","end":"2026-09-01T07:19:53.733371Z","steps":["trace[2119789464] 'compare' (duration: 94.268507ms)","trace[2119789464] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/services/endpoints/monitoring/kube-prometheus-stack-grafana; req_size:988; } (duration: 77.903342ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:19:53.733823Z","caller":"traceutil/trace.go:171","msg":"trace[294730193] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"182.761224ms","start":"2026-09-01T07:19:53.551011Z","end":"2026-09-01T07:19:53.733772Z","steps":["trace[294730193] 'process raft request' (duration: 182.259359ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:19:53.733871Z","caller":"traceutil/trace.go:171","msg":"trace[2114250550] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"182.766364ms","start":"2026-09-01T07:19:53.551071Z","end":"2026-09-01T07:19:53.733838Z","steps":["trace[2114250550] 'process raft request' (duration: 182.575793ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:19:53.787871Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2836,"took":"433.950779ms","hash":2596016125,"current-db-size-bytes":52011008,"current-db-size":"52 MB","current-db-size-in-use-bytes":27598848,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-01T07:19:53.787946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2596016125,"revision":2836,"compact-revision":-1} {"level":"info","ts":"2026-09-01T07:19:53.788208Z","caller":"traceutil/trace.go:171","msg":"trace[1023310741] linearizableReadLoop","detail":"{readStateIndex:5493; appliedIndex:5489; }","duration":"153.935589ms","start":"2026-09-01T07:19:53.63425Z","end":"2026-09-01T07:19:53.788186Z","steps":["trace[1023310741] 'read index received' (duration: 37.079929ms)","trace[1023310741] 'applied index is now lower than readState.Index' (duration: 116.85432ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T07:19:53.788297Z","caller":"traceutil/trace.go:171","msg":"trace[821119207] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"228.163495ms","start":"2026-09-01T07:19:53.560121Z","end":"2026-09-01T07:19:53.788284Z","steps":["trace[821119207] 'process raft request' (duration: 206.028956ms)","trace[821119207] 'compare' (duration: 21.882876ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T07:19:53.788578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.316062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-01T07:19:53.788633Z","caller":"traceutil/trace.go:171","msg":"trace[1306778020] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5296; }","duration":"154.446724ms","start":"2026-09-01T07:19:53.634175Z","end":"2026-09-01T07:19:53.788621Z","steps":["trace[1306778020] 'agreement among raft nodes before linearized reading' (duration: 154.267811ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:19:53.817697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.08407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17147"} {"level":"info","ts":"2026-09-01T07:19:53.818198Z","caller":"traceutil/trace.go:171","msg":"trace[612722190] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5300; }","duration":"149.652886ms","start":"2026-09-01T07:19:53.668523Z","end":"2026-09-01T07:19:53.818176Z","steps":["trace[612722190] 'agreement among raft nodes before linearized reading' (duration: 148.979379ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T07:19:53.81811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.76428ms","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-01T07:19:53.818589Z","caller":"traceutil/trace.go:171","msg":"trace[1812734413] 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:5300; }","duration":"109.261564ms","start":"2026-09-01T07:19:53.709281Z","end":"2026-09-01T07:19:53.818542Z","steps":["trace[1812734413] 'agreement among raft nodes before linearized reading' (duration: 108.729329ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:23:40.83291Z","caller":"traceutil/trace.go:171","msg":"trace[1994822975] transaction","detail":"{read_only:false; response_revision:6922; number_of_response:1; }","duration":"127.567727ms","start":"2026-09-01T07:23:40.705307Z","end":"2026-09-01T07:23:40.832874Z","steps":["trace[1994822975] 'process raft request' (duration: 127.324178ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:23:40.833275Z","caller":"traceutil/trace.go:171","msg":"trace[776892361] transaction","detail":"{read_only:false; response_revision:6923; number_of_response:1; }","duration":"105.60029ms","start":"2026-09-01T07:23:40.727587Z","end":"2026-09-01T07:23:40.833187Z","steps":["trace[776892361] 'process raft request' (duration: 105.217875ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T07:24:53.359648Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5289} {"level":"info","ts":"2026-09-01T07:24:53.46092Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5289,"took":"99.36098ms","hash":2301861644,"current-db-size-bytes":52011008,"current-db-size":"52 MB","current-db-size-in-use-bytes":19075072,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T07:24:53.460998Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2301861644,"revision":5289,"compact-revision":2836}