{"level":"warn","ts":"2026-07-30T21:07:40.137827Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T21:07:40.137935Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.219: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.219:2380","--initial-cluster=instance=https://199.19.213.219:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.219:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.219:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-30T21:07:40.138Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T21:07:40.138007Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.219:2380"]} {"level":"info","ts":"2026-07-30T21:07:40.138038Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-30T21:07:40.138579Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"]} {"level":"info","ts":"2026-07-30T21:07:40.138648Z","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.219:2380"],"listen-peer-urls":["https://199.19.213.219:2380"],"advertise-client-urls":["https://199.19.213.219:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.219:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-30T21:07:40.141303Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.446373ms"} {"level":"info","ts":"2026-07-30T21:07:40.146801Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7e142186203fa167","cluster-id":"e7586aea7e662ee6"} {"level":"info","ts":"2026-07-30T21:07:40.146865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=()"} {"level":"info","ts":"2026-07-30T21:07:40.146885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became follower at term 0"} {"level":"info","ts":"2026-07-30T21:07:40.146904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7e142186203fa167 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-30T21:07:40.14692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became follower at term 1"} {"level":"info","ts":"2026-07-30T21:07:40.146959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=(9084923208263508327)"} {"level":"warn","ts":"2026-07-30T21:07:40.151767Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-30T21:07:40.153967Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-30T21:07:40.156043Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-30T21:07:40.159117Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7e142186203fa167","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-30T21:07:40.159348Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7e142186203fa167","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-30T21:07:40.159401Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-30T21:07:40.159666Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-30T21:07:40.159691Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-30T21:07:40.160485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=(9084923208263508327)"} {"level":"info","ts":"2026-07-30T21:07:40.16061Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7586aea7e662ee6","local-member-id":"7e142186203fa167","added-peer-id":"7e142186203fa167","added-peer-peer-urls":["https://199.19.213.219:2380"]} {"level":"info","ts":"2026-07-30T21:07:40.162632Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-30T21:07:40.162745Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.219:2380"} {"level":"info","ts":"2026-07-30T21:07:40.162785Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.219:2380"} {"level":"info","ts":"2026-07-30T21:07:40.163071Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7e142186203fa167","initial-advertise-peer-urls":["https://199.19.213.219:2380"],"listen-peer-urls":["https://199.19.213.219:2380"],"advertise-client-urls":["https://199.19.213.219:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-30T21:07:40.163117Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-30T21:07:40.24824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 is starting a new election at term 1"} {"level":"info","ts":"2026-07-30T21:07:40.248351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-30T21:07:40.248448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 received MsgPreVoteResp from 7e142186203fa167 at term 1"} {"level":"info","ts":"2026-07-30T21:07:40.248485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became candidate at term 2"} {"level":"info","ts":"2026-07-30T21:07:40.248535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 received MsgVoteResp from 7e142186203fa167 at term 2"} {"level":"info","ts":"2026-07-30T21:07:40.248607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became leader at term 2"} {"level":"info","ts":"2026-07-30T21:07:40.248632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e142186203fa167 elected leader 7e142186203fa167 at term 2"} {"level":"info","ts":"2026-07-30T21:07:40.249762Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T21:07:40.250813Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T21:07:40.250791Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7e142186203fa167","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.219:2379]}","request-path":"/0/members/7e142186203fa167/attributes","cluster-id":"e7586aea7e662ee6","publish-timeout":"7s"} {"level":"info","ts":"2026-07-30T21:07:40.250906Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T21:07:40.25124Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-30T21:07:40.251272Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-30T21:07:40.254849Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7586aea7e662ee6","local-member-id":"7e142186203fa167","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T21:07:40.255308Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T21:07:40.25541Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T21:07:40.255927Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-30T21:07:40.257286Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.219:2379"} {"level":"info","ts":"2026-07-30T21:08:25.906831Z","caller":"traceutil/trace.go:171","msg":"trace[337367747] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"129.294283ms","start":"2026-07-30T21:08:25.777505Z","end":"2026-07-30T21:08:25.9068Z","steps":["trace[337367747] 'process raft request' (duration: 112.817591ms)","trace[337367747] 'compare' (duration: 16.360929ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:08:26.168637Z","caller":"traceutil/trace.go:171","msg":"trace[933289106] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"239.938328ms","start":"2026-07-30T21:08:25.928669Z","end":"2026-07-30T21:08:26.168608Z","steps":["trace[933289106] 'process raft request' (duration: 239.340891ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:08:26.359797Z","caller":"traceutil/trace.go:171","msg":"trace[848760709] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"124.638463ms","start":"2026-07-30T21:08:26.235129Z","end":"2026-07-30T21:08:26.359768Z","steps":["trace[848760709] 'process raft request' (duration: 124.511839ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:08:26.395576Z","caller":"traceutil/trace.go:171","msg":"trace[170902649] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"152.770243ms","start":"2026-07-30T21:08:26.242771Z","end":"2026-07-30T21:08:26.395541Z","steps":["trace[170902649] 'read index received' (duration: 116.976583ms)","trace[170902649] 'applied index is now lower than readState.Index' (duration: 35.79214ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:08:26.39564Z","caller":"traceutil/trace.go:171","msg":"trace[359347193] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"153.709792ms","start":"2026-07-30T21:08:26.241873Z","end":"2026-07-30T21:08:26.395582Z","steps":["trace[359347193] 'process raft request' (duration: 153.462105ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:08:26.396468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.454033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:08:26.397067Z","caller":"traceutil/trace.go:171","msg":"trace[847753650] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"154.149065ms","start":"2026-07-30T21:08:26.242743Z","end":"2026-07-30T21:08:26.396892Z","steps":["trace[847753650] 'agreement among raft nodes before linearized reading' (duration: 153.01348ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:08:26.811646Z","caller":"traceutil/trace.go:171","msg":"trace[1858193115] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"259.486083ms","start":"2026-07-30T21:08:26.552071Z","end":"2026-07-30T21:08:26.811557Z","steps":["trace[1858193115] 'process raft request' (duration: 243.851055ms)","trace[1858193115] 'compare' (duration: 15.462803ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:09:22.426419Z","caller":"traceutil/trace.go:171","msg":"trace[1035053183] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1130; }","duration":"183.575997ms","start":"2026-07-30T21:09:22.242816Z","end":"2026-07-30T21:09:22.426392Z","steps":["trace[1035053183] 'read index received' (duration: 183.384681ms)","trace[1035053183] 'applied index is now lower than readState.Index' (duration: 190.216µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:09:22.42647Z","caller":"traceutil/trace.go:171","msg":"trace[1013324504] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"209.9213ms","start":"2026-07-30T21:09:22.2165Z","end":"2026-07-30T21:09:22.426421Z","steps":["trace[1013324504] 'process raft request' (duration: 209.682262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:09:22.426566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.741832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:09:22.426608Z","caller":"traceutil/trace.go:171","msg":"trace[1007797835] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1092; }","duration":"183.860666ms","start":"2026-07-30T21:09:22.242735Z","end":"2026-07-30T21:09:22.426596Z","steps":["trace[1007797835] 'agreement among raft nodes before linearized reading' (duration: 183.774273ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:09:22.649142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.804444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-30T21:09:22.649297Z","caller":"traceutil/trace.go:171","msg":"trace[2113793144] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1092; }","duration":"113.035641ms","start":"2026-07-30T21:09:22.536235Z","end":"2026-07-30T21:09:22.64927Z","steps":["trace[2113793144] 'range keys from in-memory index tree' (duration: 112.569297ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:09:49.829087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.558883ms","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-07-30T21:09:49.829206Z","caller":"traceutil/trace.go:171","msg":"trace[294122401] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1399; }","duration":"173.692127ms","start":"2026-07-30T21:09:49.655486Z","end":"2026-07-30T21:09:49.829178Z","steps":["trace[294122401] 'range keys from in-memory index tree' (duration: 173.335656ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:09:49.966609Z","caller":"traceutil/trace.go:171","msg":"trace[1211085359] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"130.985446ms","start":"2026-07-30T21:09:49.835582Z","end":"2026-07-30T21:09:49.966567Z","steps":["trace[1211085359] 'process raft request' (duration: 130.754809ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:09:49.979023Z","caller":"traceutil/trace.go:171","msg":"trace[211194014] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"139.199622ms","start":"2026-07-30T21:09:49.839799Z","end":"2026-07-30T21:09:49.978999Z","steps":["trace[211194014] 'process raft request' (duration: 138.772399ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:09:50.668221Z","caller":"traceutil/trace.go:171","msg":"trace[1729341174] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"107.133741ms","start":"2026-07-30T21:09:50.561062Z","end":"2026-07-30T21:09:50.668195Z","steps":["trace[1729341174] 'process raft request' (duration: 106.983347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:09:51.772494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.381456ms","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-07-30T21:09:51.772592Z","caller":"traceutil/trace.go:171","msg":"trace[2061691921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1405; }","duration":"215.507089ms","start":"2026-07-30T21:09:51.55706Z","end":"2026-07-30T21:09:51.772567Z","steps":["trace[2061691921] 'range keys from in-memory index tree' (duration: 214.880622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:09:51.772575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.009678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-30T21:09:51.772695Z","caller":"traceutil/trace.go:171","msg":"trace[997156409] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1405; }","duration":"106.171213ms","start":"2026-07-30T21:09:51.666478Z","end":"2026-07-30T21:09:51.772649Z","steps":["trace[997156409] 'range keys from in-memory index tree' (duration: 105.714249ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:09:51.891396Z","caller":"traceutil/trace.go:171","msg":"trace[1989813419] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"113.807302ms","start":"2026-07-30T21:09:51.777522Z","end":"2026-07-30T21:09:51.891329Z","steps":["trace[1989813419] 'process raft request' (duration: 113.605376ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:09:51.914903Z","caller":"traceutil/trace.go:171","msg":"trace[1024796086] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"136.385418ms","start":"2026-07-30T21:09:51.778491Z","end":"2026-07-30T21:09:51.914876Z","steps":["trace[1024796086] 'process raft request' (duration: 136.216662ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:09:52.591192Z","caller":"traceutil/trace.go:171","msg":"trace[484939520] linearizableReadLoop","detail":"{readStateIndex:1456; appliedIndex:1455; }","duration":"211.542061ms","start":"2026-07-30T21:09:52.37962Z","end":"2026-07-30T21:09:52.591162Z","steps":["trace[484939520] 'read index received' (duration: 211.245902ms)","trace[484939520] 'applied index is now lower than readState.Index' (duration: 294.539µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:09:52.591247Z","caller":"traceutil/trace.go:171","msg":"trace[1046670767] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"261.799798ms","start":"2026-07-30T21:09:52.329395Z","end":"2026-07-30T21:09:52.591195Z","steps":["trace[1046670767] 'process raft request' (duration: 261.499159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:09:52.591373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.710347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:09:52.591448Z","caller":"traceutil/trace.go:171","msg":"trace[1173449027] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1410; }","duration":"211.847041ms","start":"2026-07-30T21:09:52.379582Z","end":"2026-07-30T21:09:52.591429Z","steps":["trace[1173449027] 'agreement among raft nodes before linearized reading' (duration: 211.691136ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:09:52.849636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.16023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-30T21:09:52.849729Z","caller":"traceutil/trace.go:171","msg":"trace[1279185821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1410; }","duration":"176.361677ms","start":"2026-07-30T21:09:52.673346Z","end":"2026-07-30T21:09:52.849707Z","steps":["trace[1279185821] 'range keys from in-memory index tree' (duration: 175.935454ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:10:43.5118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.133164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:10:43.511921Z","caller":"traceutil/trace.go:171","msg":"trace[1295510486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2186; }","duration":"268.311838ms","start":"2026-07-30T21:10:43.243585Z","end":"2026-07-30T21:10:43.511897Z","steps":["trace[1295510486] 'range keys from in-memory index tree' (duration: 268.012ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:10:43.511974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.596291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T21:10:43.512141Z","caller":"traceutil/trace.go:171","msg":"trace[657160091] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2186; }","duration":"115.861519ms","start":"2026-07-30T21:10:43.396254Z","end":"2026-07-30T21:10:43.512115Z","steps":["trace[657160091] 'count revisions from in-memory index tree' (duration: 115.381595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:10:43.512345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.380664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-07-30T21:10:43.512495Z","caller":"traceutil/trace.go:171","msg":"trace[1597808200] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2186; }","duration":"118.59897ms","start":"2026-07-30T21:10:43.393841Z","end":"2026-07-30T21:10:43.51244Z","steps":["trace[1597808200] 'range keys from in-memory index tree' (duration: 118.067335ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:10:58.550642Z","caller":"traceutil/trace.go:171","msg":"trace[141715353] transaction","detail":"{read_only:false; response_revision:2321; number_of_response:1; }","duration":"261.008881ms","start":"2026-07-30T21:10:58.289609Z","end":"2026-07-30T21:10:58.550618Z","steps":["trace[141715353] 'process raft request' (duration: 260.839506ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:10:58.55184Z","caller":"traceutil/trace.go:171","msg":"trace[1971637876] linearizableReadLoop","detail":"{readStateIndex:2409; appliedIndex:2407; }","duration":"233.103812ms","start":"2026-07-30T21:10:58.318709Z","end":"2026-07-30T21:10:58.551813Z","steps":["trace[1971637876] 'read index received' (duration: 231.761501ms)","trace[1971637876] 'applied index is now lower than readState.Index' (duration: 1.341091ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:10:58.55199Z","caller":"traceutil/trace.go:171","msg":"trace[1375312135] transaction","detail":"{read_only:false; response_revision:2322; number_of_response:1; }","duration":"241.948454ms","start":"2026-07-30T21:10:58.310001Z","end":"2026-07-30T21:10:58.55195Z","steps":["trace[1375312135] 'process raft request' (duration: 241.674526ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:10:58.552108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.38617ms","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-07-30T21:10:58.55214Z","caller":"traceutil/trace.go:171","msg":"trace[6512948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2322; }","duration":"233.478502ms","start":"2026-07-30T21:10:58.318653Z","end":"2026-07-30T21:10:58.552131Z","steps":["trace[6512948] 'agreement among raft nodes before linearized reading' (duration: 233.294547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:10:58.552188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.849035ms","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-07-30T21:10:58.552286Z","caller":"traceutil/trace.go:171","msg":"trace[801810676] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2322; }","duration":"138.02989ms","start":"2026-07-30T21:10:58.414236Z","end":"2026-07-30T21:10:58.552266Z","steps":["trace[801810676] 'agreement among raft nodes before linearized reading' (duration: 137.770092ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:11:22.076128Z","caller":"traceutil/trace.go:171","msg":"trace[542183307] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"100.149292ms","start":"2026-07-30T21:11:21.975938Z","end":"2026-07-30T21:11:22.076088Z","steps":["trace[542183307] 'process raft request' (duration: 99.952196ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:11:22.207363Z","caller":"traceutil/trace.go:171","msg":"trace[717786901] transaction","detail":"{read_only:false; response_revision:2484; number_of_response:1; }","duration":"126.497406ms","start":"2026-07-30T21:11:22.080692Z","end":"2026-07-30T21:11:22.207189Z","steps":["trace[717786901] 'process raft request' (duration: 119.032863ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:11:22.81486Z","caller":"traceutil/trace.go:171","msg":"trace[160068228] transaction","detail":"{read_only:false; response_revision:2487; number_of_response:1; }","duration":"128.830546ms","start":"2026-07-30T21:11:22.685998Z","end":"2026-07-30T21:11:22.814829Z","steps":["trace[160068228] 'process raft request' (duration: 106.392218ms)","trace[160068228] 'compare' (duration: 22.294354ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:11:22.99761Z","caller":"traceutil/trace.go:171","msg":"trace[708369717] transaction","detail":"{read_only:false; response_revision:2488; number_of_response:1; }","duration":"310.644419ms","start":"2026-07-30T21:11:22.686925Z","end":"2026-07-30T21:11:22.997569Z","steps":["trace[708369717] 'process raft request' (duration: 302.712722ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:11:22.998524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:11:22.686904Z","time spent":"310.830945ms","remote":"127.0.0.1:36470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:13:16.329035Z","caller":"traceutil/trace.go:171","msg":"trace[1138106672] linearizableReadLoop","detail":"{readStateIndex:3413; appliedIndex:3412; }","duration":"120.463634ms","start":"2026-07-30T21:13:16.208519Z","end":"2026-07-30T21:13:16.328983Z","steps":["trace[1138106672] 'read index received' (duration: 105.151524ms)","trace[1138106672] 'applied index is now lower than readState.Index' (duration: 15.310699ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:13:16.329128Z","caller":"traceutil/trace.go:171","msg":"trace[839441651] transaction","detail":"{read_only:false; response_revision:3296; number_of_response:1; }","duration":"122.852004ms","start":"2026-07-30T21:13:16.206214Z","end":"2026-07-30T21:13:16.329066Z","steps":["trace[839441651] 'process raft request' (duration: 107.647107ms)","trace[839441651] 'compare' (duration: 14.842496ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:13:16.329344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.784454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-30T21:13:16.329424Z","caller":"traceutil/trace.go:171","msg":"trace[765319706] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3296; }","duration":"120.931748ms","start":"2026-07-30T21:13:16.208474Z","end":"2026-07-30T21:13:16.329406Z","steps":["trace[765319706] 'agreement among raft nodes before linearized reading' (duration: 120.6649ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:17:41.182038Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3055} {"level":"info","ts":"2026-07-30T21:17:41.31062Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3055,"took":"127.30692ms","hash":2821701985,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":8712192,"current-db-size-in-use":"8.7 MB"} {"level":"info","ts":"2026-07-30T21:17:41.310718Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2821701985,"revision":3055,"compact-revision":-1} {"level":"info","ts":"2026-07-30T21:22:41.188661Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4990} {"level":"info","ts":"2026-07-30T21:22:41.229093Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4990,"took":"38.771386ms","hash":28920564,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":11104256,"current-db-size-in-use":"11 MB"} {"level":"info","ts":"2026-07-30T21:22:41.229179Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":28920564,"revision":4990,"compact-revision":3055} {"level":"info","ts":"2026-07-30T21:27:41.195629Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7186} {"level":"info","ts":"2026-07-30T21:27:41.250811Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7186,"took":"53.896491ms","hash":2316767854,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":12845056,"current-db-size-in-use":"13 MB"} {"level":"info","ts":"2026-07-30T21:27:41.250882Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2316767854,"revision":7186,"compact-revision":4990} {"level":"info","ts":"2026-07-30T21:27:51.011027Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"7e142186203fa167","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-30T21:27:51.017029Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-30T21:27:51.017146Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-30T21:32:37.639422Z","caller":"traceutil/trace.go:171","msg":"trace[1938621627] transaction","detail":"{read_only:false; response_revision:11903; number_of_response:1; }","duration":"144.482735ms","start":"2026-07-30T21:32:37.494916Z","end":"2026-07-30T21:32:37.639399Z","steps":["trace[1938621627] 'process raft request' (duration: 144.330431ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:32:41.201737Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9594} {"level":"info","ts":"2026-07-30T21:32:41.256365Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9594,"took":"53.636009ms","hash":2290778292,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":13479936,"current-db-size-in-use":"14 MB"} {"level":"info","ts":"2026-07-30T21:32:41.256419Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2290778292,"revision":9594,"compact-revision":7186} {"level":"info","ts":"2026-07-30T21:32:46.176702Z","caller":"traceutil/trace.go:171","msg":"trace[649605685] transaction","detail":"{read_only:false; response_revision:11975; number_of_response:1; }","duration":"118.761314ms","start":"2026-07-30T21:32:46.057919Z","end":"2026-07-30T21:32:46.176681Z","steps":["trace[649605685] 'process raft request' (duration: 118.614869ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:34:25.084368Z","caller":"traceutil/trace.go:171","msg":"trace[1059177017] transaction","detail":"{read_only:false; response_revision:13162; number_of_response:1; }","duration":"151.055976ms","start":"2026-07-30T21:34:24.933276Z","end":"2026-07-30T21:34:25.084332Z","steps":["trace[1059177017] 'process raft request' (duration: 107.92502ms)","trace[1059177017] 'compare' (duration: 42.993362ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:34:25.231253Z","caller":"traceutil/trace.go:171","msg":"trace[2068535609] transaction","detail":"{read_only:false; response_revision:13164; number_of_response:1; }","duration":"115.446708ms","start":"2026-07-30T21:34:25.115769Z","end":"2026-07-30T21:34:25.231216Z","steps":["trace[2068535609] 'process raft request' (duration: 115.218881ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:34:26.198437Z","caller":"traceutil/trace.go:171","msg":"trace[164647951] linearizableReadLoop","detail":"{readStateIndex:13587; appliedIndex:13586; }","duration":"131.539991ms","start":"2026-07-30T21:34:26.066869Z","end":"2026-07-30T21:34:26.198409Z","steps":["trace[164647951] 'read index received' (duration: 130.303105ms)","trace[164647951] 'applied index is now lower than readState.Index' (duration: 1.235706ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:34:26.198529Z","caller":"traceutil/trace.go:171","msg":"trace[1058839782] transaction","detail":"{read_only:false; response_revision:13170; number_of_response:1; }","duration":"193.750089ms","start":"2026-07-30T21:34:26.004722Z","end":"2026-07-30T21:34:26.198472Z","steps":["trace[1058839782] 'process raft request' (duration: 192.472032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:34:26.198613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.055628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:34:26.198655Z","caller":"traceutil/trace.go:171","msg":"trace[90437211] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:13170; }","duration":"112.146771ms","start":"2026-07-30T21:34:26.086499Z","end":"2026-07-30T21:34:26.198646Z","steps":["trace[90437211] 'agreement among raft nodes before linearized reading' (duration: 112.052618ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:34:26.198707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.82534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-cc6mz\" ","response":"range_response_count:1 size:9709"} {"level":"info","ts":"2026-07-30T21:34:26.198801Z","caller":"traceutil/trace.go:171","msg":"trace[1570872926] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-cc6mz; range_end:; response_count:1; response_revision:13170; }","duration":"131.955154ms","start":"2026-07-30T21:34:26.066824Z","end":"2026-07-30T21:34:26.198779Z","steps":["trace[1570872926] 'agreement among raft nodes before linearized reading' (duration: 131.714087ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:34:26.199053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.844123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:34:26.199093Z","caller":"traceutil/trace.go:171","msg":"trace[405639382] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:13170; }","duration":"111.883044ms","start":"2026-07-30T21:34:26.087199Z","end":"2026-07-30T21:34:26.199082Z","steps":["trace[405639382] 'agreement among raft nodes before linearized reading' (duration: 111.826062ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:34:26.199146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.115783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:34:26.199377Z","caller":"traceutil/trace.go:171","msg":"trace[772393068] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:13170; }","duration":"110.326779ms","start":"2026-07-30T21:34:26.088963Z","end":"2026-07-30T21:34:26.19929Z","steps":["trace[772393068] 'agreement among raft nodes before linearized reading' (duration: 110.029ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:34:26.200157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.155918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-07-30T21:34:26.200482Z","caller":"traceutil/trace.go:171","msg":"trace[1194007146] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:13170; }","duration":"107.157808ms","start":"2026-07-30T21:34:26.0933Z","end":"2026-07-30T21:34:26.200457Z","steps":["trace[1194007146] 'agreement among raft nodes before linearized reading' (duration: 105.725126ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:37:41.208577Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11924} {"level":"info","ts":"2026-07-30T21:37:41.277339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11924,"took":"64.582833ms","hash":1108720493,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":15523840,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-07-30T21:37:41.277447Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1108720493,"revision":11924,"compact-revision":9594} {"level":"info","ts":"2026-07-30T21:42:41.216373Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14409} {"level":"info","ts":"2026-07-30T21:42:41.301062Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14409,"took":"81.203762ms","hash":1004386431,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":16658432,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-07-30T21:42:41.301238Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1004386431,"revision":14409,"compact-revision":11924} {"level":"warn","ts":"2026-07-30T21:47:09.175954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.212701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-07-30T21:47:09.17608Z","caller":"traceutil/trace.go:171","msg":"trace[2092603878] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:18807; }","duration":"115.358956ms","start":"2026-07-30T21:47:09.060695Z","end":"2026-07-30T21:47:09.176054Z","steps":["trace[2092603878] 'range keys from in-memory index tree' (duration: 114.891602ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:47:16.180282Z","caller":"traceutil/trace.go:171","msg":"trace[994336754] linearizableReadLoop","detail":"{readStateIndex:19453; appliedIndex:19452; }","duration":"141.994244ms","start":"2026-07-30T21:47:16.03826Z","end":"2026-07-30T21:47:16.180254Z","steps":["trace[994336754] 'read index received' (duration: 141.644854ms)","trace[994336754] 'applied index is now lower than readState.Index' (duration: 347.28µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:47:16.180386Z","caller":"traceutil/trace.go:171","msg":"trace[1792442845] transaction","detail":"{read_only:false; response_revision:18865; number_of_response:1; }","duration":"255.828875ms","start":"2026-07-30T21:47:15.924517Z","end":"2026-07-30T21:47:16.180346Z","steps":["trace[1792442845] 'process raft request' (duration: 255.529107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:47:16.180553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.275422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-xn4sn\" ","response":"range_response_count:1 size:20668"} {"level":"info","ts":"2026-07-30T21:47:16.180597Z","caller":"traceutil/trace.go:171","msg":"trace[2080186055] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-xn4sn; range_end:; response_count:1; response_revision:18865; }","duration":"142.371895ms","start":"2026-07-30T21:47:16.038212Z","end":"2026-07-30T21:47:16.180584Z","steps":["trace[2080186055] 'agreement among raft nodes before linearized reading' (duration: 142.19199ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:47:16.324953Z","caller":"traceutil/trace.go:171","msg":"trace[1472336496] transaction","detail":"{read_only:false; response_revision:18866; number_of_response:1; }","duration":"139.149602ms","start":"2026-07-30T21:47:16.185769Z","end":"2026-07-30T21:47:16.324919Z","steps":["trace[1472336496] 'process raft request' (duration: 129.560965ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:47:16.378804Z","caller":"traceutil/trace.go:171","msg":"trace[379922498] transaction","detail":"{read_only:false; response_revision:18867; number_of_response:1; }","duration":"182.060649ms","start":"2026-07-30T21:47:16.196697Z","end":"2026-07-30T21:47:16.378758Z","steps":["trace[379922498] 'process raft request' (duration: 181.713269ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:47:41.223343Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16886} {"level":"info","ts":"2026-07-30T21:47:41.302998Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16886,"took":"77.856045ms","hash":2139939246,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":16527360,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-07-30T21:47:41.303082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2139939246,"revision":16886,"compact-revision":14409} {"level":"info","ts":"2026-07-30T21:47:53.682825Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"7e142186203fa167","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-30T21:47:53.692787Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-30T21:47:53.692887Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-30T21:52:41.230705Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19176} {"level":"info","ts":"2026-07-30T21:52:41.302825Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19176,"took":"70.074441ms","hash":2650685707,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":20267008,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-07-30T21:52:41.302909Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2650685707,"revision":19176,"compact-revision":16886} {"level":"info","ts":"2026-07-30T21:52:45.373329Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000005844.wal"} {"level":"info","ts":"2026-07-30T21:57:41.238402Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21889} {"level":"info","ts":"2026-07-30T21:57:41.331485Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21889,"took":"91.206611ms","hash":453008715,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":14958592,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-30T21:57:41.331546Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":453008715,"revision":21889,"compact-revision":19176} {"level":"info","ts":"2026-07-30T22:02:41.289718Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23854} {"level":"info","ts":"2026-07-30T22:02:41.359049Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23854,"took":"67.690773ms","hash":140109514,"current-db-size-bytes":35373056,"current-db-size":"35 MB","current-db-size-in-use-bytes":16384000,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-07-30T22:02:41.3591Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":140109514,"revision":23854,"compact-revision":21889}