{"level":"warn","ts":"2026-04-30T06:00:33.554626Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-30T06:00:33.554756Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-04-30T06:00:33.55485Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-30T06:00:33.554871Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-30T06:00:33.5549Z","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-04-30T06:00:33.555882Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-04-30T06:00:33.555993Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-04-30T06:00:33.56017Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.901856ms"} {"level":"info","ts":"2026-04-30T06:00:33.566316Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-04-30T06:00:33.566403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-04-30T06:00:33.566426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-04-30T06:00:33.566441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-30T06:00:33.56645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-04-30T06:00:33.56649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-04-30T06:00:33.57658Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-30T06:00:33.578131Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-30T06:00:33.579664Z","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-04-30T06:00:33.581846Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-30T06:00:33.582085Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-30T06:00:33.582199Z","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-04-30T06:00:33.582345Z","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-04-30T06:00:33.582365Z","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-04-30T06:00:33.583961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-04-30T06:00:33.584539Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-30T06:00:33.587122Z","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-04-30T06:00:33.587256Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-30T06:00:33.587364Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-30T06:00:33.587533Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-30T06:00:33.587615Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-30T06:00:34.266932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-04-30T06:00:34.266998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-30T06:00:34.267021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-04-30T06:00:34.267041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-04-30T06:00:34.267052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-30T06:00:34.267099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-04-30T06:00:34.267113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-30T06:00:34.26837Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-04-30T06:00:34.268398Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-30T06:00:34.268443Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T06:00:34.268482Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-30T06:00:34.268755Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-30T06:00:34.26881Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-30T06:00:34.269726Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T06:00:34.269831Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T06:00:34.269897Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-30T06:00:34.271739Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-04-30T06:00:34.271752Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-30T06:00:47.490316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.88938ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-30T06:00:47.49046Z","caller":"traceutil/trace.go:171","msg":"trace[2083531475] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"283.335087ms","start":"2026-04-30T06:00:47.207107Z","end":"2026-04-30T06:00:47.490442Z","steps":["trace[2083531475] 'process raft request' (duration: 140.741057ms)","trace[2083531475] 'compare' (duration: 141.717005ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:01:17.086713Z","caller":"traceutil/trace.go:171","msg":"trace[1829685309] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"232.572197ms","start":"2026-04-30T06:01:16.854117Z","end":"2026-04-30T06:01:17.086689Z","steps":["trace[1829685309] 'process raft request' (duration: 232.244297ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:01:20.095831Z","caller":"traceutil/trace.go:171","msg":"trace[532793213] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"136.821471ms","start":"2026-04-30T06:01:19.958987Z","end":"2026-04-30T06:01:20.095808Z","steps":["trace[532793213] 'process raft request' (duration: 135.890355ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:01:20.53725Z","caller":"traceutil/trace.go:171","msg":"trace[780261756] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"276.971635ms","start":"2026-04-30T06:01:20.260254Z","end":"2026-04-30T06:01:20.537226Z","steps":["trace[780261756] 'process raft request' (duration: 276.684617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:26.002541Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422192580993999,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-30T06:01:26.503128Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422192580993999,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-30T06:01:27.003824Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422192580993999,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-30T06:01:27.504556Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422192580993999,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-30T06:01:27.676158Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.347567388s","expected-duration":"1s"} {"level":"info","ts":"2026-04-30T06:01:27.676756Z","caller":"traceutil/trace.go:171","msg":"trace[1322896629] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"2.348575616s","start":"2026-04-30T06:01:25.328148Z","end":"2026-04-30T06:01:27.676724Z","steps":["trace[1322896629] 'process raft request' (duration: 2.348365191s)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.676921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:25.328119Z","time spent":"2.348727281s","remote":"127.0.0.1:41316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-30T06:01:27.68216Z","caller":"traceutil/trace.go:171","msg":"trace[1393160160] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:731; }","duration":"2.180290303s","start":"2026-04-30T06:01:25.501849Z","end":"2026-04-30T06:01:27.68214Z","steps":["trace[1393160160] 'read index received' (duration: 2.174657173s)","trace[1393160160] 'applied index is now lower than readState.Index' (duration: 5.63249ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:01:27.682249Z","caller":"traceutil/trace.go:171","msg":"trace[1753616496] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"754.255134ms","start":"2026-04-30T06:01:26.927987Z","end":"2026-04-30T06:01:27.682242Z","steps":["trace[1753616496] 'process raft request' (duration: 754.10062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.682339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:26.927946Z","time spent":"754.324146ms","remote":"127.0.0.1:41568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-30T06:01:27.682524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.434346985s","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-04-30T06:01:27.682555Z","caller":"traceutil/trace.go:171","msg":"trace[1214493823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:710; }","duration":"1.434456589s","start":"2026-04-30T06:01:26.248091Z","end":"2026-04-30T06:01:27.682547Z","steps":["trace[1214493823] 'agreement among raft nodes before linearized reading' (duration: 1.434345805s)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.682574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:26.248051Z","time spent":"1.43451947s","remote":"127.0.0.1:41568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-30T06:01:27.682619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.767307709s","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":"warn","ts":"2026-04-30T06:01:27.682664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.330214ms","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-04-30T06:01:27.682695Z","caller":"traceutil/trace.go:171","msg":"trace[768631115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:710; }","duration":"853.383007ms","start":"2026-04-30T06:01:26.829306Z","end":"2026-04-30T06:01:27.682689Z","steps":["trace[768631115] 'agreement among raft nodes before linearized reading' (duration: 853.320845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.682712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:26.829296Z","time spent":"853.412487ms","remote":"127.0.0.1:41568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-30T06:01:27.682704Z","caller":"traceutil/trace.go:171","msg":"trace[1039836023] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:710; }","duration":"1.767431243s","start":"2026-04-30T06:01:25.915254Z","end":"2026-04-30T06:01:27.682686Z","steps":["trace[1039836023] 'agreement among raft nodes before linearized reading' (duration: 1.767261289s)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.682737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.875238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-30T06:01:27.682744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:25.915248Z","time spent":"1.767488515s","remote":"127.0.0.1:41568","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":"warn","ts":"2026-04-30T06:01:27.682725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.580049407s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"warn","ts":"2026-04-30T06:01:27.682779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.980565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-30T06:01:27.682618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.811337479s","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-04-30T06:01:27.682837Z","caller":"traceutil/trace.go:171","msg":"trace[1588449441] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:710; }","duration":"492.031336ms","start":"2026-04-30T06:01:27.190786Z","end":"2026-04-30T06:01:27.682817Z","steps":["trace[1588449441] 'agreement among raft nodes before linearized reading' (duration: 491.849261ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:01:27.682838Z","caller":"traceutil/trace.go:171","msg":"trace[930642985] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:710; }","duration":"1.580251164s","start":"2026-04-30T06:01:26.102553Z","end":"2026-04-30T06:01:27.682804Z","steps":["trace[930642985] 'agreement among raft nodes before linearized reading' (duration: 1.579927635s)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:01:27.682851Z","caller":"traceutil/trace.go:171","msg":"trace[587657474] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:710; }","duration":"1.811650798s","start":"2026-04-30T06:01:25.871194Z","end":"2026-04-30T06:01:27.682845Z","steps":["trace[587657474] 'agreement among raft nodes before linearized reading' (duration: 1.811221876s)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.68286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.181016643s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"warn","ts":"2026-04-30T06:01:27.68287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:27.190715Z","time spent":"492.145999ms","remote":"127.0.0.1:41296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.25\" "} {"level":"warn","ts":"2026-04-30T06:01:27.682877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:25.871181Z","time spent":"1.811690609s","remote":"127.0.0.1:41568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-30T06:01:27.682884Z","caller":"traceutil/trace.go:171","msg":"trace[962607439] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:710; }","duration":"2.181093876s","start":"2026-04-30T06:01:25.50178Z","end":"2026-04-30T06:01:27.682874Z","steps":["trace[962607439] 'agreement among raft nodes before linearized reading' (duration: 2.181018404s)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.682889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:26.102527Z","time spent":"1.580350706s","remote":"127.0.0.1:41316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24267,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-04-30T06:01:27.682905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:25.501753Z","time spent":"2.181146017s","remote":"127.0.0.1:41316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"info","ts":"2026-04-30T06:01:27.682774Z","caller":"traceutil/trace.go:171","msg":"trace[1626400992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:710; }","duration":"854.94001ms","start":"2026-04-30T06:01:26.827816Z","end":"2026-04-30T06:01:27.682756Z","steps":["trace[1626400992] 'agreement among raft nodes before linearized reading' (duration: 854.863528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.683023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.780546895s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-04-30T06:01:27.683105Z","caller":"traceutil/trace.go:171","msg":"trace[976591632] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:710; }","duration":"1.780670898s","start":"2026-04-30T06:01:25.902412Z","end":"2026-04-30T06:01:27.683083Z","steps":["trace[976591632] 'agreement among raft nodes before linearized reading' (duration: 1.780262416s)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.683142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:25.9024Z","time spent":"1.78073431s","remote":"127.0.0.1:41316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13252,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-04-30T06:01:27.683107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:26.827791Z","time spent":"855.225718ms","remote":"127.0.0.1:41568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-30T06:01:27.68341Z","caller":"traceutil/trace.go:171","msg":"trace[1572786931] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"1.950406463s","start":"2026-04-30T06:01:25.731891Z","end":"2026-04-30T06:01:27.682298Z","steps":["trace[1572786931] 'process raft request' (duration: 1.949984101s)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.68379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:25.73184Z","time spent":"1.951615077s","remote":"127.0.0.1:41316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-30T06:01:27.683833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.515090525s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-30T06:01:27.683877Z","caller":"traceutil/trace.go:171","msg":"trace[1027425608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:710; }","duration":"1.515156337s","start":"2026-04-30T06:01:26.168706Z","end":"2026-04-30T06:01:27.683862Z","steps":["trace[1027425608] 'agreement among raft nodes before linearized reading' (duration: 1.513879141s)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:01:27.683908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:01:26.168689Z","time spent":"1.515214129s","remote":"127.0.0.1:41282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-30T06:01:38.516224Z","caller":"traceutil/trace.go:171","msg":"trace[1446947913] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"207.285059ms","start":"2026-04-30T06:01:38.308917Z","end":"2026-04-30T06:01:38.516202Z","steps":["trace[1446947913] 'process raft request' (duration: 207.076934ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:02:41.768459Z","caller":"traceutil/trace.go:171","msg":"trace[219255649] transaction","detail":"{read_only:false; response_revision:1540; number_of_response:1; }","duration":"102.628524ms","start":"2026-04-30T06:02:41.665801Z","end":"2026-04-30T06:02:41.768429Z","steps":["trace[219255649] 'process raft request' (duration: 52.276974ms)","trace[219255649] 'compare' (duration: 50.150645ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:03:00.935262Z","caller":"traceutil/trace.go:171","msg":"trace[447129287] linearizableReadLoop","detail":"{readStateIndex:1968; appliedIndex:1967; }","duration":"169.693749ms","start":"2026-04-30T06:03:00.765539Z","end":"2026-04-30T06:03:00.935233Z","steps":["trace[447129287] 'read index received' (duration: 119.470543ms)","trace[447129287] 'applied index is now lower than readState.Index' (duration: 50.221746ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:03:00.93534Z","caller":"traceutil/trace.go:171","msg":"trace[127628698] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"209.631404ms","start":"2026-04-30T06:03:00.725674Z","end":"2026-04-30T06:03:00.935306Z","steps":["trace[127628698] 'process raft request' (duration: 159.47981ms)","trace[127628698] 'compare' (duration: 49.936938ms)"],"step_count":2} {"level":"warn","ts":"2026-04-30T06:03:00.935528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.975818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0094f782-16fb-42a2-a19e-45be78285480\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-30T06:03:00.935605Z","caller":"traceutil/trace.go:171","msg":"trace[1655280902] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0094f782-16fb-42a2-a19e-45be78285480; range_end:; response_count:1; response_revision:1895; }","duration":"170.103112ms","start":"2026-04-30T06:03:00.765484Z","end":"2026-04-30T06:03:00.935587Z","steps":["trace[1655280902] 'agreement among raft nodes before linearized reading' (duration: 169.915777ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:03:01.288499Z","caller":"traceutil/trace.go:171","msg":"trace[1127665860] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"346.831092ms","start":"2026-04-30T06:03:00.941626Z","end":"2026-04-30T06:03:01.288457Z","steps":["trace[1127665860] 'process raft request' (duration: 346.625366ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:03:01.288514Z","caller":"traceutil/trace.go:171","msg":"trace[1312265614] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"346.74555ms","start":"2026-04-30T06:03:00.941718Z","end":"2026-04-30T06:03:01.288464Z","steps":["trace[1312265614] 'process raft request' (duration: 346.598566ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:03:01.288574Z","caller":"traceutil/trace.go:171","msg":"trace[180356902] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"346.947055ms","start":"2026-04-30T06:03:00.941576Z","end":"2026-04-30T06:03:01.288523Z","steps":["trace[180356902] 'process raft request' (duration: 291.666405ms)","trace[180356902] 'compare' (duration: 54.858899ms)"],"step_count":2} {"level":"warn","ts":"2026-04-30T06:03:01.288734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:03:00.9417Z","time spent":"346.922814ms","remote":"127.0.0.1:41466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-30T06:03:01.288747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:03:00.941613Z","time spent":"346.983816ms","remote":"127.0.0.1:41582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-30T06:03:01.288782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:03:00.941562Z","time spent":"347.103479ms","remote":"127.0.0.1:41582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-30T06:03:01.288843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.814661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-30T06:03:01.288885Z","caller":"traceutil/trace.go:171","msg":"trace[1089279148] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"343.534128ms","start":"2026-04-30T06:03:00.945294Z","end":"2026-04-30T06:03:01.288828Z","steps":["trace[1089279148] 'process raft request' (duration: 343.103266ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:03:01.28871Z","caller":"traceutil/trace.go:171","msg":"trace[595223972] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1969; }","duration":"120.660458ms","start":"2026-04-30T06:03:01.168017Z","end":"2026-04-30T06:03:01.288677Z","steps":["trace[595223972] 'read index received' (duration: 65.11351ms)","trace[595223972] 'applied index is now lower than readState.Index' (duration: 55.544398ms)"],"step_count":2} {"level":"warn","ts":"2026-04-30T06:03:01.289078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:03:00.945285Z","time spent":"343.694312ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-30T06:03:01.288972Z","caller":"traceutil/trace.go:171","msg":"trace[632769561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1900; }","duration":"120.997677ms","start":"2026-04-30T06:03:01.167952Z","end":"2026-04-30T06:03:01.28895Z","steps":["trace[632769561] 'agreement among raft nodes before linearized reading' (duration: 120.819462ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:03:01.569569Z","caller":"traceutil/trace.go:171","msg":"trace[1339900510] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"117.384474ms","start":"2026-04-30T06:03:01.452159Z","end":"2026-04-30T06:03:01.569544Z","steps":["trace[1339900510] 'process raft request' (duration: 117.206078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:09:15.827875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.161734ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-30T06:09:15.828073Z","caller":"traceutil/trace.go:171","msg":"trace[544146831] transaction","detail":"{read_only:false; response_revision:5107; number_of_response:1; }","duration":"326.878794ms","start":"2026-04-30T06:09:15.501123Z","end":"2026-04-30T06:09:15.828002Z","steps":["trace[544146831] 'process raft request' (duration: 168.469764ms)","trace[544146831] 'compare' (duration: 157.925587ms)"],"step_count":2} {"level":"warn","ts":"2026-04-30T06:09:15.828142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:09:15.501087Z","time spent":"327.030929ms","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3290,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-30T06:09:15.850597Z","caller":"traceutil/trace.go:171","msg":"trace[1812519028] linearizableReadLoop","detail":"{readStateIndex:5300; appliedIndex:5298; }","duration":"310.865184ms","start":"2026-04-30T06:09:15.539696Z","end":"2026-04-30T06:09:15.850562Z","steps":["trace[1812519028] 'read index received' (duration: 129.995942ms)","trace[1812519028] 'applied index is now lower than readState.Index' (duration: 180.868002ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:09:15.850736Z","caller":"traceutil/trace.go:171","msg":"trace[118642925] transaction","detail":"{read_only:false; response_revision:5108; number_of_response:1; }","duration":"337.08434ms","start":"2026-04-30T06:09:15.513605Z","end":"2026-04-30T06:09:15.850689Z","steps":["trace[118642925] 'process raft request' (duration: 336.730571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:09:15.850866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.165892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-99vg5\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-30T06:09:15.850912Z","caller":"traceutil/trace.go:171","msg":"trace[1202402440] range","detail":"{range_begin:/registry/pods/openstack/keepalived-99vg5; range_end:; response_count:1; response_revision:5108; }","duration":"311.291156ms","start":"2026-04-30T06:09:15.539609Z","end":"2026-04-30T06:09:15.8509Z","steps":["trace[1202402440] 'agreement among raft nodes before linearized reading' (duration: 311.101271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:09:15.850956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:09:15.539584Z","time spent":"311.363628ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-99vg5\" "} {"level":"warn","ts":"2026-04-30T06:09:15.850946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-30T06:09:15.513578Z","time spent":"337.257396ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58177,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-30T06:09:15.874053Z","caller":"traceutil/trace.go:171","msg":"trace[307688518] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"154.579303ms","start":"2026-04-30T06:09:15.719442Z","end":"2026-04-30T06:09:15.874021Z","steps":["trace[307688518] 'process raft request' (duration: 154.301015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:09:15.874293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.272311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-30T06:09:15.874335Z","caller":"traceutil/trace.go:171","msg":"trace[1312033240] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:5110; }","duration":"261.366394ms","start":"2026-04-30T06:09:15.612954Z","end":"2026-04-30T06:09:15.874321Z","steps":["trace[1312033240] 'agreement among raft nodes before linearized reading' (duration: 261.259401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-30T06:09:15.874451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.384204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-30T06:09:15.874472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.720731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2d492964-69fe-4372-9836-53b0e61d2af0\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-04-30T06:09:15.874528Z","caller":"traceutil/trace.go:171","msg":"trace[1834117272] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:5110; }","duration":"119.521418ms","start":"2026-04-30T06:09:15.754984Z","end":"2026-04-30T06:09:15.874505Z","steps":["trace[1834117272] 'agreement among raft nodes before linearized reading' (duration: 119.332533ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:09:15.874551Z","caller":"traceutil/trace.go:171","msg":"trace[72792741] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2d492964-69fe-4372-9836-53b0e61d2af0; range_end:; response_count:1; response_revision:5110; }","duration":"147.824394ms","start":"2026-04-30T06:09:15.726703Z","end":"2026-04-30T06:09:15.874527Z","steps":["trace[72792741] 'agreement among raft nodes before linearized reading' (duration: 147.658589ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:09:36.235192Z","caller":"traceutil/trace.go:171","msg":"trace[1786778289] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"193.566036ms","start":"2026-04-30T06:09:36.041596Z","end":"2026-04-30T06:09:36.235162Z","steps":["trace[1786778289] 'process raft request' (duration: 93.527705ms)","trace[1786778289] 'compare' (duration: 99.424824ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:09:36.444583Z","caller":"traceutil/trace.go:171","msg":"trace[1344168468] transaction","detail":"{read_only:false; response_revision:5515; number_of_response:1; }","duration":"129.490353ms","start":"2026-04-30T06:09:36.315053Z","end":"2026-04-30T06:09:36.444543Z","steps":["trace[1344168468] 'process raft request' (duration: 98.645491ms)","trace[1344168468] 'compare' (duration: 30.683998ms)"],"step_count":2} {"level":"info","ts":"2026-04-30T06:09:36.445663Z","caller":"traceutil/trace.go:171","msg":"trace[1836902518] transaction","detail":"{read_only:false; response_revision:5517; number_of_response:1; }","duration":"130.101821ms","start":"2026-04-30T06:09:36.315527Z","end":"2026-04-30T06:09:36.445629Z","steps":["trace[1836902518] 'process raft request' (duration: 129.979627ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:09:36.446048Z","caller":"traceutil/trace.go:171","msg":"trace[833448171] transaction","detail":"{read_only:false; response_revision:5518; number_of_response:1; }","duration":"130.456561ms","start":"2026-04-30T06:09:36.315563Z","end":"2026-04-30T06:09:36.446019Z","steps":["trace[833448171] 'process raft request' (duration: 130.013298ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:09:36.446189Z","caller":"traceutil/trace.go:171","msg":"trace[1531081970] transaction","detail":"{read_only:false; response_revision:5516; number_of_response:1; }","duration":"130.709118ms","start":"2026-04-30T06:09:36.315462Z","end":"2026-04-30T06:09:36.446172Z","steps":["trace[1531081970] 'process raft request' (duration: 129.886755ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:09:36.446904Z","caller":"traceutil/trace.go:171","msg":"trace[325790991] transaction","detail":"{read_only:false; response_revision:5520; number_of_response:1; }","duration":"130.582884ms","start":"2026-04-30T06:09:36.316306Z","end":"2026-04-30T06:09:36.446889Z","steps":["trace[325790991] 'process raft request' (duration: 130.107591ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:09:36.448375Z","caller":"traceutil/trace.go:171","msg":"trace[1899024446] transaction","detail":"{read_only:false; response_revision:5519; number_of_response:1; }","duration":"130.78014ms","start":"2026-04-30T06:09:36.315708Z","end":"2026-04-30T06:09:36.446489Z","steps":["trace[1899024446] 'process raft request' (duration: 130.236565ms)"],"step_count":1} {"level":"info","ts":"2026-04-30T06:10:34.295389Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2976} {"level":"info","ts":"2026-04-30T06:10:34.371294Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2976,"took":"74.226339ms","hash":467312112,"current-db-size-bytes":55947264,"current-db-size":"56 MB","current-db-size-in-use-bytes":32591872,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-30T06:10:34.37137Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":467312112,"revision":2976,"compact-revision":-1}