{"level":"warn","ts":"2026-07-15T04:52:34.548916Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T04:52:34.549001Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.105:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.105:2380","--initial-cluster=instance=https://199.19.213.105:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.105:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.105:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-15T04:52:34.549066Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T04:52:34.549079Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-07-15T04:52:34.549101Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-15T04:52:34.549736Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"]} {"level":"info","ts":"2026-07-15T04:52:34.549817Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.105:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-15T04:52:34.554Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.992415ms"} {"level":"info","ts":"2026-07-15T04:52:34.563249Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"eb6db91b2c71522f","cluster-id":"f43476f3367c14fb"} {"level":"info","ts":"2026-07-15T04:52:34.563498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f switched to configuration voters=()"} {"level":"info","ts":"2026-07-15T04:52:34.563568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became follower at term 0"} {"level":"info","ts":"2026-07-15T04:52:34.563583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft eb6db91b2c71522f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-15T04:52:34.563592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became follower at term 1"} {"level":"info","ts":"2026-07-15T04:52:34.563654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f switched to configuration voters=(16964418897735406127)"} {"level":"warn","ts":"2026-07-15T04:52:34.572999Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-15T04:52:34.574965Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-15T04:52:34.577776Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-15T04:52:34.58079Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"eb6db91b2c71522f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-15T04:52:34.580965Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"eb6db91b2c71522f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-15T04:52:34.581104Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-15T04:52:34.581197Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-15T04:52:34.581207Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-15T04:52:34.581862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f switched to configuration voters=(16964418897735406127)"} {"level":"info","ts":"2026-07-15T04:52:34.591213Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","added-peer-id":"eb6db91b2c71522f","added-peer-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-07-15T04:52:34.5919Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-15T04:52:34.592056Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"eb6db91b2c71522f","initial-advertise-peer-urls":["https://199.19.213.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-15T04:52:34.592072Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-15T04:52:34.592121Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-07-15T04:52:34.592129Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-07-15T04:52:35.264532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f is starting a new election at term 1"} {"level":"info","ts":"2026-07-15T04:52:35.264608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became pre-candidate at term 1"} {"level":"info","ts":"2026-07-15T04:52:35.264648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f received MsgPreVoteResp from eb6db91b2c71522f at term 1"} {"level":"info","ts":"2026-07-15T04:52:35.26467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became candidate at term 2"} {"level":"info","ts":"2026-07-15T04:52:35.264686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f received MsgVoteResp from eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-07-15T04:52:35.264709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"eb6db91b2c71522f became leader at term 2"} {"level":"info","ts":"2026-07-15T04:52:35.264729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: eb6db91b2c71522f elected leader eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-07-15T04:52:35.266239Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"eb6db91b2c71522f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.105:2379]}","request-path":"/0/members/eb6db91b2c71522f/attributes","cluster-id":"f43476f3367c14fb","publish-timeout":"7s"} {"level":"info","ts":"2026-07-15T04:52:35.266416Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T04:52:35.266452Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T04:52:35.266473Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:52:35.267467Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:52:35.267614Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:52:35.26765Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:52:35.269816Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-15T04:52:35.269879Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-15T04:52:35.270135Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.105:2379"} {"level":"info","ts":"2026-07-15T04:52:35.270639Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-15T04:53:31.336315Z","caller":"traceutil/trace.go:171","msg":"trace[253071280] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:686; }","duration":"219.726906ms","start":"2026-07-15T04:53:31.116557Z","end":"2026-07-15T04:53:31.336284Z","steps":["trace[253071280] 'read index received' (duration: 219.059796ms)","trace[253071280] 'applied index is now lower than readState.Index' (duration: 665.64µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:53:31.336381Z","caller":"traceutil/trace.go:171","msg":"trace[175733889] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"249.703374ms","start":"2026-07-15T04:53:31.086634Z","end":"2026-07-15T04:53:31.336338Z","steps":["trace[175733889] 'process raft request' (duration: 249.056024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:31.337193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.610404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-15T04:53:31.337296Z","caller":"traceutil/trace.go:171","msg":"trace[654837559] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:660; }","duration":"220.780578ms","start":"2026-07-15T04:53:31.1165Z","end":"2026-07-15T04:53:31.337281Z","steps":["trace[654837559] 'agreement among raft nodes before linearized reading' (duration: 220.478759ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:38.088589Z","caller":"traceutil/trace.go:171","msg":"trace[2139794115] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"283.819972ms","start":"2026-07-15T04:53:37.804745Z","end":"2026-07-15T04:53:38.088565Z","steps":["trace[2139794115] 'process raft request' (duration: 283.669888ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:38.337494Z","caller":"traceutil/trace.go:171","msg":"trace[1160949970] linearizableReadLoop","detail":"{readStateIndex:717; appliedIndex:716; }","duration":"138.490883ms","start":"2026-07-15T04:53:38.198973Z","end":"2026-07-15T04:53:38.337464Z","steps":["trace[1160949970] 'read index received' (duration: 138.201325ms)","trace[1160949970] 'applied index is now lower than readState.Index' (duration: 288.278µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:53:38.337554Z","caller":"traceutil/trace.go:171","msg":"trace[1032333787] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"235.868426ms","start":"2026-07-15T04:53:38.101643Z","end":"2026-07-15T04:53:38.337511Z","steps":["trace[1032333787] 'process raft request' (duration: 235.612549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:38.337959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.950995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.105\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-15T04:53:38.338077Z","caller":"traceutil/trace.go:171","msg":"trace[1576190683] range","detail":"{range_begin:/registry/masterleases/199.19.213.105; range_end:; response_count:1; response_revision:689; }","duration":"139.14006ms","start":"2026-07-15T04:53:38.19891Z","end":"2026-07-15T04:53:38.33805Z","steps":["trace[1576190683] 'agreement among raft nodes before linearized reading' (duration: 138.736249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:08.144583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.6112ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:55:08.144826Z","caller":"traceutil/trace.go:171","msg":"trace[453114254] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"253.374925ms","start":"2026-07-15T04:55:07.89143Z","end":"2026-07-15T04:55:08.144805Z","steps":["trace[453114254] 'process raft request' (duration: 253.291133ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:08.144819Z","caller":"traceutil/trace.go:171","msg":"trace[1332658445] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"255.425744ms","start":"2026-07-15T04:55:07.88936Z","end":"2026-07-15T04:55:08.144786Z","steps":["trace[1332658445] 'process raft request' (duration: 26.863011ms)","trace[1332658445] 'compare' (duration: 227.470407ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:55:08.473797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.440439ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:55:08.473923Z","caller":"traceutil/trace.go:171","msg":"trace[636487630] linearizableReadLoop","detail":"{readStateIndex:1987; appliedIndex:1986; }","duration":"487.180518ms","start":"2026-07-15T04:55:07.986725Z","end":"2026-07-15T04:55:08.473906Z","steps":["trace[636487630] 'read index received' (duration: 279.586616ms)","trace[636487630] 'applied index is now lower than readState.Index' (duration: 207.589082ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:55:08.474021Z","caller":"traceutil/trace.go:171","msg":"trace[470510382] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"538.116028ms","start":"2026-07-15T04:55:07.935892Z","end":"2026-07-15T04:55:08.474008Z","steps":["trace[470510382] 'process raft request' (duration: 330.382755ms)","trace[470510382] 'compare' (duration: 207.337088ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:55:08.474307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.856959ms","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-07-15T04:55:08.474395Z","caller":"traceutil/trace.go:171","msg":"trace[296829837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1913; }","duration":"375.953711ms","start":"2026-07-15T04:55:08.09842Z","end":"2026-07-15T04:55:08.474374Z","steps":["trace[296829837] 'agreement among raft nodes before linearized reading' (duration: 375.721517ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:08.4744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.673545ms","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":"warn","ts":"2026-07-15T04:55:08.474378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.494577ms","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-07-15T04:55:08.474449Z","caller":"traceutil/trace.go:171","msg":"trace[1824280805] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1913; }","duration":"487.755156ms","start":"2026-07-15T04:55:07.986678Z","end":"2026-07-15T04:55:08.474433Z","steps":["trace[1824280805] 'agreement among raft nodes before linearized reading' (duration: 487.588904ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:08.474442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:55:08.098361Z","time spent":"376.071652ms","remote":"127.0.0.1:51580","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-07-15T04:55:08.474487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:55:07.986655Z","time spent":"487.825137ms","remote":"127.0.0.1:46764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-15T04:55:08.474486Z","caller":"traceutil/trace.go:171","msg":"trace[946596990] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1913; }","duration":"253.649059ms","start":"2026-07-15T04:55:08.220815Z","end":"2026-07-15T04:55:08.474464Z","steps":["trace[946596990] 'agreement among raft nodes before linearized reading' (duration: 253.488237ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:08.474518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.101072ms","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-07-15T04:55:08.474574Z","caller":"traceutil/trace.go:171","msg":"trace[1454558071] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1913; }","duration":"371.193823ms","start":"2026-07-15T04:55:08.103365Z","end":"2026-07-15T04:55:08.474559Z","steps":["trace[1454558071] 'agreement among raft nodes before linearized reading' (duration: 370.94661ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:08.474574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.955489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.105\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-15T04:55:08.474621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:55:08.103353Z","time spent":"371.259365ms","remote":"127.0.0.1:51580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-15T04:55:08.474629Z","caller":"traceutil/trace.go:171","msg":"trace[454233413] range","detail":"{range_begin:/registry/masterleases/199.19.213.105; range_end:; response_count:1; response_revision:1913; }","duration":"270.00532ms","start":"2026-07-15T04:55:08.204612Z","end":"2026-07-15T04:55:08.474617Z","steps":["trace[454233413] 'agreement among raft nodes before linearized reading' (duration: 269.651025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:08.47433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.562002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-04342dd4-9318-45fa-b94b-439f1ea4343e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-15T04:55:08.474764Z","caller":"traceutil/trace.go:171","msg":"trace[1161129834] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-04342dd4-9318-45fa-b94b-439f1ea4343e; range_end:; response_count:1; response_revision:1913; }","duration":"235.035138ms","start":"2026-07-15T04:55:08.239712Z","end":"2026-07-15T04:55:08.474747Z","steps":["trace[1161129834] 'agreement among raft nodes before linearized reading' (duration: 234.46631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:08.474463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:55:07.935869Z","time spent":"538.521414ms","remote":"127.0.0.1:51580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:55:08.76114Z","caller":"traceutil/trace.go:171","msg":"trace[1318398228] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"282.332864ms","start":"2026-07-15T04:55:08.47878Z","end":"2026-07-15T04:55:08.761112Z","steps":["trace[1318398228] 'process raft request' (duration: 282.255513ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:08.761272Z","caller":"traceutil/trace.go:171","msg":"trace[1327019620] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"283.037433ms","start":"2026-07-15T04:55:08.478194Z","end":"2026-07-15T04:55:08.761231Z","steps":["trace[1327019620] 'process raft request' (duration: 282.573306ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:08.93847Z","caller":"traceutil/trace.go:171","msg":"trace[1393107547] linearizableReadLoop","detail":"{readStateIndex:1991; appliedIndex:1990; }","duration":"377.973539ms","start":"2026-07-15T04:55:08.560472Z","end":"2026-07-15T04:55:08.938445Z","steps":["trace[1393107547] 'read index received' (duration: 200.730295ms)","trace[1393107547] 'applied index is now lower than readState.Index' (duration: 177.242274ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:55:08.938511Z","caller":"traceutil/trace.go:171","msg":"trace[133085458] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"444.601097ms","start":"2026-07-15T04:55:08.493862Z","end":"2026-07-15T04:55:08.938463Z","steps":["trace[133085458] 'process raft request' (duration: 387.865149ms)","trace[133085458] 'compare' (duration: 56.393894ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:55:08.938697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.213272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-04342dd4-9318-45fa-b94b-439f1ea4343e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-15T04:55:08.938778Z","caller":"traceutil/trace.go:171","msg":"trace[675266269] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-04342dd4-9318-45fa-b94b-439f1ea4343e; range_end:; response_count:1; response_revision:1917; }","duration":"378.333844ms","start":"2026-07-15T04:55:08.560425Z","end":"2026-07-15T04:55:08.938759Z","steps":["trace[675266269] 'agreement among raft nodes before linearized reading' (duration: 378.137322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:08.938823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:55:08.560403Z","time spent":"378.412095ms","remote":"127.0.0.1:51520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-04342dd4-9318-45fa-b94b-439f1ea4343e\" "} {"level":"warn","ts":"2026-07-15T04:55:08.938919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.380669ms","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-07-15T04:55:08.938832Z","caller":"traceutil/trace.go:171","msg":"trace[2128201224] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"341.03194ms","start":"2026-07-15T04:55:08.597529Z","end":"2026-07-15T04:55:08.938561Z","steps":["trace[2128201224] 'process raft request' (duration: 340.817887ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:08.938976Z","caller":"traceutil/trace.go:171","msg":"trace[248870344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1917; }","duration":"281.495521ms","start":"2026-07-15T04:55:08.657469Z","end":"2026-07-15T04:55:08.938964Z","steps":["trace[248870344] 'agreement among raft nodes before linearized reading' (duration: 281.273238ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:08.938948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:55:08.493845Z","time spent":"444.875622ms","remote":"127.0.0.1:51378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:55:08.939233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:55:08.5975Z","time spent":"341.581708ms","remote":"127.0.0.1:51580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:55:13.761387Z","caller":"traceutil/trace.go:171","msg":"trace[2146816258] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"119.53961ms","start":"2026-07-15T04:55:13.641826Z","end":"2026-07-15T04:55:13.761365Z","steps":["trace[2146816258] 'process raft request' (duration: 119.386787ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:13.761456Z","caller":"traceutil/trace.go:171","msg":"trace[1101731042] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"151.827214ms","start":"2026-07-15T04:55:13.609606Z","end":"2026-07-15T04:55:13.761433Z","steps":["trace[1101731042] 'process raft request' (duration: 83.993453ms)","trace[1101731042] 'compare' (duration: 67.500626ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:55:20.348713Z","caller":"traceutil/trace.go:171","msg":"trace[1730651185] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"114.737433ms","start":"2026-07-15T04:55:20.233949Z","end":"2026-07-15T04:55:20.348687Z","steps":["trace[1730651185] 'process raft request' (duration: 111.411479ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:22.684886Z","caller":"traceutil/trace.go:171","msg":"trace[244650016] linearizableReadLoop","detail":"{readStateIndex:2107; appliedIndex:2106; }","duration":"116.454252ms","start":"2026-07-15T04:55:22.568403Z","end":"2026-07-15T04:55:22.684857Z","steps":["trace[244650016] 'read index received' (duration: 116.25276ms)","trace[244650016] 'applied index is now lower than readState.Index' (duration: 200.412µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:55:22.684994Z","caller":"traceutil/trace.go:171","msg":"trace[1841204113] transaction","detail":"{read_only:false; response_revision:2029; number_of_response:1; }","duration":"165.625478ms","start":"2026-07-15T04:55:22.519324Z","end":"2026-07-15T04:55:22.68495Z","steps":["trace[1841204113] 'process raft request' (duration: 165.381075ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:22.685061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.646184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-15T04:55:22.685098Z","caller":"traceutil/trace.go:171","msg":"trace[1478439866] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2029; }","duration":"116.768166ms","start":"2026-07-15T04:55:22.568319Z","end":"2026-07-15T04:55:22.685087Z","steps":["trace[1478439866] 'agreement among raft nodes before linearized reading' (duration: 116.630374ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:23.041236Z","caller":"traceutil/trace.go:171","msg":"trace[1959507053] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"236.907482ms","start":"2026-07-15T04:55:22.804315Z","end":"2026-07-15T04:55:23.041222Z","steps":["trace[1959507053] 'process raft request' (duration: 236.643369ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:23.041463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.261395ms","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-07-15T04:55:23.041516Z","caller":"traceutil/trace.go:171","msg":"trace[30384197] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2030; }","duration":"211.363417ms","start":"2026-07-15T04:55:22.830141Z","end":"2026-07-15T04:55:23.041504Z","steps":["trace[30384197] 'agreement among raft nodes before linearized reading' (duration: 211.215035ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:23.041152Z","caller":"traceutil/trace.go:171","msg":"trace[1481602757] linearizableReadLoop","detail":"{readStateIndex:2108; appliedIndex:2107; }","duration":"210.947611ms","start":"2026-07-15T04:55:22.830186Z","end":"2026-07-15T04:55:23.041134Z","steps":["trace[1481602757] 'read index received' (duration: 210.712958ms)","trace[1481602757] 'applied index is now lower than readState.Index' (duration: 233.733µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:55:23.042797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.797783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-15T04:55:23.042843Z","caller":"traceutil/trace.go:171","msg":"trace[1672929725] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2031; }","duration":"211.882714ms","start":"2026-07-15T04:55:22.830949Z","end":"2026-07-15T04:55:23.042832Z","steps":["trace[1672929725] 'agreement among raft nodes before linearized reading' (duration: 211.755512ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:47.097278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.137683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-15T04:55:47.097366Z","caller":"traceutil/trace.go:171","msg":"trace[1085372932] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2174; }","duration":"241.306055ms","start":"2026-07-15T04:55:46.856038Z","end":"2026-07-15T04:55:47.097344Z","steps":["trace[1085372932] 'range keys from in-memory index tree' (duration: 240.955581ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:47.844295Z","caller":"traceutil/trace.go:171","msg":"trace[435254090] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"150.943001ms","start":"2026-07-15T04:55:47.693324Z","end":"2026-07-15T04:55:47.844267Z","steps":["trace[435254090] 'process raft request' (duration: 150.772429ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:48.090903Z","caller":"traceutil/trace.go:171","msg":"trace[1889808749] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"157.581926ms","start":"2026-07-15T04:55:47.933293Z","end":"2026-07-15T04:55:48.090875Z","steps":["trace[1889808749] 'process raft request' (duration: 103.753076ms)","trace[1889808749] 'compare' (duration: 53.547896ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:55:48.309431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.336339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.105\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-15T04:55:48.309551Z","caller":"traceutil/trace.go:171","msg":"trace[809984743] range","detail":"{range_begin:/registry/masterleases/199.19.213.105; range_end:; response_count:1; response_revision:2180; }","duration":"103.546531ms","start":"2026-07-15T04:55:48.205975Z","end":"2026-07-15T04:55:48.309521Z","steps":["trace[809984743] 'range keys from in-memory index tree' (duration: 103.056536ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:56:39.581776Z","caller":"traceutil/trace.go:171","msg":"trace[1237478754] linearizableReadLoop","detail":"{readStateIndex:2661; appliedIndex:2660; }","duration":"100.77795ms","start":"2026-07-15T04:56:39.48098Z","end":"2026-07-15T04:56:39.581758Z","steps":["trace[1237478754] 'read index received' (duration: 100.614838ms)","trace[1237478754] 'applied index is now lower than readState.Index' (duration: 160.902µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:56:39.581847Z","caller":"traceutil/trace.go:171","msg":"trace[316378565] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"101.338145ms","start":"2026-07-15T04:56:39.480474Z","end":"2026-07-15T04:56:39.581812Z","steps":["trace[316378565] 'process raft request' (duration: 101.184274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:56:39.581923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.927841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-15T04:56:39.581973Z","caller":"traceutil/trace.go:171","msg":"trace[1047085482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2565; }","duration":"101.024233ms","start":"2026-07-15T04:56:39.480942Z","end":"2026-07-15T04:56:39.581966Z","steps":["trace[1047085482] 'agreement among raft nodes before linearized reading' (duration: 100.885492ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:56:40.399608Z","caller":"traceutil/trace.go:171","msg":"trace[1349335742] transaction","detail":"{read_only:false; response_revision:2568; number_of_response:1; }","duration":"122.625687ms","start":"2026-07-15T04:56:40.276962Z","end":"2026-07-15T04:56:40.399587Z","steps":["trace[1349335742] 'process raft request' (duration: 119.00204ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:11.625193Z","caller":"traceutil/trace.go:171","msg":"trace[869829395] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"173.044164ms","start":"2026-07-15T04:57:11.45213Z","end":"2026-07-15T04:57:11.625174Z","steps":["trace[869829395] 'process raft request' (duration: 172.912992ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:11.63327Z","caller":"traceutil/trace.go:171","msg":"trace[466497377] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"156.196593ms","start":"2026-07-15T04:57:11.477057Z","end":"2026-07-15T04:57:11.633253Z","steps":["trace[466497377] 'process raft request' (duration: 156.015351ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:57:17.153331Z","caller":"traceutil/trace.go:171","msg":"trace[1128974626] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"161.815244ms","start":"2026-07-15T04:57:16.991499Z","end":"2026-07-15T04:57:17.153314Z","steps":["trace[1128974626] 'process raft request' (duration: 161.71895ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:00:57.270543Z","caller":"traceutil/trace.go:171","msg":"trace[1047872221] linearizableReadLoop","detail":"{readStateIndex:4875; appliedIndex:4874; }","duration":"218.093504ms","start":"2026-07-15T05:00:57.052425Z","end":"2026-07-15T05:00:57.270519Z","steps":["trace[1047872221] 'read index received' (duration: 217.911361ms)","trace[1047872221] 'applied index is now lower than readState.Index' (duration: 180.943µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:00:57.270631Z","caller":"traceutil/trace.go:171","msg":"trace[1589193105] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"307.22704ms","start":"2026-07-15T05:00:56.963371Z","end":"2026-07-15T05:00:57.270598Z","steps":["trace[1589193105] 'process raft request' (duration: 307.010176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:00:57.270749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:00:56.96335Z","time spent":"307.333691ms","remote":"127.0.0.1:51580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T05:00:57.270787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.362289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-09a950fb-0b33-40d0-8f75-c911787aeadb\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-15T05:00:57.270826Z","caller":"traceutil/trace.go:171","msg":"trace[1490137537] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-09a950fb-0b33-40d0-8f75-c911787aeadb; range_end:; response_count:1; response_revision:4698; }","duration":"218.455271ms","start":"2026-07-15T05:00:57.052357Z","end":"2026-07-15T05:00:57.270813Z","steps":["trace[1490137537] 'agreement among raft nodes before linearized reading' (duration: 218.280638ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:00:57.653583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.781111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-15T05:00:57.653878Z","caller":"traceutil/trace.go:171","msg":"trace[1695872499] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"175.216833ms","start":"2026-07-15T05:00:57.478478Z","end":"2026-07-15T05:00:57.653695Z","steps":["trace[1695872499] 'process raft request' (duration: 30.176417ms)","trace[1695872499] 'compare' (duration: 144.309723ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:01:09.190082Z","caller":"traceutil/trace.go:171","msg":"trace[63239440] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"322.122336ms","start":"2026-07-15T05:01:08.867939Z","end":"2026-07-15T05:01:09.190061Z","steps":["trace[63239440] 'process raft request' (duration: 322.070505ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T05:01:09.190221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:01:08.86792Z","time spent":"322.230278ms","remote":"127.0.0.1:51580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T05:01:09.190226Z","caller":"traceutil/trace.go:171","msg":"trace[316762063] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"323.148204ms","start":"2026-07-15T05:01:08.867049Z","end":"2026-07-15T05:01:09.190197Z","steps":["trace[316762063] 'process raft request' (duration: 283.840888ms)","trace[316762063] 'compare' (duration: 38.712076ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T05:01:09.190362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T05:01:08.867024Z","time spent":"323.265396ms","remote":"127.0.0.1:51580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T05:01:09.530346Z","caller":"traceutil/trace.go:171","msg":"trace[1097290486] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"187.543371ms","start":"2026-07-15T05:01:09.342779Z","end":"2026-07-15T05:01:09.530322Z","steps":["trace[1097290486] 'process raft request' (duration: 166.828748ms)","trace[1097290486] 'compare' (duration: 20.54351ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T05:02:35.297077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868} {"level":"info","ts":"2026-07-15T05:02:35.436797Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"138.706806ms","hash":1473242299,"current-db-size-bytes":53764096,"current-db-size":"54 MB","current-db-size-in-use-bytes":29454336,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-15T05:02:35.43686Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1473242299,"revision":2868,"compact-revision":-1} {"level":"info","ts":"2026-07-15T05:04:44.922892Z","caller":"traceutil/trace.go:171","msg":"trace[346090166] transaction","detail":"{read_only:false; response_revision:6444; number_of_response:1; }","duration":"124.644162ms","start":"2026-07-15T05:04:44.798212Z","end":"2026-07-15T05:04:44.922856Z","steps":["trace[346090166] 'process raft request' (duration: 124.424169ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:04:52.016728Z","caller":"traceutil/trace.go:171","msg":"trace[290632918] transaction","detail":"{read_only:false; response_revision:6487; number_of_response:1; }","duration":"127.989114ms","start":"2026-07-15T05:04:51.888708Z","end":"2026-07-15T05:04:52.016697Z","steps":["trace[290632918] 'process raft request' (duration: 127.531558ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T05:07:35.301418Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5570} {"level":"info","ts":"2026-07-15T05:07:35.399363Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5570,"took":"96.718049ms","hash":231039431,"current-db-size-bytes":53764096,"current-db-size":"54 MB","current-db-size-in-use-bytes":18305024,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-15T05:07:35.399413Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":231039431,"revision":5570,"compact-revision":2868}