{"level":"warn","ts":"2026-04-07T00:10:53.800578Z","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-07T00:10:53.800678Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.23: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.23:2380","--initial-cluster=instance=https://199.19.213.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.23: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-07T00:10:53.800746Z","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-07T00:10:53.800759Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.23:2380"]} {"level":"info","ts":"2026-04-07T00:10:53.800778Z","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-07T00:10:53.801342Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.23:2379"]} {"level":"info","ts":"2026-04-07T00:10:53.801412Z","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.19.213.23:2380"],"listen-peer-urls":["https://199.19.213.23:2380"],"advertise-client-urls":["https://199.19.213.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.23: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-07T00:10:53.805447Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.822804ms"} {"level":"info","ts":"2026-04-07T00:10:53.814357Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1812db8446d3ac67","cluster-id":"57ff06cb872baa33"} {"level":"info","ts":"2026-04-07T00:10:53.81448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T00:10:53.814521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became follower at term 0"} {"level":"info","ts":"2026-04-07T00:10:53.814546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1812db8446d3ac67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T00:10:53.814561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became follower at term 1"} {"level":"info","ts":"2026-04-07T00:10:53.814623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 switched to configuration voters=(1734690167661505639)"} {"level":"warn","ts":"2026-04-07T00:10:53.822962Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T00:10:53.825852Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T00:10:53.828566Z","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-07T00:10:53.83117Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1812db8446d3ac67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T00:10:53.831326Z","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-07T00:10:53.831391Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1812db8446d3ac67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T00:10:53.831463Z","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-07T00:10:53.831499Z","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-07T00:10:53.832504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 switched to configuration voters=(1734690167661505639)"} {"level":"info","ts":"2026-04-07T00:10:53.832652Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"57ff06cb872baa33","local-member-id":"1812db8446d3ac67","added-peer-id":"1812db8446d3ac67","added-peer-peer-urls":["https://199.19.213.23:2380"]} {"level":"info","ts":"2026-04-07T00:10:53.834127Z","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-07T00:10:53.834337Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1812db8446d3ac67","initial-advertise-peer-urls":["https://199.19.213.23:2380"],"listen-peer-urls":["https://199.19.213.23:2380"],"advertise-client-urls":["https://199.19.213.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T00:10:53.834368Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T00:10:53.834966Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.23:2380"} {"level":"info","ts":"2026-04-07T00:10:53.834993Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.23:2380"} {"level":"info","ts":"2026-04-07T00:10:54.315546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T00:10:54.315609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T00:10:54.315656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 received MsgPreVoteResp from 1812db8446d3ac67 at term 1"} {"level":"info","ts":"2026-04-07T00:10:54.315675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became candidate at term 2"} {"level":"info","ts":"2026-04-07T00:10:54.315686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 received MsgVoteResp from 1812db8446d3ac67 at term 2"} {"level":"info","ts":"2026-04-07T00:10:54.315702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1812db8446d3ac67 became leader at term 2"} {"level":"info","ts":"2026-04-07T00:10:54.315722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1812db8446d3ac67 elected leader 1812db8446d3ac67 at term 2"} {"level":"info","ts":"2026-04-07T00:10:54.316737Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:10:54.318585Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1812db8446d3ac67","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.23:2379]}","request-path":"/0/members/1812db8446d3ac67/attributes","cluster-id":"57ff06cb872baa33","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T00:10:54.318601Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:10:54.318673Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:10:54.318907Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T00:10:54.31901Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T00:10:54.322483Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T00:10:54.322632Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.23:2379"} {"level":"info","ts":"2026-04-07T00:10:54.332153Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"57ff06cb872baa33","local-member-id":"1812db8446d3ac67","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:10:54.332274Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:10:54.332305Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-07T00:11:24.599323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.825678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:11:24.599435Z","caller":"traceutil/trace.go:171","msg":"trace[1324657581] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:542; }","duration":"149.009142ms","start":"2026-04-07T00:11:24.450407Z","end":"2026-04-07T00:11:24.599416Z","steps":["trace[1324657581] 'range keys from in-memory index tree' (duration: 148.715915ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:24.77522Z","caller":"traceutil/trace.go:171","msg":"trace[2087950305] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:560; }","duration":"191.725336ms","start":"2026-04-07T00:11:24.583444Z","end":"2026-04-07T00:11:24.77517Z","steps":["trace[2087950305] 'read index received' (duration: 190.472529ms)","trace[2087950305] 'applied index is now lower than readState.Index' (duration: 1.251897ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:11:24.7755Z","caller":"traceutil/trace.go:171","msg":"trace[1810426757] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"295.678122ms","start":"2026-04-07T00:11:24.479789Z","end":"2026-04-07T00:11:24.775467Z","steps":["trace[1810426757] 'process raft request' (duration: 294.787743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:24.775572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.109835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T00:11:24.775664Z","caller":"traceutil/trace.go:171","msg":"trace[1558273444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:543; }","duration":"192.251167ms","start":"2026-04-07T00:11:24.583396Z","end":"2026-04-07T00:11:24.775648Z","steps":["trace[1558273444] 'agreement among raft nodes before linearized reading' (duration: 191.935541ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:24.778909Z","caller":"traceutil/trace.go:171","msg":"trace[1107866027] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"171.395951ms","start":"2026-04-07T00:11:24.607418Z","end":"2026-04-07T00:11:24.778814Z","steps":["trace[1107866027] 'process raft request' (duration: 171.266349ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:33.219051Z","caller":"traceutil/trace.go:171","msg":"trace[1510913860] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"397.122447ms","start":"2026-04-07T00:11:32.821898Z","end":"2026-04-07T00:11:33.219021Z","steps":["trace[1510913860] 'process raft request' (duration: 391.833743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:33.219575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:11:32.821878Z","time spent":"397.272831ms","remote":"127.0.0.1:59014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:11:33.454126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.052368ms","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-04-07T00:11:33.454226Z","caller":"traceutil/trace.go:171","msg":"trace[1263651599] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"122.202591ms","start":"2026-04-07T00:11:33.332Z","end":"2026-04-07T00:11:33.454203Z","steps":["trace[1263651599] 'range keys from in-memory index tree' (duration: 121.876253ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:11:49.891527Z","caller":"traceutil/trace.go:171","msg":"trace[127178199] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:784; }","duration":"364.193813ms","start":"2026-04-07T00:11:49.527313Z","end":"2026-04-07T00:11:49.891507Z","steps":["trace[127178199] 'read index received' (duration: 363.954238ms)","trace[127178199] 'applied index is now lower than readState.Index' (duration: 238.805µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:11:49.891703Z","caller":"traceutil/trace.go:171","msg":"trace[1894088635] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"472.239238ms","start":"2026-04-07T00:11:49.419421Z","end":"2026-04-07T00:11:49.89166Z","steps":["trace[1894088635] 'process raft request' (duration: 471.941392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:49.891766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.415587ms","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-04-07T00:11:49.891837Z","caller":"traceutil/trace.go:171","msg":"trace[1903452394] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:760; }","duration":"364.54701ms","start":"2026-04-07T00:11:49.527271Z","end":"2026-04-07T00:11:49.891818Z","steps":["trace[1903452394] 'agreement among raft nodes before linearized reading' (duration: 364.342786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:11:49.891884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:11:49.527249Z","time spent":"364.625632ms","remote":"127.0.0.1:59014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T00:11:49.891885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:11:49.419385Z","time spent":"472.409981ms","remote":"127.0.0.1:58928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:12:19.593624Z","caller":"traceutil/trace.go:171","msg":"trace[1705337177] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"147.236296ms","start":"2026-04-07T00:12:19.446359Z","end":"2026-04-07T00:12:19.593595Z","steps":["trace[1705337177] 'process raft request' (duration: 147.066921ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:40.876422Z","caller":"traceutil/trace.go:171","msg":"trace[1746700612] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"164.555515ms","start":"2026-04-07T00:12:40.711821Z","end":"2026-04-07T00:12:40.876377Z","steps":["trace[1746700612] 'process raft request' (duration: 164.162476ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:12:40.898654Z","caller":"traceutil/trace.go:171","msg":"trace[19712150] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"139.954367ms","start":"2026-04-07T00:12:40.758656Z","end":"2026-04-07T00:12:40.89861Z","steps":["trace[19712150] 'process raft request' (duration: 139.716542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:03.889621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.53258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d6c5ae44-7d58-465d-9d27-4e7547235ae8\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-07T00:13:03.889709Z","caller":"traceutil/trace.go:171","msg":"trace[718408717] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d6c5ae44-7d58-465d-9d27-4e7547235ae8; range_end:; response_count:1; response_revision:1808; }","duration":"108.664834ms","start":"2026-04-07T00:13:03.781025Z","end":"2026-04-07T00:13:03.88969Z","steps":["trace[718408717] 'range keys from in-memory index tree' (duration: 108.180283ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:04.062753Z","caller":"traceutil/trace.go:171","msg":"trace[364197457] linearizableReadLoop","detail":"{readStateIndex:1864; appliedIndex:1862; }","duration":"111.095757ms","start":"2026-04-07T00:13:03.951613Z","end":"2026-04-07T00:13:04.062709Z","steps":["trace[364197457] 'read index received' (duration: 8.253761ms)","trace[364197457] 'applied index is now lower than readState.Index' (duration: 102.840496ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:13:04.062878Z","caller":"traceutil/trace.go:171","msg":"trace[1245385590] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"166.040628ms","start":"2026-04-07T00:13:03.89679Z","end":"2026-04-07T00:13:04.06283Z","steps":["trace[1245385590] 'process raft request' (duration: 113.000089ms)","trace[1245385590] 'compare' (duration: 52.755383ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:13:04.063022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.370603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d6c5ae44-7d58-465d-9d27-4e7547235ae8\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-04-07T00:13:04.063076Z","caller":"traceutil/trace.go:171","msg":"trace[2035081474] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d6c5ae44-7d58-465d-9d27-4e7547235ae8; range_end:; response_count:1; response_revision:1810; }","duration":"111.499016ms","start":"2026-04-07T00:13:03.951562Z","end":"2026-04-07T00:13:04.063061Z","steps":["trace[2035081474] 'agreement among raft nodes before linearized reading' (duration: 111.358603ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:40.748412Z","caller":"traceutil/trace.go:171","msg":"trace[1744905195] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"114.688492ms","start":"2026-04-07T00:13:40.633693Z","end":"2026-04-07T00:13:40.748382Z","steps":["trace[1744905195] 'process raft request' (duration: 114.529648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:46.620432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.238968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-04-07T00:13:46.620896Z","caller":"traceutil/trace.go:171","msg":"trace[664122476] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2147; }","duration":"206.721368ms","start":"2026-04-07T00:13:46.414146Z","end":"2026-04-07T00:13:46.620868Z","steps":["trace[664122476] 'range keys from in-memory index tree' (duration: 206.044453ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:46.933779Z","caller":"traceutil/trace.go:171","msg":"trace[962593899] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2219; }","duration":"160.145725ms","start":"2026-04-07T00:13:46.773608Z","end":"2026-04-07T00:13:46.933754Z","steps":["trace[962593899] 'read index received' (duration: 159.91177ms)","trace[962593899] 'applied index is now lower than readState.Index' (duration: 232.655µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:13:46.93386Z","caller":"traceutil/trace.go:171","msg":"trace[1149094106] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"308.464908ms","start":"2026-04-07T00:13:46.625355Z","end":"2026-04-07T00:13:46.93382Z","steps":["trace[1149094106] 'process raft request' (duration: 308.258914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:13:46.93406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:13:46.625327Z","time spent":"308.618792ms","remote":"127.0.0.1:59014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:13:46.934145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.522633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T00:13:46.934238Z","caller":"traceutil/trace.go:171","msg":"trace[1167950403] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2149; }","duration":"160.625325ms","start":"2026-04-07T00:13:46.773592Z","end":"2026-04-07T00:13:46.934218Z","steps":["trace[1167950403] 'agreement among raft nodes before linearized reading' (duration: 160.265497ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:23.802383Z","caller":"traceutil/trace.go:171","msg":"trace[738940991] linearizableReadLoop","detail":"{readStateIndex:2544; appliedIndex:2543; }","duration":"224.585153ms","start":"2026-04-07T00:14:23.577774Z","end":"2026-04-07T00:14:23.802359Z","steps":["trace[738940991] 'read index received' (duration: 224.316218ms)","trace[738940991] 'applied index is now lower than readState.Index' (duration: 267.725µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:14:23.802456Z","caller":"traceutil/trace.go:171","msg":"trace[988792313] transaction","detail":"{read_only:false; response_revision:2455; number_of_response:1; }","duration":"262.175709ms","start":"2026-04-07T00:14:23.540233Z","end":"2026-04-07T00:14:23.802409Z","steps":["trace[988792313] 'process raft request' (duration: 261.983115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:23.802605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.822318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-04-07T00:14:23.802636Z","caller":"traceutil/trace.go:171","msg":"trace[253582875] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:2455; }","duration":"224.94011ms","start":"2026-04-07T00:14:23.577688Z","end":"2026-04-07T00:14:23.802628Z","steps":["trace[253582875] 'agreement among raft nodes before linearized reading' (duration: 224.791997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:23.802879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.317126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"} {"level":"info","ts":"2026-04-07T00:14:23.802921Z","caller":"traceutil/trace.go:171","msg":"trace[1437785096] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2455; }","duration":"189.457589ms","start":"2026-04-07T00:14:23.613448Z","end":"2026-04-07T00:14:23.802906Z","steps":["trace[1437785096] 'agreement among raft nodes before linearized reading' (duration: 189.259755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:23.802986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.253563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T00:14:23.803011Z","caller":"traceutil/trace.go:171","msg":"trace[1984043581] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2455; }","duration":"113.286473ms","start":"2026-04-07T00:14:23.689717Z","end":"2026-04-07T00:14:23.803004Z","steps":["trace[1984043581] 'agreement among raft nodes before linearized reading' (duration: 113.236622ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:59.488609Z","caller":"traceutil/trace.go:171","msg":"trace[1175560596] transaction","detail":"{read_only:false; response_revision:2699; number_of_response:1; }","duration":"137.526456ms","start":"2026-04-07T00:14:59.351054Z","end":"2026-04-07T00:14:59.48858Z","steps":["trace[1175560596] 'process raft request' (duration: 137.335462ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:59.50838Z","caller":"traceutil/trace.go:171","msg":"trace[123230871] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"156.318409ms","start":"2026-04-07T00:14:59.352033Z","end":"2026-04-07T00:14:59.508352Z","steps":["trace[123230871] 'process raft request' (duration: 156.120645ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:59.50858Z","caller":"traceutil/trace.go:171","msg":"trace[31845114] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"119.671445ms","start":"2026-04-07T00:14:59.388866Z","end":"2026-04-07T00:14:59.508538Z","steps":["trace[31845114] 'process raft request' (duration: 119.43829ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:13.150225Z","caller":"traceutil/trace.go:171","msg":"trace[1080983392] transaction","detail":"{read_only:false; response_revision:4242; number_of_response:1; }","duration":"122.1113ms","start":"2026-04-07T00:17:13.028089Z","end":"2026-04-07T00:17:13.1502Z","steps":["trace[1080983392] 'process raft request' (duration: 121.962267ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:19.41821Z","caller":"traceutil/trace.go:171","msg":"trace[762136291] linearizableReadLoop","detail":"{readStateIndex:4677; appliedIndex:4674; }","duration":"108.493161ms","start":"2026-04-07T00:17:19.309695Z","end":"2026-04-07T00:17:19.418188Z","steps":["trace[762136291] 'read index received' (duration: 664.763µs)","trace[762136291] 'applied index is now lower than readState.Index' (duration: 107.827498ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:17:19.418311Z","caller":"traceutil/trace.go:171","msg":"trace[1901282663] transaction","detail":"{read_only:false; response_revision:4483; number_of_response:1; }","duration":"110.334068ms","start":"2026-04-07T00:17:19.307967Z","end":"2026-04-07T00:17:19.418302Z","steps":["trace[1901282663] 'process raft request' (duration: 95.15034ms)","trace[1901282663] 'compare' (duration: 14.864111ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:17:19.418329Z","caller":"traceutil/trace.go:171","msg":"trace[2064490189] transaction","detail":"{read_only:false; response_revision:4485; number_of_response:1; }","duration":"108.146565ms","start":"2026-04-07T00:17:19.310159Z","end":"2026-04-07T00:17:19.418306Z","steps":["trace[2064490189] 'process raft request' (duration: 107.990302ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:19.418556Z","caller":"traceutil/trace.go:171","msg":"trace[363021349] transaction","detail":"{read_only:false; response_revision:4484; number_of_response:1; }","duration":"109.788897ms","start":"2026-04-07T00:17:19.308755Z","end":"2026-04-07T00:17:19.418544Z","steps":["trace[363021349] 'process raft request' (duration: 109.359969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:19.41869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.973902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/monitoring/loki-gateway-5cc45946cd\" ","response":"range_response_count:1 size:4219"} {"level":"info","ts":"2026-04-07T00:17:19.418718Z","caller":"traceutil/trace.go:171","msg":"trace[1430205354] range","detail":"{range_begin:/registry/replicasets/monitoring/loki-gateway-5cc45946cd; range_end:; response_count:1; response_revision:4485; }","duration":"109.042482ms","start":"2026-04-07T00:17:19.309668Z","end":"2026-04-07T00:17:19.418711Z","steps":["trace[1430205354] 'agreement among raft nodes before linearized reading' (duration: 108.896659ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:19.424001Z","caller":"traceutil/trace.go:171","msg":"trace[755196452] transaction","detail":"{read_only:false; response_revision:4486; number_of_response:1; }","duration":"113.50569ms","start":"2026-04-07T00:17:19.310482Z","end":"2026-04-07T00:17:19.423987Z","steps":["trace[755196452] 'process raft request' (duration: 113.320357ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:19.424142Z","caller":"traceutil/trace.go:171","msg":"trace[1190257822] transaction","detail":"{read_only:false; response_revision:4487; number_of_response:1; }","duration":"111.941229ms","start":"2026-04-07T00:17:19.312177Z","end":"2026-04-07T00:17:19.424118Z","steps":["trace[1190257822] 'process raft request' (duration: 111.695564ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:19.424465Z","caller":"traceutil/trace.go:171","msg":"trace[1730403049] transaction","detail":"{read_only:false; response_revision:4490; number_of_response:1; }","duration":"107.312799ms","start":"2026-04-07T00:17:19.317135Z","end":"2026-04-07T00:17:19.424448Z","steps":["trace[1730403049] 'process raft request' (duration: 107.258178ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:19.424635Z","caller":"traceutil/trace.go:171","msg":"trace[602339238] transaction","detail":"{read_only:false; response_revision:4489; number_of_response:1; }","duration":"110.111254ms","start":"2026-04-07T00:17:19.314504Z","end":"2026-04-07T00:17:19.424615Z","steps":["trace[602339238] 'process raft request' (duration: 109.816089ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:19.424653Z","caller":"traceutil/trace.go:171","msg":"trace[175382872] transaction","detail":"{read_only:false; response_revision:4488; number_of_response:1; }","duration":"112.255146ms","start":"2026-04-07T00:17:19.312382Z","end":"2026-04-07T00:17:19.424637Z","steps":["trace[175382872] 'process raft request' (duration: 111.559881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:19.428118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.678467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T00:17:19.428163Z","caller":"traceutil/trace.go:171","msg":"trace[202729283] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4491; }","duration":"106.768938ms","start":"2026-04-07T00:17:19.321383Z","end":"2026-04-07T00:17:19.428152Z","steps":["trace[202729283] 'agreement among raft nodes before linearized reading' (duration: 106.574714ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:22.307927Z","caller":"traceutil/trace.go:171","msg":"trace[1561289847] linearizableReadLoop","detail":"{readStateIndex:4754; appliedIndex:4753; }","duration":"223.295548ms","start":"2026-04-07T00:17:22.084589Z","end":"2026-04-07T00:17:22.307884Z","steps":["trace[1561289847] 'read index received' (duration: 210.794792ms)","trace[1561289847] 'applied index is now lower than readState.Index' (duration: 12.498946ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:17:22.308005Z","caller":"traceutil/trace.go:171","msg":"trace[1734805169] transaction","detail":"{read_only:false; response_revision:4560; number_of_response:1; }","duration":"225.989402ms","start":"2026-04-07T00:17:22.08198Z","end":"2026-04-07T00:17:22.307969Z","steps":["trace[1734805169] 'process raft request' (duration: 213.419174ms)","trace[1734805169] 'compare' (duration: 12.210011ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:17:22.308189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.571864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1da983d5-b442-463e-9adc-e26adbce14b5\" ","response":"range_response_count:1 size:3720"} {"level":"info","ts":"2026-04-07T00:17:22.308301Z","caller":"traceutil/trace.go:171","msg":"trace[1791468472] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1da983d5-b442-463e-9adc-e26adbce14b5; range_end:; response_count:1; response_revision:4560; }","duration":"223.755007ms","start":"2026-04-07T00:17:22.084526Z","end":"2026-04-07T00:17:22.308281Z","steps":["trace[1791468472] 'agreement among raft nodes before linearized reading' (duration: 223.523202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:22.405954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.157753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-07T00:17:22.405964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.419552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:17:22.406065Z","caller":"traceutil/trace.go:171","msg":"trace[713460276] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4560; }","duration":"230.291665ms","start":"2026-04-07T00:17:22.175746Z","end":"2026-04-07T00:17:22.406038Z","steps":["trace[713460276] 'agreement among raft nodes before linearized reading' (duration: 230.02318ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:22.406085Z","caller":"traceutil/trace.go:171","msg":"trace[437384763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4560; }","duration":"192.575185ms","start":"2026-04-07T00:17:22.213479Z","end":"2026-04-07T00:17:22.406054Z","steps":["trace[437384763] 'agreement among raft nodes before linearized reading' (duration: 192.332021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:22.406107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.684224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T00:17:22.406168Z","caller":"traceutil/trace.go:171","msg":"trace[143025619] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4560; }","duration":"229.808806ms","start":"2026-04-07T00:17:22.176343Z","end":"2026-04-07T00:17:22.406151Z","steps":["trace[143025619] 'agreement among raft nodes before linearized reading' (duration: 229.510791ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:34.500309Z","caller":"traceutil/trace.go:171","msg":"trace[1901908320] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"138.849398ms","start":"2026-04-07T00:17:34.361402Z","end":"2026-04-07T00:17:34.500252Z","steps":["trace[1901908320] 'process raft request' (duration: 95.874444ms)","trace[1901908320] 'compare' (duration: 42.551025ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:17:34.500518Z","caller":"traceutil/trace.go:171","msg":"trace[1992240618] transaction","detail":"{read_only:false; response_revision:4800; number_of_response:1; }","duration":"138.783577ms","start":"2026-04-07T00:17:34.361705Z","end":"2026-04-07T00:17:34.500489Z","steps":["trace[1992240618] 'process raft request' (duration: 138.40775ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:34.501105Z","caller":"traceutil/trace.go:171","msg":"trace[1320682816] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"139.207325ms","start":"2026-04-07T00:17:34.361882Z","end":"2026-04-07T00:17:34.501089Z","steps":["trace[1320682816] 'process raft request' (duration: 138.546832ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:35.090408Z","caller":"traceutil/trace.go:171","msg":"trace[1095451311] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"180.203161ms","start":"2026-04-07T00:17:34.910162Z","end":"2026-04-07T00:17:35.090365Z","steps":["trace[1095451311] 'process raft request' (duration: 179.863204ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:41.902697Z","caller":"traceutil/trace.go:171","msg":"trace[31353220] linearizableReadLoop","detail":"{readStateIndex:5170; appliedIndex:5168; }","duration":"234.404047ms","start":"2026-04-07T00:17:41.668265Z","end":"2026-04-07T00:17:41.902669Z","steps":["trace[31353220] 'read index received' (duration: 234.097391ms)","trace[31353220] 'applied index is now lower than readState.Index' (duration: 305.756µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:17:41.902843Z","caller":"traceutil/trace.go:171","msg":"trace[1250869085] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"261.059351ms","start":"2026-04-07T00:17:41.64173Z","end":"2026-04-07T00:17:41.902789Z","steps":["trace[1250869085] 'process raft request' (duration: 260.704014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:17:41.90304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.737593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-04-07T00:17:41.903089Z","caller":"traceutil/trace.go:171","msg":"trace[527010812] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4961; }","duration":"234.844245ms","start":"2026-04-07T00:17:41.668228Z","end":"2026-04-07T00:17:41.903072Z","steps":["trace[527010812] 'agreement among raft nodes before linearized reading' (duration: 234.609021ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:41.903473Z","caller":"traceutil/trace.go:171","msg":"trace[1710251513] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"261.039631ms","start":"2026-04-07T00:17:41.641754Z","end":"2026-04-07T00:17:41.902793Z","steps":["trace[1710251513] 'process raft request' (duration: 260.873858ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:17:42.165741Z","caller":"traceutil/trace.go:171","msg":"trace[1521361528] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"117.682453ms","start":"2026-04-07T00:17:42.048035Z","end":"2026-04-07T00:17:42.165717Z","steps":["trace[1521361528] 'process raft request' (duration: 117.464218ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:20:54.347948Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3242} {"level":"info","ts":"2026-04-07T00:20:54.440806Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3242,"took":"90.950324ms","hash":2263677857,"current-db-size-bytes":61353984,"current-db-size":"61 MB","current-db-size-in-use-bytes":33951744,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-07T00:20:54.440887Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2263677857,"revision":3242,"compact-revision":-1} {"level":"info","ts":"2026-04-07T00:23:30.120259Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002133.wal"} {"level":"info","ts":"2026-04-07T00:23:34.0657Z","caller":"traceutil/trace.go:171","msg":"trace[111334809] linearizableReadLoop","detail":"{readStateIndex:8532; appliedIndex:8531; }","duration":"346.262916ms","start":"2026-04-07T00:23:33.719412Z","end":"2026-04-07T00:23:34.065675Z","steps":["trace[111334809] 'read index received' (duration: 346.092332ms)","trace[111334809] 'applied index is now lower than readState.Index' (duration: 169.504µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:23:34.066004Z","caller":"traceutil/trace.go:171","msg":"trace[920280511] transaction","detail":"{read_only:false; response_revision:8169; number_of_response:1; }","duration":"359.134967ms","start":"2026-04-07T00:23:33.706858Z","end":"2026-04-07T00:23:34.065992Z","steps":["trace[920280511] 'process raft request' (duration: 358.665516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:23:34.066107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:23:33.706836Z","time spent":"359.193349ms","remote":"127.0.0.1:59014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:23:34.066346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.942261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T00:23:34.066379Z","caller":"traceutil/trace.go:171","msg":"trace[546766782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8169; }","duration":"347.016453ms","start":"2026-04-07T00:23:33.719354Z","end":"2026-04-07T00:23:34.06637Z","steps":["trace[546766782] 'agreement among raft nodes before linearized reading' (duration: 346.90073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:23:34.066401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:23:33.719323Z","time spent":"347.073234ms","remote":"127.0.0.1:59014","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-07T00:23:34.066497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.038401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"info","ts":"2026-04-07T00:23:34.066547Z","caller":"traceutil/trace.go:171","msg":"trace[843461359] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8169; }","duration":"277.149673ms","start":"2026-04-07T00:23:33.789382Z","end":"2026-04-07T00:23:34.066532Z","steps":["trace[843461359] 'agreement among raft nodes before linearized reading' (duration: 277.02173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:23:34.066814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.240368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dvjrv\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-04-07T00:23:34.066835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.128771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-04-07T00:23:34.066848Z","caller":"traceutil/trace.go:171","msg":"trace[712938412] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dvjrv; range_end:; response_count:1; response_revision:8169; }","duration":"151.32631ms","start":"2026-04-07T00:23:33.915511Z","end":"2026-04-07T00:23:34.066837Z","steps":["trace[712938412] 'agreement among raft nodes before linearized reading' (duration: 151.181657ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:23:34.066884Z","caller":"traceutil/trace.go:171","msg":"trace[1777671091] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8169; }","duration":"253.160392ms","start":"2026-04-07T00:23:33.813696Z","end":"2026-04-07T00:23:34.066856Z","steps":["trace[1777671091] 'agreement among raft nodes before linearized reading' (duration: 253.009748ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:23:34.244161Z","caller":"traceutil/trace.go:171","msg":"trace[439855298] transaction","detail":"{read_only:false; response_revision:8170; number_of_response:1; }","duration":"173.846379ms","start":"2026-04-07T00:23:34.070285Z","end":"2026-04-07T00:23:34.244132Z","steps":["trace[439855298] 'process raft request' (duration: 171.307351ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:23:34.244248Z","caller":"traceutil/trace.go:171","msg":"trace[356220502] transaction","detail":"{read_only:false; response_revision:8171; number_of_response:1; }","duration":"171.783172ms","start":"2026-04-07T00:23:34.072437Z","end":"2026-04-07T00:23:34.24422Z","steps":["trace[356220502] 'process raft request' (duration: 171.67571ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:23:34.244384Z","caller":"traceutil/trace.go:171","msg":"trace[590102405] linearizableReadLoop","detail":"{readStateIndex:8533; appliedIndex:8532; }","duration":"172.074709ms","start":"2026-04-07T00:23:34.072291Z","end":"2026-04-07T00:23:34.244365Z","steps":["trace[590102405] 'read index received' (duration: 169.765057ms)","trace[590102405] 'applied index is now lower than readState.Index' (duration: 2.307492ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:23:34.244585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.272794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:568"} {"level":"info","ts":"2026-04-07T00:23:34.244618Z","caller":"traceutil/trace.go:171","msg":"trace[1145380093] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8171; }","duration":"172.337835ms","start":"2026-04-07T00:23:34.072267Z","end":"2026-04-07T00:23:34.244605Z","steps":["trace[1145380093] 'agreement among raft nodes before linearized reading' (duration: 172.180971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:23:34.244711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.48155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:24 size:203467"} {"level":"info","ts":"2026-04-07T00:23:34.244737Z","caller":"traceutil/trace.go:171","msg":"trace[1604155520] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:24; response_revision:8171; }","duration":"169.541731ms","start":"2026-04-07T00:23:34.075187Z","end":"2026-04-07T00:23:34.244729Z","steps":["trace[1604155520] 'agreement among raft nodes before linearized reading' (duration: 169.283866ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:23:46.387487Z","caller":"traceutil/trace.go:171","msg":"trace[278622485] linearizableReadLoop","detail":"{readStateIndex:8619; appliedIndex:8618; }","duration":"173.236135ms","start":"2026-04-07T00:23:46.214226Z","end":"2026-04-07T00:23:46.387462Z","steps":["trace[278622485] 'read index received' (duration: 173.015551ms)","trace[278622485] 'applied index is now lower than readState.Index' (duration: 219.634µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:23:46.387559Z","caller":"traceutil/trace.go:171","msg":"trace[586332744] transaction","detail":"{read_only:false; response_revision:8251; number_of_response:1; }","duration":"253.380526ms","start":"2026-04-07T00:23:46.134141Z","end":"2026-04-07T00:23:46.387521Z","steps":["trace[586332744] 'process raft request' (duration: 253.158371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:23:46.387697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.45263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:23:46.387745Z","caller":"traceutil/trace.go:171","msg":"trace[2000901946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8251; }","duration":"173.558622ms","start":"2026-04-07T00:23:46.214173Z","end":"2026-04-07T00:23:46.387732Z","steps":["trace[2000901946] 'agreement among raft nodes before linearized reading' (duration: 173.46418ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:23:47.311467Z","caller":"traceutil/trace.go:171","msg":"trace[630022943] linearizableReadLoop","detail":"{readStateIndex:8627; appliedIndex:8626; }","duration":"120.143795ms","start":"2026-04-07T00:23:47.191296Z","end":"2026-04-07T00:23:47.31144Z","steps":["trace[630022943] 'read index received' (duration: 119.997772ms)","trace[630022943] 'applied index is now lower than readState.Index' (duration: 145.043µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:23:47.311525Z","caller":"traceutil/trace.go:171","msg":"trace[1394622648] transaction","detail":"{read_only:false; response_revision:8259; number_of_response:1; }","duration":"242.626074ms","start":"2026-04-07T00:23:47.068865Z","end":"2026-04-07T00:23:47.311491Z","steps":["trace[1394622648] 'process raft request' (duration: 242.403579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:23:47.311797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.451373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-04-07T00:23:47.311845Z","caller":"traceutil/trace.go:171","msg":"trace[775127744] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8259; }","duration":"120.580075ms","start":"2026-04-07T00:23:47.191254Z","end":"2026-04-07T00:23:47.311834Z","steps":["trace[775127744] 'agreement among raft nodes before linearized reading' (duration: 120.318339ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:24:14.001884Z","caller":"traceutil/trace.go:171","msg":"trace[1885026597] linearizableReadLoop","detail":"{readStateIndex:8869; appliedIndex:8868; }","duration":"379.546957ms","start":"2026-04-07T00:24:13.62228Z","end":"2026-04-07T00:24:14.001827Z","steps":["trace[1885026597] 'read index received' (duration: 379.427915ms)","trace[1885026597] 'applied index is now lower than readState.Index' (duration: 117.552µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:24:14.001939Z","caller":"traceutil/trace.go:171","msg":"trace[997011493] transaction","detail":"{read_only:false; response_revision:8489; number_of_response:1; }","duration":"380.95399ms","start":"2026-04-07T00:24:13.620949Z","end":"2026-04-07T00:24:14.001903Z","steps":["trace[997011493] 'process raft request' (duration: 380.680234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:24:14.002066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.759994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:24:14.002078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:24:13.620928Z","time spent":"381.074143ms","remote":"127.0.0.1:59014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:24:14.002107Z","caller":"traceutil/trace.go:171","msg":"trace[1548981565] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:8489; }","duration":"379.855125ms","start":"2026-04-07T00:24:13.622239Z","end":"2026-04-07T00:24:14.002095Z","steps":["trace[1548981565] 'agreement among raft nodes before linearized reading' (duration: 379.728511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:24:14.002155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:24:13.622227Z","time spent":"379.917776ms","remote":"127.0.0.1:51802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"info","ts":"2026-04-07T00:24:14.238474Z","caller":"traceutil/trace.go:171","msg":"trace[1611196933] linearizableReadLoop","detail":"{readStateIndex:8870; appliedIndex:8869; }","duration":"183.440147ms","start":"2026-04-07T00:24:14.055007Z","end":"2026-04-07T00:24:14.238447Z","steps":["trace[1611196933] 'read index received' (duration: 135.529364ms)","trace[1611196933] 'applied index is now lower than readState.Index' (duration: 47.909333ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:24:14.238523Z","caller":"traceutil/trace.go:171","msg":"trace[1849024806] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"523.089842ms","start":"2026-04-07T00:24:13.715399Z","end":"2026-04-07T00:24:14.238489Z","steps":["trace[1849024806] 'process raft request' (duration: 475.062687ms)","trace[1849024806] 'compare' (duration: 47.77508ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:24:14.238658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.880824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:24:14.238669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:24:13.715377Z","time spent":"523.207115ms","remote":"127.0.0.1:59014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:24:14.238697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.680982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11499"} {"level":"info","ts":"2026-04-07T00:24:14.238719Z","caller":"traceutil/trace.go:171","msg":"trace[1396345151] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:8490; }","duration":"156.011356ms","start":"2026-04-07T00:24:14.082694Z","end":"2026-04-07T00:24:14.238705Z","steps":["trace[1396345151] 'agreement among raft nodes before linearized reading' (duration: 155.914174ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:24:14.238725Z","caller":"traceutil/trace.go:171","msg":"trace[1327868243] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8490; }","duration":"183.761634ms","start":"2026-04-07T00:24:14.054955Z","end":"2026-04-07T00:24:14.238716Z","steps":["trace[1327868243] 'agreement among raft nodes before linearized reading' (duration: 183.61593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:24:27.609286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:24:27.292388Z","time spent":"316.890067ms","remote":"127.0.0.1:58774","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-07T00:24:27.624328Z","caller":"traceutil/trace.go:171","msg":"trace[420162944] linearizableReadLoop","detail":"{readStateIndex:9012; appliedIndex:9010; }","duration":"252.895915ms","start":"2026-04-07T00:24:27.371407Z","end":"2026-04-07T00:24:27.624303Z","steps":["trace[420162944] 'read index received' (duration: 218.381353ms)","trace[420162944] 'applied index is now lower than readState.Index' (duration: 34.513322ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:24:27.624437Z","caller":"traceutil/trace.go:171","msg":"trace[2119000472] transaction","detail":"{read_only:false; response_revision:8623; number_of_response:1; }","duration":"282.698383ms","start":"2026-04-07T00:24:27.341727Z","end":"2026-04-07T00:24:27.624426Z","steps":["trace[2119000472] 'process raft request' (duration: 282.409506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:24:27.624616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.195092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:24:27.624707Z","caller":"traceutil/trace.go:171","msg":"trace[1663307159] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:8623; }","duration":"253.353845ms","start":"2026-04-07T00:24:27.371339Z","end":"2026-04-07T00:24:27.624692Z","steps":["trace[1663307159] 'agreement among raft nodes before linearized reading' (duration: 253.215862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:24:27.630858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.178447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T00:24:27.63094Z","caller":"traceutil/trace.go:171","msg":"trace[1647357844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8624; }","duration":"132.31057ms","start":"2026-04-07T00:24:27.49861Z","end":"2026-04-07T00:24:27.630921Z","steps":["trace[1647357844] 'agreement among raft nodes before linearized reading' (duration: 132.064674ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:24:28.324566Z","caller":"traceutil/trace.go:171","msg":"trace[1826350655] linearizableReadLoop","detail":"{readStateIndex:9017; appliedIndex:9016; }","duration":"111.886092ms","start":"2026-04-07T00:24:28.212651Z","end":"2026-04-07T00:24:28.324537Z","steps":["trace[1826350655] 'read index received' (duration: 111.724248ms)","trace[1826350655] 'applied index is now lower than readState.Index' (duration: 160.374µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:24:28.324735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.057616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:24:28.324695Z","caller":"traceutil/trace.go:171","msg":"trace[1452298595] transaction","detail":"{read_only:false; response_revision:8628; number_of_response:1; }","duration":"121.743152ms","start":"2026-04-07T00:24:28.202908Z","end":"2026-04-07T00:24:28.324651Z","steps":["trace[1452298595] 'process raft request' (duration: 121.433775ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:24:28.324779Z","caller":"traceutil/trace.go:171","msg":"trace[885441270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8628; }","duration":"112.169279ms","start":"2026-04-07T00:24:28.212598Z","end":"2026-04-07T00:24:28.324767Z","steps":["trace[885441270] 'agreement among raft nodes before linearized reading' (duration: 112.061286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:24:28.71441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.568362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:24:28.7145Z","caller":"traceutil/trace.go:171","msg":"trace[240218402] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:8628; }","duration":"224.703965ms","start":"2026-04-07T00:24:28.489772Z","end":"2026-04-07T00:24:28.714476Z","steps":["trace[240218402] 'count revisions from in-memory index tree' (duration: 224.4795ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:25:36.264709Z","caller":"traceutil/trace.go:171","msg":"trace[101099976] transaction","detail":"{read_only:false; response_revision:9359; number_of_response:1; }","duration":"141.251781ms","start":"2026-04-07T00:25:36.123427Z","end":"2026-04-07T00:25:36.264679Z","steps":["trace[101099976] 'process raft request' (duration: 141.040926ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:25:36.436344Z","caller":"traceutil/trace.go:171","msg":"trace[1240435622] transaction","detail":"{read_only:false; response_revision:9360; number_of_response:1; }","duration":"131.771449ms","start":"2026-04-07T00:25:36.304521Z","end":"2026-04-07T00:25:36.436293Z","steps":["trace[1240435622] 'process raft request' (duration: 116.204575ms)","trace[1240435622] 'compare' (duration: 15.118374ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:25:54.354483Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6618} {"level":"info","ts":"2026-04-07T00:25:54.451926Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6618,"took":"95.339588ms","hash":1042031908,"current-db-size-bytes":61353984,"current-db-size":"61 MB","current-db-size-in-use-bytes":27029504,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-04-07T00:25:54.451995Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1042031908,"revision":6618,"compact-revision":3242} {"level":"info","ts":"2026-04-07T00:25:59.849854Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1812db8446d3ac67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T00:25:59.855946Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T00:25:59.856075Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T00:30:54.362446Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9534} {"level":"info","ts":"2026-04-07T00:30:54.450993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9534,"took":"86.092863ms","hash":1314788614,"current-db-size-bytes":61353984,"current-db-size":"61 MB","current-db-size-in-use-bytes":25239552,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-07T00:30:54.451054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1314788614,"revision":9534,"compact-revision":6618}