{"level":"warn","ts":"2026-06-28T10:58:11.893572Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T10:58:11.893779Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.81: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.81:2380","--initial-cluster=instance=https://199.19.213.81:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.81:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.81: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-06-28T10:58:11.893869Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T10:58:11.893882Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.81:2380"]} {"level":"info","ts":"2026-06-28T10:58:11.893903Z","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-06-28T10:58:11.894927Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"]} {"level":"info","ts":"2026-06-28T10:58:11.896088Z","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.81:2380"],"listen-peer-urls":["https://199.19.213.81:2380"],"advertise-client-urls":["https://199.19.213.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.81: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-06-28T10:58:11.899943Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.564445ms"} {"level":"info","ts":"2026-06-28T10:58:11.908017Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1627b0b72e417489","cluster-id":"d42e5eae8a1b814c"} {"level":"info","ts":"2026-06-28T10:58:11.908107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=()"} {"level":"info","ts":"2026-06-28T10:58:11.908143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became follower at term 0"} {"level":"info","ts":"2026-06-28T10:58:11.908161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1627b0b72e417489 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-28T10:58:11.908177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became follower at term 1"} {"level":"info","ts":"2026-06-28T10:58:11.908219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=(1596438893727675529)"} {"level":"warn","ts":"2026-06-28T10:58:11.915439Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-28T10:58:11.916915Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-28T10:58:11.917921Z","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-06-28T10:58:11.920407Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1627b0b72e417489","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-28T10:58:11.920694Z","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-06-28T10:58:11.920791Z","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-06-28T10:58:11.920806Z","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-06-28T10:58:11.922226Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1627b0b72e417489","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-28T10:58:11.925648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=(1596438893727675529)"} {"level":"info","ts":"2026-06-28T10:58:11.925782Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d42e5eae8a1b814c","local-member-id":"1627b0b72e417489","added-peer-id":"1627b0b72e417489","added-peer-peer-urls":["https://199.19.213.81:2380"]} {"level":"info","ts":"2026-06-28T10:58:11.92721Z","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-06-28T10:58:11.927375Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.81:2380"} {"level":"info","ts":"2026-06-28T10:58:11.927425Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.81:2380"} {"level":"info","ts":"2026-06-28T10:58:11.927584Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1627b0b72e417489","initial-advertise-peer-urls":["https://199.19.213.81:2380"],"listen-peer-urls":["https://199.19.213.81:2380"],"advertise-client-urls":["https://199.19.213.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-28T10:58:11.927637Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-28T10:58:12.909536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 is starting a new election at term 1"} {"level":"info","ts":"2026-06-28T10:58:12.909655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-28T10:58:12.909684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 received MsgPreVoteResp from 1627b0b72e417489 at term 1"} {"level":"info","ts":"2026-06-28T10:58:12.909706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became candidate at term 2"} {"level":"info","ts":"2026-06-28T10:58:12.909719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 received MsgVoteResp from 1627b0b72e417489 at term 2"} {"level":"info","ts":"2026-06-28T10:58:12.909737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became leader at term 2"} {"level":"info","ts":"2026-06-28T10:58:12.90976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1627b0b72e417489 elected leader 1627b0b72e417489 at term 2"} {"level":"info","ts":"2026-06-28T10:58:12.910876Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T10:58:12.911648Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1627b0b72e417489","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.81:2379]}","request-path":"/0/members/1627b0b72e417489/attributes","cluster-id":"d42e5eae8a1b814c","publish-timeout":"7s"} {"level":"info","ts":"2026-06-28T10:58:12.911698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T10:58:12.911667Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T10:58:12.911942Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-28T10:58:12.912023Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-28T10:58:12.912184Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d42e5eae8a1b814c","local-member-id":"1627b0b72e417489","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T10:58:12.912387Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T10:58:12.912431Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T10:58:12.914204Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-28T10:58:12.915327Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.81:2379"} {"level":"info","ts":"2026-06-28T10:58:50.552144Z","caller":"traceutil/trace.go:171","msg":"trace[89067626] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"120.306289ms","start":"2026-06-28T10:58:50.431799Z","end":"2026-06-28T10:58:50.552105Z","steps":["trace[89067626] 'process raft request' (duration: 113.979677ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T10:58:57.029341Z","caller":"traceutil/trace.go:171","msg":"trace[1250176411] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"181.808181ms","start":"2026-06-28T10:58:56.847429Z","end":"2026-06-28T10:58:57.029238Z","steps":["trace[1250176411] 'read index received' (duration: 179.69516ms)","trace[1250176411] 'applied index is now lower than readState.Index' (duration: 2.110351ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T10:58:57.030097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.651891ms","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-06-28T10:58:57.0302Z","caller":"traceutil/trace.go:171","msg":"trace[1970452808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"182.803285ms","start":"2026-06-28T10:58:56.847367Z","end":"2026-06-28T10:58:57.030171Z","steps":["trace[1970452808] 'agreement among raft nodes before linearized reading' (duration: 182.547019ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T10:58:57.030375Z","caller":"traceutil/trace.go:171","msg":"trace[453101709] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"208.193377ms","start":"2026-06-28T10:58:56.822092Z","end":"2026-06-28T10:58:57.030286Z","steps":["trace[453101709] 'process raft request' (duration: 205.365069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T10:58:57.032619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.881407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-shskn\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-28T10:58:57.033511Z","caller":"traceutil/trace.go:171","msg":"trace[1510431230] range","detail":"{range_begin:/registry/pods/kube-system/cilium-shskn; range_end:; response_count:1; response_revision:592; }","duration":"122.223205ms","start":"2026-06-28T10:58:56.910638Z","end":"2026-06-28T10:58:57.032861Z","steps":["trace[1510431230] 'agreement among raft nodes before linearized reading' (duration: 120.412072ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T10:58:57.288069Z","caller":"traceutil/trace.go:171","msg":"trace[1153789053] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:614; }","duration":"183.969923ms","start":"2026-06-28T10:58:57.104058Z","end":"2026-06-28T10:58:57.288028Z","steps":["trace[1153789053] 'read index received' (duration: 2.956741ms)","trace[1153789053] 'applied index is now lower than readState.Index' (duration: 181.011552ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T10:58:57.288213Z","caller":"traceutil/trace.go:171","msg":"trace[1941293776] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"195.254385ms","start":"2026-06-28T10:58:57.092904Z","end":"2026-06-28T10:58:57.288158Z","steps":["trace[1941293776] 'process raft request' (duration: 170.15832ms)","trace[1941293776] 'compare' (duration: 24.123422ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T10:58:57.288957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.258119ms","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-06-28T10:58:57.289026Z","caller":"traceutil/trace.go:171","msg":"trace[1919301194] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"185.013858ms","start":"2026-06-28T10:58:57.103994Z","end":"2026-06-28T10:58:57.289008Z","steps":["trace[1919301194] 'agreement among raft nodes before linearized reading' (duration: 184.145277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T10:58:57.739115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.962867ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T10:58:57.739306Z","caller":"traceutil/trace.go:171","msg":"trace[536096038] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"440.841703ms","start":"2026-06-28T10:58:57.298448Z","end":"2026-06-28T10:58:57.739289Z","steps":["trace[536096038] 'read index received' (duration: 231.685023ms)","trace[536096038] 'applied index is now lower than readState.Index' (duration: 209.1549ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T10:58:57.73941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.955665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T10:58:57.73956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.761027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T10:58:57.739613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.461201ms","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-06-28T10:58:57.739722Z","caller":"traceutil/trace.go:171","msg":"trace[1274905680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:596; }","duration":"127.581415ms","start":"2026-06-28T10:58:57.612093Z","end":"2026-06-28T10:58:57.739675Z","steps":["trace[1274905680] 'agreement among raft nodes before linearized reading' (duration: 127.346748ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T10:58:57.739848Z","caller":"traceutil/trace.go:171","msg":"trace[1073090532] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:596; }","duration":"441.046038ms","start":"2026-06-28T10:58:57.298411Z","end":"2026-06-28T10:58:57.739457Z","steps":["trace[1073090532] 'agreement among raft nodes before linearized reading' (duration: 440.945695ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T10:58:57.739929Z","caller":"traceutil/trace.go:171","msg":"trace[483390995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"356.964542ms","start":"2026-06-28T10:58:57.382692Z","end":"2026-06-28T10:58:57.739657Z","steps":["trace[483390995] 'agreement among raft nodes before linearized reading' (duration: 356.730646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T10:58:57.739914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T10:58:57.298399Z","time spent":"441.500789ms","remote":"127.0.0.1:39882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-28T10:58:57.739997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T10:58:57.382665Z","time spent":"357.318921ms","remote":"127.0.0.1:39632","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-06-28T10:58:57.739742Z","caller":"traceutil/trace.go:171","msg":"trace[592727618] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"445.810372ms","start":"2026-06-28T10:58:57.293539Z","end":"2026-06-28T10:58:57.73935Z","steps":["trace[592727618] 'process raft request' (duration: 238.004285ms)","trace[592727618] 'compare' (duration: 205.837601ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T10:58:57.740516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T10:58:57.293475Z","time spent":"446.949381ms","remote":"127.0.0.1:39910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T10:59:12.001473Z","caller":"traceutil/trace.go:171","msg":"trace[452443747] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"129.42545ms","start":"2026-06-28T10:59:11.872024Z","end":"2026-06-28T10:59:12.001449Z","steps":["trace[452443747] 'process raft request' (duration: 118.307272ms)","trace[452443747] 'compare' (duration: 10.991634ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T10:59:43.468226Z","caller":"traceutil/trace.go:171","msg":"trace[161737115] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"245.991778ms","start":"2026-06-28T10:59:43.222209Z","end":"2026-06-28T10:59:43.4682Z","steps":["trace[161737115] 'process raft request' (duration: 221.61196ms)","trace[161737115] 'compare' (duration: 24.166913ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T10:59:43.468443Z","caller":"traceutil/trace.go:171","msg":"trace[179325405] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"200.46133ms","start":"2026-06-28T10:59:43.267965Z","end":"2026-06-28T10:59:43.468427Z","steps":["trace[179325405] 'process raft request' (duration: 200.194384ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T10:59:43.468397Z","caller":"traceutil/trace.go:171","msg":"trace[732448887] linearizableReadLoop","detail":"{readStateIndex:1191; appliedIndex:1189; }","duration":"119.384106ms","start":"2026-06-28T10:59:43.348959Z","end":"2026-06-28T10:59:43.468343Z","steps":["trace[732448887] 'read index received' (duration: 94.884046ms)","trace[732448887] 'applied index is now lower than readState.Index' (duration: 24.49685ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T10:59:43.468757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.765475ms","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-06-28T10:59:43.468819Z","caller":"traceutil/trace.go:171","msg":"trace[1654369398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1158; }","duration":"119.889818ms","start":"2026-06-28T10:59:43.348914Z","end":"2026-06-28T10:59:43.468803Z","steps":["trace[1654369398] 'agreement among raft nodes before linearized reading' (duration: 119.591521ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:00:00.326304Z","caller":"traceutil/trace.go:171","msg":"trace[972494005] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"191.954145ms","start":"2026-06-28T11:00:00.134292Z","end":"2026-06-28T11:00:00.326246Z","steps":["trace[972494005] 'process raft request' (duration: 187.145449ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:00:31.999124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.62337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T11:00:31.999403Z","caller":"traceutil/trace.go:171","msg":"trace[2085984490] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"245.785266ms","start":"2026-06-28T11:00:31.753602Z","end":"2026-06-28T11:00:31.999388Z","steps":["trace[2085984490] 'process raft request' (duration: 245.656973ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:00:31.999533Z","caller":"traceutil/trace.go:171","msg":"trace[2069656140] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"247.982137ms","start":"2026-06-28T11:00:31.751497Z","end":"2026-06-28T11:00:31.99948Z","steps":["trace[2069656140] 'process raft request' (duration: 127.117559ms)","trace[2069656140] 'compare' (duration: 119.410344ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:00:32.445937Z","caller":"traceutil/trace.go:171","msg":"trace[1647909811] linearizableReadLoop","detail":"{readStateIndex:1915; appliedIndex:1914; }","duration":"127.995711ms","start":"2026-06-28T11:00:32.317917Z","end":"2026-06-28T11:00:32.445912Z","steps":["trace[1647909811] 'read index received' (duration: 127.785945ms)","trace[1647909811] 'applied index is now lower than readState.Index' (duration: 208.646µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:00:32.446032Z","caller":"traceutil/trace.go:171","msg":"trace[225061522] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"147.022357ms","start":"2026-06-28T11:00:32.298944Z","end":"2026-06-28T11:00:32.445966Z","steps":["trace[225061522] 'process raft request' (duration: 146.821212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:00:32.446299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.352049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-28T11:00:32.44643Z","caller":"traceutil/trace.go:171","msg":"trace[2120706297] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1844; }","duration":"128.558204ms","start":"2026-06-28T11:00:32.317841Z","end":"2026-06-28T11:00:32.446399Z","steps":["trace[2120706297] 'agreement among raft nodes before linearized reading' (duration: 128.185715ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:00:32.651321Z","caller":"traceutil/trace.go:171","msg":"trace[583520342] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"118.997355ms","start":"2026-06-28T11:00:32.532285Z","end":"2026-06-28T11:00:32.651282Z","steps":["trace[583520342] 'process raft request' (duration: 118.738919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:00:33.125288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.112396ms","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-06-28T11:00:33.125416Z","caller":"traceutil/trace.go:171","msg":"trace[320232427] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"261.660096ms","start":"2026-06-28T11:00:32.863721Z","end":"2026-06-28T11:00:33.125381Z","steps":["trace[320232427] 'process raft request' (duration: 248.682824ms)","trace[320232427] 'compare' (duration: 12.725766ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:00:33.12542Z","caller":"traceutil/trace.go:171","msg":"trace[1131273880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1848; }","duration":"362.325071ms","start":"2026-06-28T11:00:32.763076Z","end":"2026-06-28T11:00:33.125401Z","steps":["trace[1131273880] 'range keys from in-memory index tree' (duration: 361.594093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:00:33.125479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:00:32.763042Z","time spent":"362.421554ms","remote":"127.0.0.1:39910","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-06-28T11:00:45.884926Z","caller":"traceutil/trace.go:171","msg":"trace[1768227420] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"143.147234ms","start":"2026-06-28T11:00:45.741742Z","end":"2026-06-28T11:00:45.884889Z","steps":["trace[1768227420] 'process raft request' (duration: 142.58559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:00:46.127363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.613063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.81\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-28T11:00:46.127482Z","caller":"traceutil/trace.go:171","msg":"trace[1925736292] range","detail":"{range_begin:/registry/masterleases/199.19.213.81; range_end:; response_count:1; response_revision:1950; }","duration":"100.794028ms","start":"2026-06-28T11:00:46.026662Z","end":"2026-06-28T11:00:46.127456Z","steps":["trace[1925736292] 'range keys from in-memory index tree' (duration: 100.413679ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:01:11.391099Z","caller":"traceutil/trace.go:171","msg":"trace[368081825] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"121.816909ms","start":"2026-06-28T11:01:11.269254Z","end":"2026-06-28T11:01:11.391071Z","steps":["trace[368081825] 'process raft request' (duration: 108.211501ms)","trace[368081825] 'compare' (duration: 13.480815ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:01:23.097985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.998483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-28T11:01:23.098022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.133358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-28T11:01:23.098075Z","caller":"traceutil/trace.go:171","msg":"trace[703571850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2166; }","duration":"185.134777ms","start":"2026-06-28T11:01:22.912921Z","end":"2026-06-28T11:01:23.098056Z","steps":["trace[703571850] 'range keys from in-memory index tree' (duration: 184.82225ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:01:23.098133Z","caller":"traceutil/trace.go:171","msg":"trace[51047757] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2166; }","duration":"212.306342ms","start":"2026-06-28T11:01:22.885798Z","end":"2026-06-28T11:01:23.098104Z","steps":["trace[51047757] 'range keys from in-memory index tree' (duration: 211.908413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:01:23.098589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.493889ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T11:01:23.098815Z","caller":"traceutil/trace.go:171","msg":"trace[721239052] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2248; }","duration":"160.514622ms","start":"2026-06-28T11:01:22.938272Z","end":"2026-06-28T11:01:23.098787Z","steps":["trace[721239052] 'read index received' (duration: 2.585072ms)","trace[721239052] 'applied index is now lower than readState.Index' (duration: 157.92685ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:01:23.098865Z","caller":"traceutil/trace.go:171","msg":"trace[656805190] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"175.33221ms","start":"2026-06-28T11:01:22.923498Z","end":"2026-06-28T11:01:23.09883Z","steps":["trace[656805190] 'process raft request' (duration: 17.462132ms)","trace[656805190] 'compare' (duration: 156.800713ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:01:23.099184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.960257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T11:01:23.099245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.931272ms","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-06-28T11:01:23.099301Z","caller":"traceutil/trace.go:171","msg":"trace[1099050052] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2167; }","duration":"128.229084ms","start":"2026-06-28T11:01:22.971047Z","end":"2026-06-28T11:01:23.099277Z","steps":["trace[1099050052] 'agreement among raft nodes before linearized reading' (duration: 127.917476ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:01:23.099407Z","caller":"traceutil/trace.go:171","msg":"trace[1848259156] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2167; }","duration":"161.146927ms","start":"2026-06-28T11:01:22.938233Z","end":"2026-06-28T11:01:23.09938Z","steps":["trace[1848259156] 'agreement among raft nodes before linearized reading' (duration: 160.633205ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:01:23.661301Z","caller":"traceutil/trace.go:171","msg":"trace[503062115] linearizableReadLoop","detail":"{readStateIndex:2252; appliedIndex:2251; }","duration":"151.080335ms","start":"2026-06-28T11:01:23.510184Z","end":"2026-06-28T11:01:23.661264Z","steps":["trace[503062115] 'read index received' (duration: 150.767718ms)","trace[503062115] 'applied index is now lower than readState.Index' (duration: 310.697µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:01:23.661363Z","caller":"traceutil/trace.go:171","msg":"trace[29859347] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"201.075742ms","start":"2026-06-28T11:01:23.46025Z","end":"2026-06-28T11:01:23.661326Z","steps":["trace[29859347] 'process raft request' (duration: 200.785025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:01:23.661625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.404174ms","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-06-28T11:01:23.661684Z","caller":"traceutil/trace.go:171","msg":"trace[147720657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2170; }","duration":"151.547457ms","start":"2026-06-28T11:01:23.51012Z","end":"2026-06-28T11:01:23.661668Z","steps":["trace[147720657] 'agreement among raft nodes before linearized reading' (duration: 151.298871ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:01:23.827212Z","caller":"traceutil/trace.go:171","msg":"trace[757173659] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"160.709157ms","start":"2026-06-28T11:01:23.666447Z","end":"2026-06-28T11:01:23.827156Z","steps":["trace[757173659] 'process raft request' (duration: 139.737071ms)","trace[757173659] 'compare' (duration: 20.611148ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:05:47.017971Z","caller":"traceutil/trace.go:171","msg":"trace[668641196] transaction","detail":"{read_only:false; response_revision:3961; number_of_response:1; }","duration":"149.17112ms","start":"2026-06-28T11:05:46.86875Z","end":"2026-06-28T11:05:47.017922Z","steps":["trace[668641196] 'process raft request' (duration: 61.134435ms)","trace[668641196] 'compare' (duration: 87.668866ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:05:47.018031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.582808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-28T11:05:47.018086Z","caller":"traceutil/trace.go:171","msg":"trace[2036067428] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3960; }","duration":"229.728632ms","start":"2026-06-28T11:05:46.788343Z","end":"2026-06-28T11:05:47.018072Z","steps":["trace[2036067428] 'range keys from in-memory index tree' (duration: 229.210158ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:07:13.093224Z","caller":"traceutil/trace.go:171","msg":"trace[1675134516] linearizableReadLoop","detail":"{readStateIndex:5224; appliedIndex:5223; }","duration":"129.833634ms","start":"2026-06-28T11:07:12.963362Z","end":"2026-06-28T11:07:13.093196Z","steps":["trace[1675134516] 'read index received' (duration: 46.834585ms)","trace[1675134516] 'applied index is now lower than readState.Index' (duration: 82.997739ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:07:13.093313Z","caller":"traceutil/trace.go:171","msg":"trace[331264257] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"133.192246ms","start":"2026-06-28T11:07:12.960087Z","end":"2026-06-28T11:07:13.093279Z","steps":["trace[331264257] 'process raft request' (duration: 50.098075ms)","trace[331264257] 'compare' (duration: 82.779743ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:07:13.093573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.160933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-06-28T11:07:13.093729Z","caller":"traceutil/trace.go:171","msg":"trace[1869077200] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5029; }","duration":"130.379168ms","start":"2026-06-28T11:07:12.963319Z","end":"2026-06-28T11:07:13.093699Z","steps":["trace[1869077200] 'agreement among raft nodes before linearized reading' (duration: 130.014119ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:07:16.615408Z","caller":"traceutil/trace.go:171","msg":"trace[807633874] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"257.239ms","start":"2026-06-28T11:07:16.35814Z","end":"2026-06-28T11:07:16.615379Z","steps":["trace[807633874] 'process raft request' (duration: 257.058176ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:07:16.650879Z","caller":"traceutil/trace.go:171","msg":"trace[243453373] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"292.669786ms","start":"2026-06-28T11:07:16.358184Z","end":"2026-06-28T11:07:16.650854Z","steps":["trace[243453373] 'process raft request' (duration: 292.501632ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:07:16.650975Z","caller":"traceutil/trace.go:171","msg":"trace[1394875813] linearizableReadLoop","detail":"{readStateIndex:5378; appliedIndex:5376; }","duration":"266.493747ms","start":"2026-06-28T11:07:16.38446Z","end":"2026-06-28T11:07:16.650954Z","steps":["trace[1394875813] 'read index received' (duration: 230.781614ms)","trace[1394875813] 'applied index is now lower than readState.Index' (duration: 35.710603ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:07:16.651013Z","caller":"traceutil/trace.go:171","msg":"trace[1093656515] transaction","detail":"{read_only:false; response_revision:5179; number_of_response:1; }","duration":"149.050465ms","start":"2026-06-28T11:07:16.501943Z","end":"2026-06-28T11:07:16.650993Z","steps":["trace[1093656515] 'process raft request' (duration: 148.853479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:16.651105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.63117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T11:07:16.651173Z","caller":"traceutil/trace.go:171","msg":"trace[2047139946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5179; }","duration":"266.735383ms","start":"2026-06-28T11:07:16.384425Z","end":"2026-06-28T11:07:16.65116Z","steps":["trace[2047139946] 'agreement among raft nodes before linearized reading' (duration: 266.62251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:16.651244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.213635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-w9qwq-tls\" ","response":"range_response_count:1 size:2183"} {"level":"info","ts":"2026-06-28T11:07:16.651287Z","caller":"traceutil/trace.go:171","msg":"trace[851274829] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-w9qwq-tls; range_end:; response_count:1; response_revision:5179; }","duration":"121.294887ms","start":"2026-06-28T11:07:16.529978Z","end":"2026-06-28T11:07:16.651273Z","steps":["trace[851274829] 'agreement among raft nodes before linearized reading' (duration: 121.156704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:16.65158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.391548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787065"} {"level":"info","ts":"2026-06-28T11:07:16.651632Z","caller":"traceutil/trace.go:171","msg":"trace[101001935] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5179; }","duration":"249.47115ms","start":"2026-06-28T11:07:16.402147Z","end":"2026-06-28T11:07:16.651618Z","steps":["trace[101001935] 'agreement among raft nodes before linearized reading' (duration: 248.915467ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:07:30.21781Z","caller":"traceutil/trace.go:171","msg":"trace[1984951206] transaction","detail":"{read_only:false; response_revision:5420; number_of_response:1; }","duration":"353.811473ms","start":"2026-06-28T11:07:29.863954Z","end":"2026-06-28T11:07:30.217765Z","steps":["trace[1984951206] 'process raft request' (duration: 353.385942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:30.218021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:07:29.863928Z","time spent":"353.985997ms","remote":"127.0.0.1:39818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T11:07:30.21804Z","caller":"traceutil/trace.go:171","msg":"trace[1372084156] linearizableReadLoop","detail":"{readStateIndex:5628; appliedIndex:5626; }","duration":"250.222895ms","start":"2026-06-28T11:07:29.96777Z","end":"2026-06-28T11:07:30.217993Z","steps":["trace[1372084156] 'read index received' (duration: 249.458265ms)","trace[1372084156] 'applied index is now lower than readState.Index' (duration: 762.9µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:07:30.218075Z","caller":"traceutil/trace.go:171","msg":"trace[153768293] transaction","detail":"{read_only:false; response_revision:5421; number_of_response:1; }","duration":"351.145486ms","start":"2026-06-28T11:07:29.866866Z","end":"2026-06-28T11:07:30.218012Z","steps":["trace[153768293] 'process raft request' (duration: 350.758405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:30.21834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:07:29.866819Z","time spent":"351.372881ms","remote":"127.0.0.1:39710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":131078,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T11:07:30.218367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.575924ms","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-06-28T11:07:30.218435Z","caller":"traceutil/trace.go:171","msg":"trace[114855138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5421; }","duration":"250.696997ms","start":"2026-06-28T11:07:29.967721Z","end":"2026-06-28T11:07:30.218418Z","steps":["trace[114855138] 'agreement among raft nodes before linearized reading' (duration: 250.41254ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:07:30.551607Z","caller":"traceutil/trace.go:171","msg":"trace[610739890] linearizableReadLoop","detail":"{readStateIndex:5633; appliedIndex:5632; }","duration":"176.196779ms","start":"2026-06-28T11:07:30.375376Z","end":"2026-06-28T11:07:30.551572Z","steps":["trace[610739890] 'read index received' (duration: 175.910591ms)","trace[610739890] 'applied index is now lower than readState.Index' (duration: 284.798µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:07:30.5517Z","caller":"traceutil/trace.go:171","msg":"trace[127002057] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"226.575552ms","start":"2026-06-28T11:07:30.325077Z","end":"2026-06-28T11:07:30.551653Z","steps":["trace[127002057] 'process raft request' (duration: 226.294725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:30.551826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.61891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T11:07:30.551867Z","caller":"traceutil/trace.go:171","msg":"trace[42886518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5426; }","duration":"167.731703ms","start":"2026-06-28T11:07:30.384122Z","end":"2026-06-28T11:07:30.551854Z","steps":["trace[42886518] 'agreement among raft nodes before linearized reading' (duration: 167.636731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:30.551939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.477566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T11:07:30.552087Z","caller":"traceutil/trace.go:171","msg":"trace[1705672481] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:5426; }","duration":"176.673581ms","start":"2026-06-28T11:07:30.375367Z","end":"2026-06-28T11:07:30.55204Z","steps":["trace[1705672481] 'agreement among raft nodes before linearized reading' (duration: 176.386623ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:07:30.860945Z","caller":"traceutil/trace.go:171","msg":"trace[1036190447] linearizableReadLoop","detail":"{readStateIndex:5634; appliedIndex:5633; }","duration":"140.703334ms","start":"2026-06-28T11:07:30.720213Z","end":"2026-06-28T11:07:30.860916Z","steps":["trace[1036190447] 'read index received' (duration: 116.878048ms)","trace[1036190447] 'applied index is now lower than readState.Index' (duration: 23.824026ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:07:30.860969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.619278ms","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-06-28T11:07:30.860989Z","caller":"traceutil/trace.go:171","msg":"trace[1203924076] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"160.984331ms","start":"2026-06-28T11:07:30.699959Z","end":"2026-06-28T11:07:30.860943Z","steps":["trace[1203924076] 'process raft request' (duration: 137.165875ms)","trace[1203924076] 'compare' (duration: 23.463307ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:07:30.861048Z","caller":"traceutil/trace.go:171","msg":"trace[1634452939] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5426; }","duration":"163.774412ms","start":"2026-06-28T11:07:30.697261Z","end":"2026-06-28T11:07:30.861035Z","steps":["trace[1634452939] 'range keys from in-memory index tree' (duration: 163.410432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:30.861258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.019243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-28T11:07:30.86142Z","caller":"traceutil/trace.go:171","msg":"trace[1575216823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5427; }","duration":"141.188917ms","start":"2026-06-28T11:07:30.720159Z","end":"2026-06-28T11:07:30.861348Z","steps":["trace[1575216823] 'agreement among raft nodes before linearized reading' (duration: 140.843768ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:07:39.475986Z","caller":"traceutil/trace.go:171","msg":"trace[871963638] linearizableReadLoop","detail":"{readStateIndex:5827; appliedIndex:5826; }","duration":"116.718042ms","start":"2026-06-28T11:07:39.359238Z","end":"2026-06-28T11:07:39.475956Z","steps":["trace[871963638] 'read index received' (duration: 107.473057ms)","trace[871963638] 'applied index is now lower than readState.Index' (duration: 9.243435ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:07:39.47614Z","caller":"traceutil/trace.go:171","msg":"trace[359206195] transaction","detail":"{read_only:false; response_revision:5616; number_of_response:1; }","duration":"131.029707ms","start":"2026-06-28T11:07:39.345081Z","end":"2026-06-28T11:07:39.476111Z","steps":["trace[359206195] 'process raft request' (duration: 121.676079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:39.47629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.032861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-28T11:07:39.47633Z","caller":"traceutil/trace.go:171","msg":"trace[122557335] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5616; }","duration":"117.155263ms","start":"2026-06-28T11:07:39.359163Z","end":"2026-06-28T11:07:39.476319Z","steps":["trace[122557335] 'agreement among raft nodes before linearized reading' (duration: 116.949498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:07:39.476451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.190171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-63825afc-b624-435b-bea6-8af4288dfcf9\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-28T11:07:39.47655Z","caller":"traceutil/trace.go:171","msg":"trace[403134553] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-63825afc-b624-435b-bea6-8af4288dfcf9; range_end:; response_count:1; response_revision:5616; }","duration":"111.357926ms","start":"2026-06-28T11:07:39.365172Z","end":"2026-06-28T11:07:39.47653Z","steps":["trace[403134553] 'agreement among raft nodes before linearized reading' (duration: 111.037488ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:07:39.642189Z","caller":"traceutil/trace.go:171","msg":"trace[1962876893] transaction","detail":"{read_only:false; response_revision:5617; number_of_response:1; }","duration":"112.062095ms","start":"2026-06-28T11:07:39.530081Z","end":"2026-06-28T11:07:39.642143Z","steps":["trace[1962876893] 'process raft request' (duration: 47.258023ms)","trace[1962876893] 'compare' (duration: 64.510564ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:08:12.948778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2953} {"level":"info","ts":"2026-06-28T11:08:13.034587Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2953,"took":"83.941258ms","hash":684069669,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":32694272,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-28T11:08:13.034675Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":684069669,"revision":2953,"compact-revision":-1} {"level":"info","ts":"2026-06-28T11:08:31.717047Z","caller":"traceutil/trace.go:171","msg":"trace[53195130] transaction","detail":"{read_only:false; response_revision:6091; number_of_response:1; }","duration":"141.089595ms","start":"2026-06-28T11:08:31.575907Z","end":"2026-06-28T11:08:31.716997Z","steps":["trace[53195130] 'process raft request' (duration: 45.548451ms)","trace[53195130] 'compare' (duration: 95.337219ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:08:31.722211Z","caller":"traceutil/trace.go:171","msg":"trace[1557049310] transaction","detail":"{read_only:false; response_revision:6093; number_of_response:1; }","duration":"118.607931ms","start":"2026-06-28T11:08:31.60357Z","end":"2026-06-28T11:08:31.722178Z","steps":["trace[1557049310] 'process raft request' (duration: 118.490398ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:08:31.722213Z","caller":"traceutil/trace.go:171","msg":"trace[1225420283] transaction","detail":"{read_only:false; response_revision:6092; number_of_response:1; }","duration":"118.778485ms","start":"2026-06-28T11:08:31.603382Z","end":"2026-06-28T11:08:31.72216Z","steps":["trace[1225420283] 'process raft request' (duration: 118.464508ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:08:31.722654Z","caller":"traceutil/trace.go:171","msg":"trace[199616347] transaction","detail":"{read_only:false; response_revision:6094; number_of_response:1; }","duration":"118.047748ms","start":"2026-06-28T11:08:31.604556Z","end":"2026-06-28T11:08:31.722604Z","steps":["trace[199616347] 'process raft request' (duration: 117.553555ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:08:31.722966Z","caller":"traceutil/trace.go:171","msg":"trace[2114813620] transaction","detail":"{read_only:false; response_revision:6098; number_of_response:1; }","duration":"115.235185ms","start":"2026-06-28T11:08:31.60772Z","end":"2026-06-28T11:08:31.722955Z","steps":["trace[2114813620] 'process raft request' (duration: 114.972469ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:08:31.72296Z","caller":"traceutil/trace.go:171","msg":"trace[1401583130] transaction","detail":"{read_only:false; response_revision:6095; number_of_response:1; }","duration":"118.1468ms","start":"2026-06-28T11:08:31.604798Z","end":"2026-06-28T11:08:31.722945Z","steps":["trace[1401583130] 'process raft request' (duration: 117.588326ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:08:31.722932Z","caller":"traceutil/trace.go:171","msg":"trace[1899062282] transaction","detail":"{read_only:false; response_revision:6097; number_of_response:1; }","duration":"117.345109ms","start":"2026-06-28T11:08:31.605536Z","end":"2026-06-28T11:08:31.722881Z","steps":["trace[1899062282] 'process raft request' (duration: 117.062412ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:08:31.723017Z","caller":"traceutil/trace.go:171","msg":"trace[984663901] transaction","detail":"{read_only:false; response_revision:6096; number_of_response:1; }","duration":"118.15214ms","start":"2026-06-28T11:08:31.604842Z","end":"2026-06-28T11:08:31.722994Z","steps":["trace[984663901] 'process raft request' (duration: 117.705939ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:13:12.956126Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5886} {"level":"info","ts":"2026-06-28T11:13:13.05572Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5886,"took":"97.146265ms","hash":1179945579,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":26144768,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-28T11:13:13.055789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1179945579,"revision":5886,"compact-revision":2953} {"level":"warn","ts":"2026-06-28T11:14:01.775493Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8397417862171038350,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T11:14:01.829205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.246861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T11:14:01.829345Z","caller":"traceutil/trace.go:171","msg":"trace[243348876] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:8494; }","duration":"687.454076ms","start":"2026-06-28T11:14:01.141861Z","end":"2026-06-28T11:14:01.829315Z","steps":["trace[243348876] 'count revisions from in-memory index tree' (duration: 687.061396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:01.829411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:14:01.141834Z","time spent":"687.557229ms","remote":"127.0.0.1:39802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":7,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-06-28T11:14:01.934952Z","caller":"traceutil/trace.go:171","msg":"trace[2107986556] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"770.840321ms","start":"2026-06-28T11:14:01.164072Z","end":"2026-06-28T11:14:01.934912Z","steps":["trace[2107986556] 'process raft request' (duration: 770.628195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:01.935163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:14:01.164047Z","time spent":"771.014006ms","remote":"127.0.0.1:39910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T11:14:01.948817Z","caller":"traceutil/trace.go:171","msg":"trace[753005745] linearizableReadLoop","detail":"{readStateIndex:8799; appliedIndex:8797; }","duration":"674.005838ms","start":"2026-06-28T11:14:01.274783Z","end":"2026-06-28T11:14:01.948789Z","steps":["trace[753005745] 'read index received' (duration: 659.842911ms)","trace[753005745] 'applied index is now lower than readState.Index' (duration: 14.161367ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:14:01.949007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.206513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T11:14:01.949073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.827374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-28T11:14:01.949096Z","caller":"traceutil/trace.go:171","msg":"trace[1868336104] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8495; }","duration":"596.904116ms","start":"2026-06-28T11:14:01.352186Z","end":"2026-06-28T11:14:01.94909Z","steps":["trace[1868336104] 'agreement among raft nodes before linearized reading' (duration: 596.746832ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:01.949092Z","caller":"traceutil/trace.go:171","msg":"trace[433519637] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:8495; }","duration":"674.370117ms","start":"2026-06-28T11:14:01.274699Z","end":"2026-06-28T11:14:01.949069Z","steps":["trace[433519637] 'agreement among raft nodes before linearized reading' (duration: 674.199192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:01.949125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:14:01.35217Z","time spent":"596.949617ms","remote":"127.0.0.1:39910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-28T11:14:01.949138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:14:01.274671Z","time spent":"674.456879ms","remote":"127.0.0.1:56694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "} {"level":"warn","ts":"2026-06-28T11:14:01.949436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.725534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-28T11:14:01.949455Z","caller":"traceutil/trace.go:171","msg":"trace[1998857791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8495; }","duration":"399.777706ms","start":"2026-06-28T11:14:01.549673Z","end":"2026-06-28T11:14:01.94945Z","steps":["trace[1998857791] 'agreement among raft nodes before linearized reading' (duration: 399.730795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:01.949468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:14:01.549656Z","time spent":"399.809397ms","remote":"127.0.0.1:39910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-28T11:14:01.949573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.085011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-blgjf\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-06-28T11:14:01.949595Z","caller":"traceutil/trace.go:171","msg":"trace[27622627] range","detail":"{range_begin:/registry/pods/openstack/keepalived-blgjf; range_end:; response_count:1; response_revision:8495; }","duration":"570.173044ms","start":"2026-06-28T11:14:01.379415Z","end":"2026-06-28T11:14:01.949588Z","steps":["trace[27622627] 'agreement among raft nodes before linearized reading' (duration: 570.052591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:01.949614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:14:01.379388Z","time spent":"570.221876ms","remote":"127.0.0.1:39836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6550,"request content":"key:\"/registry/pods/openstack/keepalived-blgjf\" "} {"level":"warn","ts":"2026-06-28T11:14:01.949727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.237183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T11:14:01.94975Z","caller":"traceutil/trace.go:171","msg":"trace[1947865920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8495; }","duration":"565.278625ms","start":"2026-06-28T11:14:01.384462Z","end":"2026-06-28T11:14:01.949741Z","steps":["trace[1947865920] 'agreement among raft nodes before linearized reading' (duration: 565.243324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:01.949766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:14:01.384451Z","time spent":"565.310945ms","remote":"127.0.0.1:39632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-28T11:14:01.94982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.223774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-cd9756498-727hg.18bd3a64a88bae53\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-06-28T11:14:01.949851Z","caller":"traceutil/trace.go:171","msg":"trace[1840347272] range","detail":"{range_begin:/registry/events/openstack/barbican-api-cd9756498-727hg.18bd3a64a88bae53; range_end:; response_count:1; response_revision:8495; }","duration":"445.312007ms","start":"2026-06-28T11:14:01.504527Z","end":"2026-06-28T11:14:01.949839Z","steps":["trace[1840347272] 'agreement among raft nodes before linearized reading' (duration: 445.196134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:01.949869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T11:14:01.504501Z","time spent":"445.364608ms","remote":"127.0.0.1:39728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1154,"request content":"key:\"/registry/events/openstack/barbican-api-cd9756498-727hg.18bd3a64a88bae53\" "} {"level":"info","ts":"2026-06-28T11:14:12.138633Z","caller":"traceutil/trace.go:171","msg":"trace[1235121531] linearizableReadLoop","detail":"{readStateIndex:8857; appliedIndex:8855; }","duration":"111.142173ms","start":"2026-06-28T11:14:12.027417Z","end":"2026-06-28T11:14:12.138559Z","steps":["trace[1235121531] 'read index received' (duration: 293.327µs)","trace[1235121531] 'applied index is now lower than readState.Index' (duration: 110.847366ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:14:12.138667Z","caller":"traceutil/trace.go:171","msg":"trace[237190820] transaction","detail":"{read_only:false; response_revision:8551; number_of_response:1; }","duration":"117.433236ms","start":"2026-06-28T11:14:12.02119Z","end":"2026-06-28T11:14:12.138623Z","steps":["trace[237190820] 'process raft request' (duration: 109.483902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:12.138882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.43307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-blgjf\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-06-28T11:14:12.138932Z","caller":"traceutil/trace.go:171","msg":"trace[807291021] range","detail":"{range_begin:/registry/pods/openstack/keepalived-blgjf; range_end:; response_count:1; response_revision:8551; }","duration":"111.539422ms","start":"2026-06-28T11:14:12.027378Z","end":"2026-06-28T11:14:12.138917Z","steps":["trace[807291021] 'agreement among raft nodes before linearized reading' (duration: 111.335837ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:12.669921Z","caller":"traceutil/trace.go:171","msg":"trace[1135842185] linearizableReadLoop","detail":"{readStateIndex:8861; appliedIndex:8859; }","duration":"140.395337ms","start":"2026-06-28T11:14:12.529493Z","end":"2026-06-28T11:14:12.669889Z","steps":["trace[1135842185] 'read index received' (duration: 29.266195ms)","trace[1135842185] 'applied index is now lower than readState.Index' (duration: 111.116792ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:14:12.670088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.558401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T11:14:12.670128Z","caller":"traceutil/trace.go:171","msg":"trace[1701305464] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8555; }","duration":"140.678753ms","start":"2026-06-28T11:14:12.529435Z","end":"2026-06-28T11:14:12.670114Z","steps":["trace[1701305464] 'agreement among raft nodes before linearized reading' (duration: 140.56321ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:12.670306Z","caller":"traceutil/trace.go:171","msg":"trace[1730510856] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"196.863575ms","start":"2026-06-28T11:14:12.473388Z","end":"2026-06-28T11:14:12.670252Z","steps":["trace[1730510856] 'process raft request' (duration: 150.525593ms)","trace[1730510856] 'compare' (duration: 45.699685ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:14:13.567072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.79076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T11:14:13.56716Z","caller":"traceutil/trace.go:171","msg":"trace[773741275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8560; }","duration":"182.977614ms","start":"2026-06-28T11:14:13.384162Z","end":"2026-06-28T11:14:13.56714Z","steps":["trace[773741275] 'range keys from in-memory index tree' (duration: 182.651657ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:14.269805Z","caller":"traceutil/trace.go:171","msg":"trace[1803565152] transaction","detail":"{read_only:false; response_revision:8563; number_of_response:1; }","duration":"121.837273ms","start":"2026-06-28T11:14:14.147932Z","end":"2026-06-28T11:14:14.269769Z","steps":["trace[1803565152] 'process raft request' (duration: 121.477045ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:14.269949Z","caller":"traceutil/trace.go:171","msg":"trace[1531619049] linearizableReadLoop","detail":"{readStateIndex:8869; appliedIndex:8868; }","duration":"118.776129ms","start":"2026-06-28T11:14:14.150921Z","end":"2026-06-28T11:14:14.269697Z","steps":["trace[1531619049] 'read index received' (duration: 118.518293ms)","trace[1531619049] 'applied index is now lower than readState.Index' (duration: 256.146µs)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:14:14.270094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.152239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-blgjf\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-06-28T11:14:14.270139Z","caller":"traceutil/trace.go:171","msg":"trace[1416432268] range","detail":"{range_begin:/registry/pods/openstack/keepalived-blgjf; range_end:; response_count:1; response_revision:8563; }","duration":"119.274631ms","start":"2026-06-28T11:14:14.150854Z","end":"2026-06-28T11:14:14.270129Z","steps":["trace[1416432268] 'agreement among raft nodes before linearized reading' (duration: 119.050216ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:14.442963Z","caller":"traceutil/trace.go:171","msg":"trace[137684709] linearizableReadLoop","detail":"{readStateIndex:8870; appliedIndex:8869; }","duration":"172.892859ms","start":"2026-06-28T11:14:14.270036Z","end":"2026-06-28T11:14:14.442928Z","steps":["trace[137684709] 'read index received' (duration: 172.605521ms)","trace[137684709] 'applied index is now lower than readState.Index' (duration: 286.278µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:14:14.443156Z","caller":"traceutil/trace.go:171","msg":"trace[1373185390] transaction","detail":"{read_only:false; response_revision:8564; number_of_response:1; }","duration":"227.03661ms","start":"2026-06-28T11:14:14.216053Z","end":"2026-06-28T11:14:14.443089Z","steps":["trace[1373185390] 'process raft request' (duration: 226.68265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:14.443708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.706457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224101"} {"level":"info","ts":"2026-06-28T11:14:14.44403Z","caller":"traceutil/trace.go:171","msg":"trace[706200287] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8564; }","duration":"169.118226ms","start":"2026-06-28T11:14:14.274895Z","end":"2026-06-28T11:14:14.444013Z","steps":["trace[706200287] 'agreement among raft nodes before linearized reading' (duration: 168.292386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:14.44501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.850031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414394"} {"level":"info","ts":"2026-06-28T11:14:14.445144Z","caller":"traceutil/trace.go:171","msg":"trace[425466190] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:8564; }","duration":"226.050836ms","start":"2026-06-28T11:14:14.219065Z","end":"2026-06-28T11:14:14.445116Z","steps":["trace[425466190] 'agreement among raft nodes before linearized reading' (duration: 224.17056ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:14.792968Z","caller":"traceutil/trace.go:171","msg":"trace[257013054] transaction","detail":"{read_only:false; response_revision:8566; number_of_response:1; }","duration":"113.96276ms","start":"2026-06-28T11:14:14.678969Z","end":"2026-06-28T11:14:14.792931Z","steps":["trace[257013054] 'process raft request' (duration: 74.271442ms)","trace[257013054] 'compare' (duration: 39.544425ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:14:15.27244Z","caller":"traceutil/trace.go:171","msg":"trace[2144363030] linearizableReadLoop","detail":"{readStateIndex:8875; appliedIndex:8874; }","duration":"104.444599ms","start":"2026-06-28T11:14:15.167964Z","end":"2026-06-28T11:14:15.272408Z","steps":["trace[2144363030] 'read index received' (duration: 104.166223ms)","trace[2144363030] 'applied index is now lower than readState.Index' (duration: 277.126µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:14:15.2725Z","caller":"traceutil/trace.go:171","msg":"trace[1691364933] transaction","detail":"{read_only:false; response_revision:8569; number_of_response:1; }","duration":"129.228873ms","start":"2026-06-28T11:14:15.143244Z","end":"2026-06-28T11:14:15.272473Z","steps":["trace[1691364933] 'process raft request' (duration: 128.973887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:14:15.272675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.657064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-28T11:14:15.272724Z","caller":"traceutil/trace.go:171","msg":"trace[2095443413] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8569; }","duration":"104.775248ms","start":"2026-06-28T11:14:15.167936Z","end":"2026-06-28T11:14:15.272711Z","steps":["trace[2095443413] 'agreement among raft nodes before linearized reading' (duration: 104.582093ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:19.70189Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022ca.wal"} {"level":"info","ts":"2026-06-28T11:14:42.250325Z","caller":"traceutil/trace.go:171","msg":"trace[2064805367] transaction","detail":"{read_only:false; response_revision:8764; number_of_response:1; }","duration":"122.897179ms","start":"2026-06-28T11:14:42.127396Z","end":"2026-06-28T11:14:42.250293Z","steps":["trace[2064805367] 'process raft request' (duration: 122.684534ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:42.4679Z","caller":"traceutil/trace.go:171","msg":"trace[1350206427] transaction","detail":"{read_only:false; response_revision:8766; number_of_response:1; }","duration":"213.391068ms","start":"2026-06-28T11:14:42.254481Z","end":"2026-06-28T11:14:42.467872Z","steps":["trace[1350206427] 'process raft request' (duration: 213.272744ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:14:42.4679Z","caller":"traceutil/trace.go:171","msg":"trace[106075010] transaction","detail":"{read_only:false; response_revision:8765; number_of_response:1; }","duration":"241.748049ms","start":"2026-06-28T11:14:42.226107Z","end":"2026-06-28T11:14:42.467855Z","steps":["trace[106075010] 'process raft request' (duration: 223.528135ms)","trace[106075010] 'compare' (duration: 17.950898ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:14:46.716726Z","caller":"traceutil/trace.go:171","msg":"trace[1046225476] transaction","detail":"{read_only:false; response_revision:8789; number_of_response:1; }","duration":"136.235904ms","start":"2026-06-28T11:14:46.580428Z","end":"2026-06-28T11:14:46.716664Z","steps":["trace[1046225476] 'process raft request' (duration: 74.772134ms)","trace[1046225476] 'compare' (duration: 61.098561ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T11:14:55.644038Z","caller":"traceutil/trace.go:171","msg":"trace[858686298] transaction","detail":"{read_only:false; response_revision:8880; number_of_response:1; }","duration":"101.585769ms","start":"2026-06-28T11:14:55.54241Z","end":"2026-06-28T11:14:55.643996Z","steps":["trace[858686298] 'process raft request' (duration: 66.258026ms)","trace[858686298] 'compare' (duration: 35.187299ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T11:16:15.638216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.325049ms","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-06-28T11:16:15.638352Z","caller":"traceutil/trace.go:171","msg":"trace[808490980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9648; }","duration":"183.503464ms","start":"2026-06-28T11:16:15.454819Z","end":"2026-06-28T11:16:15.638322Z","steps":["trace[808490980] 'range keys from in-memory index tree' (duration: 183.065694ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:16:17.372777Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1627b0b72e417489","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-28T11:16:17.378873Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-28T11:16:17.379022Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-28T11:18:12.963641Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8046} {"level":"info","ts":"2026-06-28T11:18:13.026232Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8046,"took":"60.941762ms","hash":4270958310,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":28258304,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-28T11:18:13.026351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4270958310,"revision":8046,"compact-revision":5886} {"level":"info","ts":"2026-06-28T11:21:45.973089Z","caller":"traceutil/trace.go:171","msg":"trace[720416638] transaction","detail":"{read_only:false; response_revision:12035; number_of_response:1; }","duration":"138.326173ms","start":"2026-06-28T11:21:45.834731Z","end":"2026-06-28T11:21:45.973057Z","steps":["trace[720416638] 'process raft request' (duration: 138.043496ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:21:45.983993Z","caller":"traceutil/trace.go:171","msg":"trace[372802824] transaction","detail":"{read_only:false; response_revision:12036; number_of_response:1; }","duration":"111.713107ms","start":"2026-06-28T11:21:45.872256Z","end":"2026-06-28T11:21:45.983969Z","steps":["trace[372802824] 'process raft request' (duration: 111.563213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:21:46.412639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.791275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-backup-64ccbdb59-t7n9n.18bd3acbc965717c\" ","response":"range_response_count:1 size:801"} {"level":"info","ts":"2026-06-28T11:21:46.412738Z","caller":"traceutil/trace.go:171","msg":"trace[1806440219] range","detail":"{range_begin:/registry/events/openstack/cinder-backup-64ccbdb59-t7n9n.18bd3acbc965717c; range_end:; response_count:1; response_revision:12039; }","duration":"226.910488ms","start":"2026-06-28T11:21:46.185807Z","end":"2026-06-28T11:21:46.412717Z","steps":["trace[1806440219] 'range keys from in-memory index tree' (duration: 226.648782ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:21:46.452873Z","caller":"traceutil/trace.go:171","msg":"trace[449786248] transaction","detail":"{read_only:false; response_revision:12040; number_of_response:1; }","duration":"215.550442ms","start":"2026-06-28T11:21:46.237286Z","end":"2026-06-28T11:21:46.452836Z","steps":["trace[449786248] 'process raft request' (duration: 215.259275ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:23:12.970274Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10475} {"level":"info","ts":"2026-06-28T11:23:13.048053Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10475,"took":"76.007868ms","hash":1608925783,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":25919488,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-28T11:23:13.048118Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1608925783,"revision":10475,"compact-revision":8046} {"level":"info","ts":"2026-06-28T11:28:12.977699Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12599} {"level":"info","ts":"2026-06-28T11:28:13.053518Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12599,"took":"74.127663ms","hash":1117082939,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":26902528,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-28T11:28:13.053594Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1117082939,"revision":12599,"compact-revision":10475} {"level":"warn","ts":"2026-06-28T11:28:51.886032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.726865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-nova-server-0.18bd3b35f7f337bf\" ","response":"range_response_count:1 size:1001"} {"level":"info","ts":"2026-06-28T11:28:51.886145Z","caller":"traceutil/trace.go:171","msg":"trace[1886195604] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-nova-server-0.18bd3b35f7f337bf; range_end:; response_count:1; response_revision:15034; }","duration":"177.90519ms","start":"2026-06-28T11:28:51.708215Z","end":"2026-06-28T11:28:51.886121Z","steps":["trace[1886195604] 'range keys from in-memory index tree' (duration: 177.484579ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:30:16.787392Z","caller":"traceutil/trace.go:171","msg":"trace[1653207273] transaction","detail":"{read_only:false; response_revision:15836; number_of_response:1; }","duration":"128.167382ms","start":"2026-06-28T11:30:16.6592Z","end":"2026-06-28T11:30:16.787367Z","steps":["trace[1653207273] 'process raft request' (duration: 127.65854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T11:30:16.787755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.516001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-qfvnm\" ","response":"range_response_count:1 size:9790"} {"level":"info","ts":"2026-06-28T11:30:16.787799Z","caller":"traceutil/trace.go:171","msg":"trace[1322081855] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-qfvnm; range_end:; response_count:1; response_revision:15836; }","duration":"100.636324ms","start":"2026-06-28T11:30:16.687151Z","end":"2026-06-28T11:30:16.787787Z","steps":["trace[1322081855] 'agreement among raft nodes before linearized reading' (duration: 100.485021ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:33:12.983553Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14624} {"level":"info","ts":"2026-06-28T11:33:13.063763Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14624,"took":"76.387954ms","hash":2947416131,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":31985664,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-28T11:33:13.06382Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2947416131,"revision":14624,"compact-revision":12599} {"level":"info","ts":"2026-06-28T11:38:12.991234Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17083} {"level":"info","ts":"2026-06-28T11:38:13.083855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17083,"took":"89.488167ms","hash":2223411707,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":30097408,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-28T11:38:13.083909Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2223411707,"revision":17083,"compact-revision":14624} {"level":"info","ts":"2026-06-28T11:38:46.758591Z","caller":"traceutil/trace.go:171","msg":"trace[1598957070] transaction","detail":"{read_only:false; response_revision:19256; number_of_response:1; }","duration":"203.266421ms","start":"2026-06-28T11:38:46.55529Z","end":"2026-06-28T11:38:46.758556Z","steps":["trace[1598957070] 'process raft request' (duration: 203.059247ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T11:39:00.277421Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1627b0b72e417489","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-28T11:39:00.282984Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-28T11:39:00.28311Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-28T11:43:12.999635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19080} {"level":"info","ts":"2026-06-28T11:43:13.093956Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19080,"took":"90.442409ms","hash":3112039105,"current-db-size-bytes":57896960,"current-db-size":"58 MB","current-db-size-in-use-bytes":24399872,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-28T11:43:13.094043Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3112039105,"revision":19080,"compact-revision":17083}