{"level":"warn","ts":"2026-07-09T09:23:54.987157Z","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-09T09:23:54.987284Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.18: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.18:2380","--initial-cluster=instance=https://199.19.213.18:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.18:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.18: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-09T09:23:54.987388Z","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-09T09:23:54.987402Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-07-09T09:23:54.987424Z","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-09T09:23:54.988349Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"]} {"level":"info","ts":"2026-07-09T09:23:54.988432Z","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.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.18: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-09T09:23:54.991016Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.337296ms"} {"level":"info","ts":"2026-07-09T09:23:54.996018Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6d0358acb671c233","cluster-id":"ba212af698de913f"} {"level":"info","ts":"2026-07-09T09:23:54.996109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=()"} {"level":"info","ts":"2026-07-09T09:23:54.996134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 0"} {"level":"info","ts":"2026-07-09T09:23:54.996153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6d0358acb671c233 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-09T09:23:54.996171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 1"} {"level":"info","ts":"2026-07-09T09:23:54.99621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"warn","ts":"2026-07-09T09:23:55.005818Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-09T09:23:55.007116Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-09T09:23:55.008412Z","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-09T09:23:55.011174Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6d0358acb671c233","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-09T09:23:55.011468Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6d0358acb671c233","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-09T09:23:55.011567Z","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-09T09:23:55.011612Z","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-09T09:23:55.011727Z","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-09T09:23:55.012813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"info","ts":"2026-07-09T09:23:55.013009Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","added-peer-id":"6d0358acb671c233","added-peer-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-07-09T09:23:55.015669Z","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-09T09:23:55.015839Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-07-09T09:23:55.015883Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-07-09T09:23:55.015987Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6d0358acb671c233","initial-advertise-peer-urls":["https://199.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-09T09:23:55.016036Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-09T09:23:55.797468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 is starting a new election at term 1"} {"level":"info","ts":"2026-07-09T09:23:55.797549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-09T09:23:55.797583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgPreVoteResp from 6d0358acb671c233 at term 1"} {"level":"info","ts":"2026-07-09T09:23:55.797601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became candidate at term 2"} {"level":"info","ts":"2026-07-09T09:23:55.797608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgVoteResp from 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-07-09T09:23:55.797621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became leader at term 2"} {"level":"info","ts":"2026-07-09T09:23:55.797632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6d0358acb671c233 elected leader 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-07-09T09:23:55.798639Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T09:23:55.799498Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6d0358acb671c233","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.18:2379]}","request-path":"/0/members/6d0358acb671c233/attributes","cluster-id":"ba212af698de913f","publish-timeout":"7s"} {"level":"info","ts":"2026-07-09T09:23:55.799504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T09:23:55.799658Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T09:23:55.799909Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-09T09:23:55.799993Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-09T09:23:55.800002Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T09:23:55.80009Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T09:23:55.800124Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T09:23:55.803499Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.18:2379"} {"level":"info","ts":"2026-07-09T09:23:55.80411Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-09T09:24:39.291493Z","caller":"traceutil/trace.go:171","msg":"trace[1567676354] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"105.841848ms","start":"2026-07-09T09:24:39.185611Z","end":"2026-07-09T09:24:39.291453Z","steps":["trace[1567676354] 'process raft request' (duration: 104.112453ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:40.202437Z","caller":"traceutil/trace.go:171","msg":"trace[2077236869] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"241.054872ms","start":"2026-07-09T09:24:39.961358Z","end":"2026-07-09T09:24:40.202413Z","steps":["trace[2077236869] 'read index received' (duration: 240.440029ms)","trace[2077236869] 'applied index is now lower than readState.Index' (duration: 613.893µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:24:40.202573Z","caller":"traceutil/trace.go:171","msg":"trace[2016176089] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"392.573552ms","start":"2026-07-09T09:24:39.809961Z","end":"2026-07-09T09:24:40.202534Z","steps":["trace[2016176089] 'process raft request' (duration: 391.943809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:40.20269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.488581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8bj66\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-07-09T09:24:40.202752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.233915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-09T09:24:40.202772Z","caller":"traceutil/trace.go:171","msg":"trace[1053335555] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8bj66; range_end:; response_count:1; response_revision:592; }","duration":"180.615333ms","start":"2026-07-09T09:24:40.022148Z","end":"2026-07-09T09:24:40.202763Z","steps":["trace[1053335555] 'agreement among raft nodes before linearized reading' (duration: 180.425049ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:40.202733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.357738ms","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-09T09:24:40.202846Z","caller":"traceutil/trace.go:171","msg":"trace[2082396844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:592; }","duration":"241.533092ms","start":"2026-07-09T09:24:39.961285Z","end":"2026-07-09T09:24:40.202818Z","steps":["trace[2082396844] 'agreement among raft nodes before linearized reading' (duration: 241.271537ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:40.202792Z","caller":"traceutil/trace.go:171","msg":"trace[280218379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"148.293246ms","start":"2026-07-09T09:24:40.054485Z","end":"2026-07-09T09:24:40.202778Z","steps":["trace[280218379] 'agreement among raft nodes before linearized reading' (duration: 148.184154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:40.203283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:39.809921Z","time spent":"392.747216ms","remote":"127.0.0.1:44598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:24:55.28355Z","caller":"traceutil/trace.go:171","msg":"trace[156594907] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"161.427698ms","start":"2026-07-09T09:24:55.122097Z","end":"2026-07-09T09:24:55.283525Z","steps":["trace[156594907] 'process raft request' (duration: 161.284026ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:08.997352Z","caller":"traceutil/trace.go:171","msg":"trace[1726153795] linearizableReadLoop","detail":"{readStateIndex:1891; appliedIndex:1890; }","duration":"246.917892ms","start":"2026-07-09T09:26:08.750409Z","end":"2026-07-09T09:26:08.997326Z","steps":["trace[1726153795] 'read index received' (duration: 246.716208ms)","trace[1726153795] 'applied index is now lower than readState.Index' (duration: 200.584µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:08.997492Z","caller":"traceutil/trace.go:171","msg":"trace[1854430862] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"263.901212ms","start":"2026-07-09T09:26:08.733538Z","end":"2026-07-09T09:26:08.997439Z","steps":["trace[1854430862] 'process raft request' (duration: 263.642496ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:08.997641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.213598ms","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-09T09:26:08.99774Z","caller":"traceutil/trace.go:171","msg":"trace[1691375694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1820; }","duration":"247.373531ms","start":"2026-07-09T09:26:08.750345Z","end":"2026-07-09T09:26:08.997718Z","steps":["trace[1691375694] 'agreement among raft nodes before linearized reading' (duration: 247.110836ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:09.393413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.978092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T09:26:09.393509Z","caller":"traceutil/trace.go:171","msg":"trace[1445449638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1822; }","duration":"140.123084ms","start":"2026-07-09T09:26:09.253362Z","end":"2026-07-09T09:26:09.393485Z","steps":["trace[1445449638] 'range keys from in-memory index tree' (duration: 139.721727ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:23.925867Z","caller":"traceutil/trace.go:171","msg":"trace[74603490] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"234.833519ms","start":"2026-07-09T09:26:23.69096Z","end":"2026-07-09T09:26:23.925794Z","steps":["trace[74603490] 'process raft request' (duration: 234.685716ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:57.346278Z","caller":"traceutil/trace.go:171","msg":"trace[926347593] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2212; }","duration":"117.045367ms","start":"2026-07-09T09:26:57.229212Z","end":"2026-07-09T09:26:57.346257Z","steps":["trace[926347593] 'read index received' (duration: 116.772632ms)","trace[926347593] 'applied index is now lower than readState.Index' (duration: 271.495µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:57.346344Z","caller":"traceutil/trace.go:171","msg":"trace[284596634] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"118.032127ms","start":"2026-07-09T09:26:57.22828Z","end":"2026-07-09T09:26:57.346312Z","steps":["trace[284596634] 'process raft request' (duration: 117.839013ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:57.34665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.421585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:15 size:25777"} {"level":"info","ts":"2026-07-09T09:26:57.346706Z","caller":"traceutil/trace.go:171","msg":"trace[1291095562] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:15; response_revision:2131; }","duration":"117.508786ms","start":"2026-07-09T09:26:57.22918Z","end":"2026-07-09T09:26:57.346689Z","steps":["trace[1291095562] 'agreement among raft nodes before linearized reading' (duration: 117.219511ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:57.346929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.13208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:15 size:25777"} {"level":"info","ts":"2026-07-09T09:26:57.347008Z","caller":"traceutil/trace.go:171","msg":"trace[1635430696] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:15; response_revision:2131; }","duration":"117.243612ms","start":"2026-07-09T09:26:57.229745Z","end":"2026-07-09T09:26:57.346989Z","steps":["trace[1635430696] 'agreement among raft nodes before linearized reading' (duration: 116.729281ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:27:03.608021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.001729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T09:27:03.608167Z","caller":"traceutil/trace.go:171","msg":"trace[575921767] linearizableReadLoop","detail":"{readStateIndex:2248; appliedIndex:2247; }","duration":"138.712435ms","start":"2026-07-09T09:27:03.469438Z","end":"2026-07-09T09:27:03.60815Z","steps":["trace[575921767] 'read index received' (duration: 40.31µs)","trace[575921767] 'applied index is now lower than readState.Index' (duration: 138.670575ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:27:03.608207Z","caller":"traceutil/trace.go:171","msg":"trace[1599490156] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"190.711751ms","start":"2026-07-09T09:27:03.417465Z","end":"2026-07-09T09:27:03.608177Z","steps":["trace[1599490156] 'process raft request' (duration: 43.271643ms)","trace[1599490156] 'compare' (duration: 146.631012ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:27:03.608289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.85973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:27:03.608329Z","caller":"traceutil/trace.go:171","msg":"trace[1914672910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2165; }","duration":"138.966841ms","start":"2026-07-09T09:27:03.469352Z","end":"2026-07-09T09:27:03.608318Z","steps":["trace[1914672910] 'agreement among raft nodes before linearized reading' (duration: 138.88998ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:27:03.908619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.801655ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T09:27:03.908743Z","caller":"traceutil/trace.go:171","msg":"trace[2980171] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"236.309291ms","start":"2026-07-09T09:27:03.672415Z","end":"2026-07-09T09:27:03.908725Z","steps":["trace[2980171] 'process raft request' (duration: 88.312862ms)","trace[2980171] 'compare' (duration: 147.630752ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:27:38.205768Z","caller":"traceutil/trace.go:171","msg":"trace[855916769] transaction","detail":"{read_only:false; response_revision:2528; number_of_response:1; }","duration":"154.208061ms","start":"2026-07-09T09:27:38.051523Z","end":"2026-07-09T09:27:38.205731Z","steps":["trace[855916769] 'process raft request' (duration: 154.074369ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:28:12.515188Z","caller":"traceutil/trace.go:171","msg":"trace[1593737749] transaction","detail":"{read_only:false; response_revision:2734; number_of_response:1; }","duration":"144.566062ms","start":"2026-07-09T09:28:12.370604Z","end":"2026-07-09T09:28:12.51517Z","steps":["trace[1593737749] 'process raft request' (duration: 144.44949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:28:12.83037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.767892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T09:28:12.83039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.564742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:28:12.830455Z","caller":"traceutil/trace.go:171","msg":"trace[112328748] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2737; }","duration":"169.919405ms","start":"2026-07-09T09:28:12.660516Z","end":"2026-07-09T09:28:12.830436Z","steps":["trace[112328748] 'count revisions from in-memory index tree' (duration: 169.670501ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:28:12.830476Z","caller":"traceutil/trace.go:171","msg":"trace[1825433224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2737; }","duration":"216.744826ms","start":"2026-07-09T09:28:12.613705Z","end":"2026-07-09T09:28:12.83045Z","steps":["trace[1825433224] 'range keys from in-memory index tree' (duration: 216.405619ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:28:13.047743Z","caller":"traceutil/trace.go:171","msg":"trace[1742649332] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"127.067591ms","start":"2026-07-09T09:28:12.920644Z","end":"2026-07-09T09:28:13.047712Z","steps":["trace[1742649332] 'process raft request' (duration: 127.01346ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:28:13.047943Z","caller":"traceutil/trace.go:171","msg":"trace[1029389224] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"129.152374ms","start":"2026-07-09T09:28:12.918742Z","end":"2026-07-09T09:28:13.047895Z","steps":["trace[1029389224] 'process raft request' (duration: 128.754755ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:32:03.150318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.954482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:32:03.150381Z","caller":"traceutil/trace.go:171","msg":"trace[1571925643] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:4893; }","duration":"198.060184ms","start":"2026-07-09T09:32:02.952308Z","end":"2026-07-09T09:32:03.150368Z","steps":["trace[1571925643] 'count revisions from in-memory index tree' (duration: 197.873651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:32:03.150366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.724425ms","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-07-09T09:32:03.150456Z","caller":"traceutil/trace.go:171","msg":"trace[981470136] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4893; }","duration":"215.925648ms","start":"2026-07-09T09:32:02.93451Z","end":"2026-07-09T09:32:03.150436Z","steps":["trace[981470136] 'range keys from in-memory index tree' (duration: 215.522931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:32:03.150453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.570658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-2ml4q-tls\" ","response":"range_response_count:1 size:1966"} {"level":"warn","ts":"2026-07-09T09:32:03.150478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.43002ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T09:32:03.15054Z","caller":"traceutil/trace.go:171","msg":"trace[1942488709] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-2ml4q-tls; range_end:; response_count:1; response_revision:4893; }","duration":"220.697291ms","start":"2026-07-09T09:32:02.929821Z","end":"2026-07-09T09:32:03.150519Z","steps":["trace[1942488709] 'range keys from in-memory index tree' (duration: 220.398305ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:32:03.150624Z","caller":"traceutil/trace.go:171","msg":"trace[1912230235] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"173.294335ms","start":"2026-07-09T09:32:02.977292Z","end":"2026-07-09T09:32:03.150587Z","steps":["trace[1912230235] 'process raft request' (duration: 44.682823ms)","trace[1912230235] 'compare' (duration: 128.260186ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:32:14.807626Z","caller":"traceutil/trace.go:171","msg":"trace[1813499754] transaction","detail":"{read_only:false; response_revision:5132; number_of_response:1; }","duration":"151.644244ms","start":"2026-07-09T09:32:14.655954Z","end":"2026-07-09T09:32:14.807598Z","steps":["trace[1813499754] 'process raft request' (duration: 151.385458ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:33:28.179971Z","caller":"traceutil/trace.go:171","msg":"trace[1815484408] transaction","detail":"{read_only:false; response_revision:5903; number_of_response:1; }","duration":"125.861065ms","start":"2026-07-09T09:33:28.054081Z","end":"2026-07-09T09:33:28.179942Z","steps":["trace[1815484408] 'process raft request' (duration: 125.664642ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:33:55.882778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2974} {"level":"info","ts":"2026-07-09T09:33:55.95329Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2974,"took":"69.093542ms","hash":143491345,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":34283520,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-09T09:33:55.953353Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":143491345,"revision":2974,"compact-revision":-1} {"level":"info","ts":"2026-07-09T09:38:30.607612Z","caller":"traceutil/trace.go:171","msg":"trace[1744664255] transaction","detail":"{read_only:false; response_revision:8134; number_of_response:1; }","duration":"366.323339ms","start":"2026-07-09T09:38:30.241261Z","end":"2026-07-09T09:38:30.607585Z","steps":["trace[1744664255] 'process raft request' (duration: 366.142616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:38:30.607894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:38:30.241244Z","time spent":"366.456242ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:38:41.755313Z","caller":"traceutil/trace.go:171","msg":"trace[1665505056] transaction","detail":"{read_only:false; response_revision:8195; number_of_response:1; }","duration":"134.222035ms","start":"2026-07-09T09:38:41.621067Z","end":"2026-07-09T09:38:41.755289Z","steps":["trace[1665505056] 'process raft request' (duration: 133.884809ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:38:42.074438Z","caller":"traceutil/trace.go:171","msg":"trace[1690773550] transaction","detail":"{read_only:false; response_revision:8196; number_of_response:1; }","duration":"314.788598ms","start":"2026-07-09T09:38:41.759624Z","end":"2026-07-09T09:38:42.074412Z","steps":["trace[1690773550] 'process raft request' (duration: 314.627985ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:38:42.07459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:38:41.759601Z","time spent":"314.910349ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:38:43.4778Z","caller":"traceutil/trace.go:171","msg":"trace[468774803] transaction","detail":"{read_only:false; response_revision:8201; number_of_response:1; }","duration":"129.103839ms","start":"2026-07-09T09:38:43.348675Z","end":"2026-07-09T09:38:43.477779Z","steps":["trace[468774803] 'process raft request' (duration: 128.942785ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:38:43.478233Z","caller":"traceutil/trace.go:171","msg":"trace[311788959] transaction","detail":"{read_only:false; response_revision:8202; number_of_response:1; }","duration":"129.000886ms","start":"2026-07-09T09:38:43.349168Z","end":"2026-07-09T09:38:43.478169Z","steps":["trace[311788959] 'process raft request' (duration: 128.574998ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:38:55.891333Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6103} {"level":"info","ts":"2026-07-09T09:38:55.989767Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6103,"took":"96.442384ms","hash":236641491,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":23040000,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-07-09T09:38:55.989844Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":236641491,"revision":6103,"compact-revision":2974} {"level":"warn","ts":"2026-07-09T09:39:14.769663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.6453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T09:39:14.769745Z","caller":"traceutil/trace.go:171","msg":"trace[1133439425] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:8423; }","duration":"138.757302ms","start":"2026-07-09T09:39:14.630965Z","end":"2026-07-09T09:39:14.769723Z","steps":["trace[1133439425] 'count revisions from in-memory index tree' (duration: 138.524768ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:39:14.769709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.079352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:39:14.76981Z","caller":"traceutil/trace.go:171","msg":"trace[1512396960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8423; }","duration":"157.211104ms","start":"2026-07-09T09:39:14.612576Z","end":"2026-07-09T09:39:14.769787Z","steps":["trace[1512396960] 'range keys from in-memory index tree' (duration: 156.996491ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:39:23.193116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.669992ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-09T09:39:23.193287Z","caller":"traceutil/trace.go:171","msg":"trace[1098132390] transaction","detail":"{read_only:false; response_revision:8509; number_of_response:1; }","duration":"304.686494ms","start":"2026-07-09T09:39:22.888574Z","end":"2026-07-09T09:39:23.19326Z","steps":["trace[1098132390] 'process raft request' (duration: 110.756578ms)","trace[1098132390] 'compare' (duration: 192.647662ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:39:23.193356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:39:22.888547Z","time spent":"304.779787ms","remote":"127.0.0.1:44588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T09:39:23.221026Z","caller":"traceutil/trace.go:171","msg":"trace[182923991] linearizableReadLoop","detail":"{readStateIndex:8816; appliedIndex:8814; }","duration":"281.396429ms","start":"2026-07-09T09:39:22.939604Z","end":"2026-07-09T09:39:23.221Z","steps":["trace[182923991] 'read index received' (duration: 59.749292ms)","trace[182923991] 'applied index is now lower than readState.Index' (duration: 221.645887ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:39:23.221218Z","caller":"traceutil/trace.go:171","msg":"trace[2075769722] transaction","detail":"{read_only:false; response_revision:8511; number_of_response:1; }","duration":"227.616091ms","start":"2026-07-09T09:39:22.993581Z","end":"2026-07-09T09:39:23.221197Z","steps":["trace[2075769722] 'process raft request' (duration: 227.336116ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:39:23.221268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.653083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kmt45\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-09T09:39:23.221306Z","caller":"traceutil/trace.go:171","msg":"trace[403761289] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kmt45; range_end:; response_count:1; response_revision:8511; }","duration":"281.751875ms","start":"2026-07-09T09:39:22.93954Z","end":"2026-07-09T09:39:23.221292Z","steps":["trace[403761289] 'agreement among raft nodes before linearized reading' (duration: 281.568252ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:39:23.221391Z","caller":"traceutil/trace.go:171","msg":"trace[1162633645] transaction","detail":"{read_only:false; response_revision:8510; number_of_response:1; }","duration":"325.208987ms","start":"2026-07-09T09:39:22.896154Z","end":"2026-07-09T09:39:23.221363Z","steps":["trace[1162633645] 'process raft request' (duration: 324.369121ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:39:23.221633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:39:22.896031Z","time spent":"325.461881ms","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4637,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:39:23.942206Z","caller":"traceutil/trace.go:171","msg":"trace[1274184913] transaction","detail":"{read_only:false; response_revision:8518; number_of_response:1; }","duration":"127.63075ms","start":"2026-07-09T09:39:23.814543Z","end":"2026-07-09T09:39:23.942173Z","steps":["trace[1274184913] 'process raft request' (duration: 117.540517ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:39:24.372539Z","caller":"traceutil/trace.go:171","msg":"trace[556115293] linearizableReadLoop","detail":"{readStateIndex:8826; appliedIndex:8825; }","duration":"107.866252ms","start":"2026-07-09T09:39:24.264643Z","end":"2026-07-09T09:39:24.372509Z","steps":["trace[556115293] 'read index received' (duration: 23.510399ms)","trace[556115293] 'applied index is now lower than readState.Index' (duration: 84.354573ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:39:24.372786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.133928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-07-09T09:39:24.372895Z","caller":"traceutil/trace.go:171","msg":"trace[1167084638] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8519; }","duration":"108.28597ms","start":"2026-07-09T09:39:24.264591Z","end":"2026-07-09T09:39:24.372877Z","steps":["trace[1167084638] 'agreement among raft nodes before linearized reading' (duration: 108.033625ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:39:42.240936Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002348.wal"} {"level":"info","ts":"2026-07-09T09:40:42.472824Z","caller":"traceutil/trace.go:171","msg":"trace[2018873951] linearizableReadLoop","detail":"{readStateIndex:9604; appliedIndex:9603; }","duration":"180.313006ms","start":"2026-07-09T09:40:42.292488Z","end":"2026-07-09T09:40:42.472801Z","steps":["trace[2018873951] 'read index received' (duration: 180.009851ms)","trace[2018873951] 'applied index is now lower than readState.Index' (duration: 302.015µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:40:42.47295Z","caller":"traceutil/trace.go:171","msg":"trace[218857308] transaction","detail":"{read_only:false; response_revision:9278; number_of_response:1; }","duration":"267.324669ms","start":"2026-07-09T09:40:42.205592Z","end":"2026-07-09T09:40:42.472916Z","steps":["trace[218857308] 'process raft request' (duration: 267.032924ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:40:42.473074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.575781ms","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-07-09T09:40:42.473118Z","caller":"traceutil/trace.go:171","msg":"trace[1304739334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9278; }","duration":"180.675553ms","start":"2026-07-09T09:40:42.292431Z","end":"2026-07-09T09:40:42.473107Z","steps":["trace[1304739334] 'agreement among raft nodes before linearized reading' (duration: 180.521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:40:42.473234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.264174ms","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-07-09T09:40:42.473382Z","caller":"traceutil/trace.go:171","msg":"trace[2089170404] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9278; }","duration":"114.460937ms","start":"2026-07-09T09:40:42.358892Z","end":"2026-07-09T09:40:42.473353Z","steps":["trace[2089170404] 'agreement among raft nodes before linearized reading' (duration: 114.12994ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:40:42.60171Z","caller":"traceutil/trace.go:171","msg":"trace[519403293] transaction","detail":"{read_only:false; response_revision:9280; number_of_response:1; }","duration":"123.524651ms","start":"2026-07-09T09:40:42.478155Z","end":"2026-07-09T09:40:42.60168Z","steps":["trace[519403293] 'process raft request' (duration: 106.622598ms)","trace[519403293] 'compare' (duration: 16.76923ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:41:35.706303Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6d0358acb671c233","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-09T09:41:35.711485Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-09T09:41:35.711559Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-09T09:43:55.89755Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8275} {"level":"info","ts":"2026-07-09T09:43:55.972487Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8275,"took":"72.507751ms","hash":1646267253,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":26595328,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-07-09T09:43:55.972565Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1646267253,"revision":8275,"compact-revision":6103} {"level":"info","ts":"2026-07-09T09:48:55.925063Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10937} {"level":"info","ts":"2026-07-09T09:48:56.12178Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10937,"took":"193.899623ms","hash":2944659684,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":28303360,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-09T09:48:56.121858Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2944659684,"revision":10937,"compact-revision":8275} {"level":"info","ts":"2026-07-09T09:50:39.704048Z","caller":"traceutil/trace.go:171","msg":"trace[1802056724] transaction","detail":"{read_only:false; response_revision:13644; number_of_response:1; }","duration":"104.519611ms","start":"2026-07-09T09:50:39.599503Z","end":"2026-07-09T09:50:39.704023Z","steps":["trace[1802056724] 'process raft request' (duration: 104.318658ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:50:54.677275Z","caller":"traceutil/trace.go:171","msg":"trace[1569013778] transaction","detail":"{read_only:false; response_revision:13741; number_of_response:1; }","duration":"150.313878ms","start":"2026-07-09T09:50:54.526929Z","end":"2026-07-09T09:50:54.677243Z","steps":["trace[1569013778] 'process raft request' (duration: 149.89705ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:51:04.992973Z","caller":"traceutil/trace.go:171","msg":"trace[2055956579] linearizableReadLoop","detail":"{readStateIndex:14390; appliedIndex:14389; }","duration":"160.727197ms","start":"2026-07-09T09:51:04.832205Z","end":"2026-07-09T09:51:04.992932Z","steps":["trace[2055956579] 'read index received' (duration: 134.747779ms)","trace[2055956579] 'applied index is now lower than readState.Index' (duration: 25.977878ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:51:04.993043Z","caller":"traceutil/trace.go:171","msg":"trace[2005683976] transaction","detail":"{read_only:false; response_revision:13913; number_of_response:1; }","duration":"217.720929ms","start":"2026-07-09T09:51:04.775286Z","end":"2026-07-09T09:51:04.993007Z","steps":["trace[2005683976] 'process raft request' (duration: 191.754962ms)","trace[2005683976] 'compare' (duration: 25.709663ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:51:04.993405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.151715ms","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-07-09T09:51:04.993596Z","caller":"traceutil/trace.go:171","msg":"trace[946860581] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13913; }","duration":"161.399179ms","start":"2026-07-09T09:51:04.832155Z","end":"2026-07-09T09:51:04.993554Z","steps":["trace[946860581] 'agreement among raft nodes before linearized reading' (duration: 160.990152ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:51:04.993678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.942768ms","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-07-09T09:51:04.993852Z","caller":"traceutil/trace.go:171","msg":"trace[1769701964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13913; }","duration":"119.182082ms","start":"2026-07-09T09:51:04.874626Z","end":"2026-07-09T09:51:04.993808Z","steps":["trace[1769701964] 'agreement among raft nodes before linearized reading' (duration: 118.666543ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:52:43.721599Z","caller":"traceutil/trace.go:171","msg":"trace[393409357] linearizableReadLoop","detail":"{readStateIndex:15504; appliedIndex:15503; }","duration":"145.0329ms","start":"2026-07-09T09:52:43.576543Z","end":"2026-07-09T09:52:43.721576Z","steps":["trace[393409357] 'read index received' (duration: 144.712273ms)","trace[393409357] 'applied index is now lower than readState.Index' (duration: 319.877µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:52:43.72187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.288025ms","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-09T09:52:43.721928Z","caller":"traceutil/trace.go:171","msg":"trace[1133680512] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14995; }","duration":"145.413307ms","start":"2026-07-09T09:52:43.5765Z","end":"2026-07-09T09:52:43.721914Z","steps":["trace[1133680512] 'agreement among raft nodes before linearized reading' (duration: 145.289254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:52:43.722051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.000487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:52:43.722151Z","caller":"traceutil/trace.go:171","msg":"trace[332885231] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:14995; }","duration":"111.178901ms","start":"2026-07-09T09:52:43.610951Z","end":"2026-07-09T09:52:43.722129Z","steps":["trace[332885231] 'agreement among raft nodes before linearized reading' (duration: 111.003107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:52:43.722156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.430951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-07-09T09:52:43.72203Z","caller":"traceutil/trace.go:171","msg":"trace[588991627] transaction","detail":"{read_only:false; response_revision:14995; number_of_response:1; }","duration":"211.854562ms","start":"2026-07-09T09:52:43.510062Z","end":"2026-07-09T09:52:43.721917Z","steps":["trace[588991627] 'process raft request' (duration: 211.346311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:52:43.722315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.421194ms","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-09T09:52:43.722353Z","caller":"traceutil/trace.go:171","msg":"trace[133966673] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:14995; }","duration":"138.474875ms","start":"2026-07-09T09:52:43.58387Z","end":"2026-07-09T09:52:43.722345Z","steps":["trace[133966673] 'agreement among raft nodes before linearized reading' (duration: 138.413923ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:52:43.722607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.835454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T09:52:43.722655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.79216ms","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-09T09:52:43.722652Z","caller":"traceutil/trace.go:171","msg":"trace[1860639433] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14995; }","duration":"110.926406ms","start":"2026-07-09T09:52:43.611715Z","end":"2026-07-09T09:52:43.722641Z","steps":["trace[1860639433] 'agreement among raft nodes before linearized reading' (duration: 110.733822ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:52:43.722697Z","caller":"traceutil/trace.go:171","msg":"trace[732239524] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14995; }","duration":"138.843881ms","start":"2026-07-09T09:52:43.583841Z","end":"2026-07-09T09:52:43.722685Z","steps":["trace[732239524] 'agreement among raft nodes before linearized reading' (duration: 138.78741ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:52:43.722844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.266489ms","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-07-09T09:52:43.722897Z","caller":"traceutil/trace.go:171","msg":"trace[1202797682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14995; }","duration":"140.36409ms","start":"2026-07-09T09:52:43.582521Z","end":"2026-07-09T09:52:43.722885Z","steps":["trace[1202797682] 'agreement among raft nodes before linearized reading' (duration: 140.250687ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:52:43.722254Z","caller":"traceutil/trace.go:171","msg":"trace[2092045967] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14995; }","duration":"141.549262ms","start":"2026-07-09T09:52:43.580682Z","end":"2026-07-09T09:52:43.722231Z","steps":["trace[2092045967] 'agreement among raft nodes before linearized reading' (duration: 141.250527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:52:43.906217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.090353ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T09:52:43.906707Z","caller":"traceutil/trace.go:171","msg":"trace[716428185] transaction","detail":"{read_only:false; response_revision:14996; number_of_response:1; }","duration":"177.150426ms","start":"2026-07-09T09:52:43.72952Z","end":"2026-07-09T09:52:43.90667Z","steps":["trace[716428185] 'process raft request' (duration: 57.512412ms)","trace[716428185] 'compare' (duration: 118.976181ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:53:55.931485Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12976} {"level":"info","ts":"2026-07-09T09:53:56.004152Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12976,"took":"69.816338ms","hash":2157327189,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":30375936,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-09T09:53:56.004231Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2157327189,"revision":12976,"compact-revision":10937} {"level":"info","ts":"2026-07-09T09:58:29.457159Z","caller":"traceutil/trace.go:171","msg":"trace[1449708169] transaction","detail":"{read_only:false; response_revision:17635; number_of_response:1; }","duration":"147.971984ms","start":"2026-07-09T09:58:29.309159Z","end":"2026-07-09T09:58:29.457131Z","steps":["trace[1449708169] 'process raft request' (duration: 147.76894ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:58:29.83441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.469206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:1438"} {"level":"warn","ts":"2026-07-09T09:58:29.834069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.99754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T09:58:29.834575Z","caller":"traceutil/trace.go:171","msg":"trace[791016184] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:17637; }","duration":"284.714881ms","start":"2026-07-09T09:58:29.54983Z","end":"2026-07-09T09:58:29.834545Z","steps":["trace[791016184] 'range keys from in-memory index tree' (duration: 284.134769ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:58:29.834597Z","caller":"traceutil/trace.go:171","msg":"trace[740899111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17637; }","duration":"223.56294ms","start":"2026-07-09T09:58:29.611004Z","end":"2026-07-09T09:58:29.834567Z","steps":["trace[740899111] 'range keys from in-memory index tree' (duration: 222.945099ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:58:29.83497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.7248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-heat.18c096a69020950a\" ","response":"range_response_count:1 size:734"} {"level":"info","ts":"2026-07-09T09:58:29.835013Z","caller":"traceutil/trace.go:171","msg":"trace[26970790] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-heat.18c096a69020950a; range_end:; response_count:1; response_revision:17637; }","duration":"286.799371ms","start":"2026-07-09T09:58:29.548201Z","end":"2026-07-09T09:58:29.835001Z","steps":["trace[26970790] 'range keys from in-memory index tree' (duration: 286.571897ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:58:29.841039Z","caller":"traceutil/trace.go:171","msg":"trace[141739965] transaction","detail":"{read_only:false; response_revision:17638; number_of_response:1; }","duration":"119.367401ms","start":"2026-07-09T09:58:29.721659Z","end":"2026-07-09T09:58:29.841026Z","steps":["trace[141739965] 'process raft request' (duration: 119.253289ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:58:29.886562Z","caller":"traceutil/trace.go:171","msg":"trace[1654478596] transaction","detail":"{read_only:false; response_revision:17639; number_of_response:1; }","duration":"164.090146ms","start":"2026-07-09T09:58:29.722433Z","end":"2026-07-09T09:58:29.886523Z","steps":["trace[1654478596] 'process raft request' (duration: 163.889971ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:58:29.886837Z","caller":"traceutil/trace.go:171","msg":"trace[1490880114] linearizableReadLoop","detail":"{readStateIndex:18236; appliedIndex:18235; }","duration":"123.493112ms","start":"2026-07-09T09:58:29.763306Z","end":"2026-07-09T09:58:29.8868Z","steps":["trace[1490880114] 'read index received' (duration: 78.216268ms)","trace[1490880114] 'applied index is now lower than readState.Index' (duration: 45.272774ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:58:29.887131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.811027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-09T09:58:29.887199Z","caller":"traceutil/trace.go:171","msg":"trace[1733515108] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17641; }","duration":"123.95935ms","start":"2026-07-09T09:58:29.763225Z","end":"2026-07-09T09:58:29.887184Z","steps":["trace[1733515108] 'agreement among raft nodes before linearized reading' (duration: 123.664164ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:58:29.91843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.414848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T09:58:29.918532Z","caller":"traceutil/trace.go:171","msg":"trace[458188325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17642; }","duration":"154.58384ms","start":"2026-07-09T09:58:29.763922Z","end":"2026-07-09T09:58:29.918506Z","steps":["trace[458188325] 'agreement among raft nodes before linearized reading' (duration: 154.330875ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:58:30.194065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.436354ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T09:58:30.194276Z","caller":"traceutil/trace.go:171","msg":"trace[1542385920] transaction","detail":"{read_only:false; response_revision:17644; number_of_response:1; }","duration":"270.67117ms","start":"2026-07-09T09:58:29.923585Z","end":"2026-07-09T09:58:30.194257Z","steps":["trace[1542385920] 'process raft request' (duration: 270.589959ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:58:30.194385Z","caller":"traceutil/trace.go:171","msg":"trace[1740739367] linearizableReadLoop","detail":"{readStateIndex:18240; appliedIndex:18239; }","duration":"276.267958ms","start":"2026-07-09T09:58:29.91809Z","end":"2026-07-09T09:58:30.194358Z","steps":["trace[1740739367] 'read index received' (duration: 17.430647ms)","trace[1740739367] 'applied index is now lower than readState.Index' (duration: 258.834831ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:58:30.194565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.01677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"} {"level":"info","ts":"2026-07-09T09:58:30.194615Z","caller":"traceutil/trace.go:171","msg":"trace[137067102] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:17644; }","duration":"295.087742ms","start":"2026-07-09T09:58:29.899509Z","end":"2026-07-09T09:58:30.194596Z","steps":["trace[137067102] 'agreement among raft nodes before linearized reading' (duration: 294.960519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:58:30.194624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.390184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-heat.18c096a6909d66b4\" ","response":"range_response_count:1 size:728"} {"level":"info","ts":"2026-07-09T09:58:30.194667Z","caller":"traceutil/trace.go:171","msg":"trace[952512484] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-heat.18c096a6909d66b4; range_end:; response_count:1; response_revision:17644; }","duration":"272.459865ms","start":"2026-07-09T09:58:29.922194Z","end":"2026-07-09T09:58:30.194654Z","steps":["trace[952512484] 'agreement among raft nodes before linearized reading' (duration: 272.334492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:58:30.19475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.295362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"} {"level":"info","ts":"2026-07-09T09:58:30.19501Z","caller":"traceutil/trace.go:171","msg":"trace[960964215] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:17644; }","duration":"272.603358ms","start":"2026-07-09T09:58:29.922384Z","end":"2026-07-09T09:58:30.194988Z","steps":["trace[960964215] 'agreement among raft nodes before linearized reading' (duration: 272.16861ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:58:30.195195Z","caller":"traceutil/trace.go:171","msg":"trace[1741787544] transaction","detail":"{read_only:false; response_revision:17643; number_of_response:1; }","duration":"304.738947ms","start":"2026-07-09T09:58:29.890412Z","end":"2026-07-09T09:58:30.195151Z","steps":["trace[1741787544] 'process raft request' (duration: 45.10121ms)","trace[1741787544] 'compare' (duration: 257.765821ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:58:30.195324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:58:29.890386Z","time spent":"304.85737ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:58:30.374628Z","caller":"traceutil/trace.go:171","msg":"trace[1154689353] transaction","detail":"{read_only:false; response_revision:17645; number_of_response:1; }","duration":"176.374811ms","start":"2026-07-09T09:58:30.198205Z","end":"2026-07-09T09:58:30.37458Z","steps":["trace[1154689353] 'process raft request' (duration: 122.258928ms)","trace[1154689353] 'compare' (duration: 53.92145ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:58:30.374658Z","caller":"traceutil/trace.go:171","msg":"trace[1441800860] linearizableReadLoop","detail":"{readStateIndex:18242; appliedIndex:18241; }","duration":"175.983713ms","start":"2026-07-09T09:58:30.198649Z","end":"2026-07-09T09:58:30.374632Z","steps":["trace[1441800860] 'read index received' (duration: 121.798859ms)","trace[1441800860] 'applied index is now lower than readState.Index' (duration: 54.183734ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:58:30.374856Z","caller":"traceutil/trace.go:171","msg":"trace[1695768889] transaction","detail":"{read_only:false; response_revision:17646; number_of_response:1; }","duration":"175.425363ms","start":"2026-07-09T09:58:30.19942Z","end":"2026-07-09T09:58:30.374845Z","steps":["trace[1695768889] 'process raft request' (duration: 175.148428ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:58:30.374989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.312639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b1536a70-5099-4e98-a8c7-574dafcdcca1\" ","response":"range_response_count:1 size:1318"} {"level":"info","ts":"2026-07-09T09:58:30.375067Z","caller":"traceutil/trace.go:171","msg":"trace[453629328] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b1536a70-5099-4e98-a8c7-574dafcdcca1; range_end:; response_count:1; response_revision:17646; }","duration":"176.436884ms","start":"2026-07-09T09:58:30.198607Z","end":"2026-07-09T09:58:30.375044Z","steps":["trace[453629328] 'agreement among raft nodes before linearized reading' (duration: 176.160168ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:58:30.375075Z","caller":"traceutil/trace.go:171","msg":"trace[969322392] transaction","detail":"{read_only:false; response_revision:17647; number_of_response:1; }","duration":"173.699461ms","start":"2026-07-09T09:58:30.201335Z","end":"2026-07-09T09:58:30.375034Z","steps":["trace[969322392] 'process raft request' (duration: 173.468185ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:58:30.375532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.952608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-heat-server\" ","response":"range_response_count:1 size:9566"} {"level":"warn","ts":"2026-07-09T09:58:30.37605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.916182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:953096"} {"level":"info","ts":"2026-07-09T09:58:30.376115Z","caller":"traceutil/trace.go:171","msg":"trace[1093817870] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:17647; }","duration":"176.007994ms","start":"2026-07-09T09:58:30.200093Z","end":"2026-07-09T09:58:30.376101Z","steps":["trace[1093817870] 'agreement among raft nodes before linearized reading' (duration: 174.919412ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:58:30.375568Z","caller":"traceutil/trace.go:171","msg":"trace[1464865727] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-heat-server; range_end:; response_count:1; response_revision:17647; }","duration":"170.010289ms","start":"2026-07-09T09:58:30.20555Z","end":"2026-07-09T09:58:30.37556Z","steps":["trace[1464865727] 'agreement among raft nodes before linearized reading' (duration: 169.912548ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:58:55.937498Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15463} {"level":"info","ts":"2026-07-09T09:58:56.029735Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15463,"took":"88.395816ms","hash":224792710,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":32923648,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-07-09T09:58:56.029811Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":224792710,"revision":15463,"compact-revision":12976} {"level":"info","ts":"2026-07-09T10:01:51.258292Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6d0358acb671c233","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-09T10:01:51.262795Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-09T10:01:51.2629Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-09T10:03:55.094057Z","caller":"traceutil/trace.go:171","msg":"trace[118772505] transaction","detail":"{read_only:false; response_revision:20186; number_of_response:1; }","duration":"160.664021ms","start":"2026-07-09T10:03:54.933371Z","end":"2026-07-09T10:03:55.094035Z","steps":["trace[118772505] 'process raft request' (duration: 160.523377ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:03:55.439272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.593652ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:03:55.439517Z","caller":"traceutil/trace.go:171","msg":"trace[1217278182] transaction","detail":"{read_only:false; response_revision:20187; number_of_response:1; }","duration":"461.793144ms","start":"2026-07-09T10:03:54.977699Z","end":"2026-07-09T10:03:55.439492Z","steps":["trace[1217278182] 'process raft request' (duration: 290.838945ms)","trace[1217278182] 'compare' (duration: 170.394889ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:03:55.43963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:03:54.977681Z","time spent":"461.913416ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:03:55.439637Z","caller":"traceutil/trace.go:171","msg":"trace[140612848] linearizableReadLoop","detail":"{readStateIndex:20869; appliedIndex:20867; }","duration":"394.418987ms","start":"2026-07-09T10:03:55.045168Z","end":"2026-07-09T10:03:55.439587Z","steps":["trace[140612848] 'read index received' (duration: 49.217486ms)","trace[140612848] 'applied index is now lower than readState.Index' (duration: 345.194681ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:03:55.439827Z","caller":"traceutil/trace.go:171","msg":"trace[1722581148] transaction","detail":"{read_only:false; response_revision:20188; number_of_response:1; }","duration":"433.219554ms","start":"2026-07-09T10:03:55.006594Z","end":"2026-07-09T10:03:55.439813Z","steps":["trace[1722581148] 'process raft request' (duration: 432.820866ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:03:55.439935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.762805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-09T10:03:55.439978Z","caller":"traceutil/trace.go:171","msg":"trace[1753395297] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20188; }","duration":"394.833486ms","start":"2026-07-09T10:03:55.045133Z","end":"2026-07-09T10:03:55.439967Z","steps":["trace[1753395297] 'agreement among raft nodes before linearized reading' (duration: 394.681442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:03:55.43998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:03:55.006581Z","time spent":"433.279405ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:03:55.440017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:03:55.045121Z","time spent":"394.889317ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-09T10:03:55.440104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.984224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7913"} {"level":"info","ts":"2026-07-09T10:03:55.440175Z","caller":"traceutil/trace.go:171","msg":"trace[1464483516] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:20188; }","duration":"324.097895ms","start":"2026-07-09T10:03:55.116057Z","end":"2026-07-09T10:03:55.440155Z","steps":["trace[1464483516] 'agreement among raft nodes before linearized reading' (duration: 323.803229ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:03:55.440211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:03:55.11604Z","time spent":"324.165597ms","remote":"127.0.0.1:55398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7936,"request content":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" "} {"level":"info","ts":"2026-07-09T10:03:55.701651Z","caller":"traceutil/trace.go:171","msg":"trace[1865669696] transaction","detail":"{read_only:false; response_revision:20189; number_of_response:1; }","duration":"256.724529ms","start":"2026-07-09T10:03:55.444898Z","end":"2026-07-09T10:03:55.701622Z","steps":["trace[1865669696] 'process raft request' (duration: 208.464111ms)","trace[1865669696] 'compare' (duration: 47.661527ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:03:56.001523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.673987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T10:03:56.001626Z","caller":"traceutil/trace.go:171","msg":"trace[1491379980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20189; }","duration":"191.813851ms","start":"2026-07-09T10:03:55.809789Z","end":"2026-07-09T10:03:56.001603Z","steps":["trace[1491379980] 'range keys from in-memory index tree' (duration: 191.317149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:03:56.001827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.842128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-09T10:03:56.001883Z","caller":"traceutil/trace.go:171","msg":"trace[1093283507] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20189; }","duration":"194.90602ms","start":"2026-07-09T10:03:55.806963Z","end":"2026-07-09T10:03:56.001869Z","steps":["trace[1093283507] 'range keys from in-memory index tree' (duration: 194.764227ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:03:56.274631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.349497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:03:56.275011Z","caller":"traceutil/trace.go:171","msg":"trace[1713544128] transaction","detail":"{read_only:false; response_revision:20191; number_of_response:1; }","duration":"268.345523ms","start":"2026-07-09T10:03:56.006637Z","end":"2026-07-09T10:03:56.274982Z","steps":["trace[1713544128] 'process raft request' (duration: 123.580288ms)","trace[1713544128] 'compare' (duration: 144.058191ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:03:56.275491Z","caller":"traceutil/trace.go:171","msg":"trace[1148858531] transaction","detail":"{read_only:false; response_revision:20192; number_of_response:1; }","duration":"267.436465ms","start":"2026-07-09T10:03:56.008035Z","end":"2026-07-09T10:03:56.275471Z","steps":["trace[1148858531] 'process raft request' (duration: 267.006347ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:03:56.275664Z","caller":"traceutil/trace.go:171","msg":"trace[1206612964] transaction","detail":"{read_only:false; response_revision:20193; number_of_response:1; }","duration":"266.772692ms","start":"2026-07-09T10:03:56.008858Z","end":"2026-07-09T10:03:56.27563Z","steps":["trace[1206612964] 'process raft request' (duration: 266.221902ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:03:56.275882Z","caller":"traceutil/trace.go:171","msg":"trace[1206879661] transaction","detail":"{read_only:false; response_revision:20194; number_of_response:1; }","duration":"266.750982ms","start":"2026-07-09T10:03:56.009119Z","end":"2026-07-09T10:03:56.27587Z","steps":["trace[1206879661] 'process raft request' (duration: 265.984147ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:03:56.377098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18023} {"level":"warn","ts":"2026-07-09T10:03:56.378126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.082544ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:6"} {"level":"info","ts":"2026-07-09T10:03:56.378309Z","caller":"traceutil/trace.go:171","msg":"trace[830274310] compact","detail":"{revision:18023; response_revision:20194; }","duration":"343.375267ms","start":"2026-07-09T10:03:56.034872Z","end":"2026-07-09T10:03:56.378247Z","steps":["trace[830274310] 'process raft request' (duration: 240.257803ms)","trace[830274310] 'check and update compact revision' (duration: 100.978522ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:03:56.378434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:03:56.034833Z","time spent":"343.56976ms","remote":"127.0.0.1:44524","response type":"/etcdserverpb.KV/Compact","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-09T10:03:56.67483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.321055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:03:56.674959Z","caller":"traceutil/trace.go:171","msg":"trace[357582763] transaction","detail":"{read_only:false; response_revision:20195; number_of_response:1; }","duration":"331.846864ms","start":"2026-07-09T10:03:56.343087Z","end":"2026-07-09T10:03:56.674933Z","steps":["trace[357582763] 'process raft request' (duration: 42.312314ms)","trace[357582763] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/ceph.rook.io/cephclusters/openstack/ceph; req_size:7893; } (duration: 289.02193ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:03:56.675025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:03:56.343067Z","time spent":"331.928786ms","remote":"127.0.0.1:55398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7896,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:03:56.870789Z","caller":"traceutil/trace.go:171","msg":"trace[1976238409] transaction","detail":"{read_only:false; response_revision:20196; number_of_response:1; }","duration":"223.824205ms","start":"2026-07-09T10:03:56.646941Z","end":"2026-07-09T10:03:56.870766Z","steps":["trace[1976238409] 'process raft request' (duration: 203.77373ms)","trace[1976238409] 'compare' (duration: 19.746999ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:03:56.871087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.394649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-09T10:03:56.871177Z","caller":"traceutil/trace.go:171","msg":"trace[1630241053] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:20197; }","duration":"196.550932ms","start":"2026-07-09T10:03:56.674605Z","end":"2026-07-09T10:03:56.871156Z","steps":["trace[1630241053] 'agreement among raft nodes before linearized reading' (duration: 196.352979ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:03:56.871341Z","caller":"traceutil/trace.go:171","msg":"trace[1241059414] linearizableReadLoop","detail":"{readStateIndex:20878; appliedIndex:20877; }","duration":"196.153515ms","start":"2026-07-09T10:03:56.674651Z","end":"2026-07-09T10:03:56.870804Z","steps":["trace[1241059414] 'read index received' (duration: 176.151149ms)","trace[1241059414] 'applied index is now lower than readState.Index' (duration: 19.996795ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:03:56.872088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.158699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18465"} {"level":"info","ts":"2026-07-09T10:03:56.872161Z","caller":"traceutil/trace.go:171","msg":"trace[1480319822] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:20197; }","duration":"189.294681ms","start":"2026-07-09T10:03:56.682846Z","end":"2026-07-09T10:03:56.872141Z","steps":["trace[1480319822] 'agreement among raft nodes before linearized reading' (duration: 188.982636ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:03:56.965107Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18023,"took":"581.512367ms","hash":1750236054,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":30625792,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-09T10:03:56.965164Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1750236054,"revision":18023,"compact-revision":15463} {"level":"info","ts":"2026-07-09T10:07:53.730991Z","caller":"traceutil/trace.go:171","msg":"trace[1392959513] transaction","detail":"{read_only:false; response_revision:22697; number_of_response:1; }","duration":"233.538983ms","start":"2026-07-09T10:07:53.497425Z","end":"2026-07-09T10:07:53.730964Z","steps":["trace[1392959513] 'process raft request' (duration: 233.271578ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:07:53.743093Z","caller":"traceutil/trace.go:171","msg":"trace[1131097341] linearizableReadLoop","detail":"{readStateIndex:23452; appliedIndex:23450; }","duration":"241.612249ms","start":"2026-07-09T10:07:53.501462Z","end":"2026-07-09T10:07:53.743074Z","steps":["trace[1131097341] 'read index received' (duration: 229.255371ms)","trace[1131097341] 'applied index is now lower than readState.Index' (duration: 12.355998ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:07:53.743165Z","caller":"traceutil/trace.go:171","msg":"trace[452530207] transaction","detail":"{read_only:false; response_revision:22698; number_of_response:1; }","duration":"242.820942ms","start":"2026-07-09T10:07:53.500302Z","end":"2026-07-09T10:07:53.743123Z","steps":["trace[452530207] 'process raft request' (duration: 242.651209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:07:53.7435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.015667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T10:07:53.743533Z","caller":"traceutil/trace.go:171","msg":"trace[1614371523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22698; }","duration":"242.086258ms","start":"2026-07-09T10:07:53.501439Z","end":"2026-07-09T10:07:53.743525Z","steps":["trace[1614371523] 'agreement among raft nodes before linearized reading' (duration: 241.781492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:07:53.751795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.385728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-09T10:07:53.75187Z","caller":"traceutil/trace.go:171","msg":"trace[1094812640] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22699; }","duration":"249.51338ms","start":"2026-07-09T10:07:53.50234Z","end":"2026-07-09T10:07:53.751853Z","steps":["trace[1094812640] 'agreement among raft nodes before linearized reading' (duration: 249.282896ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:08:56.385329Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20190} {"level":"info","ts":"2026-07-09T10:08:56.491334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20190,"took":"102.126925ms","hash":1718667830,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":42737664,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-07-09T10:08:56.491398Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1718667830,"revision":20190,"compact-revision":18023} {"level":"info","ts":"2026-07-09T10:11:36.401242Z","caller":"traceutil/trace.go:171","msg":"trace[1624191752] transaction","detail":"{read_only:false; response_revision:24916; number_of_response:1; }","duration":"241.368362ms","start":"2026-07-09T10:11:36.159845Z","end":"2026-07-09T10:11:36.401213Z","steps":["trace[1624191752] 'process raft request' (duration: 241.210809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:36.561287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.720667ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:11:36.561539Z","caller":"traceutil/trace.go:171","msg":"trace[1711806240] transaction","detail":"{read_only:false; response_revision:24917; number_of_response:1; }","duration":"346.664224ms","start":"2026-07-09T10:11:36.214851Z","end":"2026-07-09T10:11:36.561516Z","steps":["trace[1711806240] 'process raft request' (duration: 213.634621ms)","trace[1711806240] 'compare' (duration: 132.582374ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:36.563404Z","caller":"traceutil/trace.go:171","msg":"trace[1517193578] transaction","detail":"{read_only:false; response_revision:24918; number_of_response:1; }","duration":"220.683886ms","start":"2026-07-09T10:11:36.340896Z","end":"2026-07-09T10:11:36.56158Z","steps":["trace[1517193578] 'process raft request' (duration: 220.491472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:36.563477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:36.214828Z","time spent":"348.55862ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:37.022607Z","caller":"traceutil/trace.go:171","msg":"trace[1669693215] linearizableReadLoop","detail":"{readStateIndex:25733; appliedIndex:25732; }","duration":"180.27331ms","start":"2026-07-09T10:11:36.842303Z","end":"2026-07-09T10:11:37.022577Z","steps":["trace[1669693215] 'read index received' (duration: 103.829993ms)","trace[1669693215] 'applied index is now lower than readState.Index' (duration: 76.441887ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:37.022766Z","caller":"traceutil/trace.go:171","msg":"trace[1341196323] transaction","detail":"{read_only:false; response_revision:24920; number_of_response:1; }","duration":"180.873111ms","start":"2026-07-09T10:11:36.841755Z","end":"2026-07-09T10:11:37.022628Z","steps":["trace[1341196323] 'process raft request' (duration: 104.366383ms)","trace[1341196323] 'compare' (duration: 76.185802ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:11:37.022926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.599376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-09T10:11:37.02297Z","caller":"traceutil/trace.go:171","msg":"trace[948535562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24920; }","duration":"180.688028ms","start":"2026-07-09T10:11:36.84227Z","end":"2026-07-09T10:11:37.022958Z","steps":["trace[948535562] 'agreement among raft nodes before linearized reading' (duration: 180.438604ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:37.049693Z","caller":"traceutil/trace.go:171","msg":"trace[798009298] transaction","detail":"{read_only:false; response_revision:24921; number_of_response:1; }","duration":"139.469866ms","start":"2026-07-09T10:11:36.91019Z","end":"2026-07-09T10:11:37.04966Z","steps":["trace[798009298] 'process raft request' (duration: 139.235862ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:37.049846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.676384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T10:11:37.049909Z","caller":"traceutil/trace.go:171","msg":"trace[908008999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24921; }","duration":"147.789946ms","start":"2026-07-09T10:11:36.9021Z","end":"2026-07-09T10:11:37.04989Z","steps":["trace[908008999] 'agreement among raft nodes before linearized reading' (duration: 147.488861ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:37.361939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.611399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T10:11:37.362102Z","caller":"traceutil/trace.go:171","msg":"trace[225982781] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24924; }","duration":"202.849952ms","start":"2026-07-09T10:11:37.159217Z","end":"2026-07-09T10:11:37.362067Z","steps":["trace[225982781] 'count revisions from in-memory index tree' (duration: 202.500696ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:37.36214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.176918ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:11:37.36224Z","caller":"traceutil/trace.go:171","msg":"trace[2055921752] transaction","detail":"{read_only:false; response_revision:24925; number_of_response:1; }","duration":"176.121851ms","start":"2026-07-09T10:11:37.186098Z","end":"2026-07-09T10:11:37.36222Z","steps":["trace[2055921752] 'process raft request' (duration: 32.772509ms)","trace[2055921752] 'compare' (duration: 143.050415ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:38.836046Z","caller":"traceutil/trace.go:171","msg":"trace[1264281106] transaction","detail":"{read_only:false; response_revision:24932; number_of_response:1; }","duration":"267.158888ms","start":"2026-07-09T10:11:38.568859Z","end":"2026-07-09T10:11:38.836018Z","steps":["trace[1264281106] 'process raft request' (duration: 266.973115ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:39.028404Z","caller":"traceutil/trace.go:171","msg":"trace[942661437] transaction","detail":"{read_only:false; response_revision:24933; number_of_response:1; }","duration":"458.231046ms","start":"2026-07-09T10:11:38.570137Z","end":"2026-07-09T10:11:39.028368Z","steps":["trace[942661437] 'process raft request' (duration: 375.749942ms)","trace[942661437] 'compare' (duration: 82.055725ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:39.028489Z","caller":"traceutil/trace.go:171","msg":"trace[1178111100] transaction","detail":"{read_only:false; response_revision:24934; number_of_response:1; }","duration":"273.797766ms","start":"2026-07-09T10:11:38.754669Z","end":"2026-07-09T10:11:39.028467Z","steps":["trace[1178111100] 'process raft request' (duration: 273.452568ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:39.028671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:38.570128Z","time spent":"458.376009ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:11:39.32572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.840491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:11:39.325937Z","caller":"traceutil/trace.go:171","msg":"trace[481720643] linearizableReadLoop","detail":"{readStateIndex:25749; appliedIndex:25747; }","duration":"244.089824ms","start":"2026-07-09T10:11:39.081826Z","end":"2026-07-09T10:11:39.325916Z","steps":["trace[481720643] 'read index received' (duration: 98.900777ms)","trace[481720643] 'applied index is now lower than readState.Index' (duration: 145.187627ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:39.326063Z","caller":"traceutil/trace.go:171","msg":"trace[2088066821] transaction","detail":"{read_only:false; response_revision:24935; number_of_response:1; }","duration":"293.131965ms","start":"2026-07-09T10:11:39.032898Z","end":"2026-07-09T10:11:39.32603Z","steps":["trace[2088066821] 'process raft request' (duration: 147.826446ms)","trace[2088066821] 'compare' (duration: 144.664227ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:39.3264Z","caller":"traceutil/trace.go:171","msg":"trace[90488168] transaction","detail":"{read_only:false; response_revision:24936; number_of_response:1; }","duration":"272.082262ms","start":"2026-07-09T10:11:39.054304Z","end":"2026-07-09T10:11:39.326387Z","steps":["trace[90488168] 'process raft request' (duration: 271.531162ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:39.326628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.805449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-07-09T10:11:39.326636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.96014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-09T10:11:39.326676Z","caller":"traceutil/trace.go:171","msg":"trace[1703516970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24936; }","duration":"244.8874ms","start":"2026-07-09T10:11:39.081773Z","end":"2026-07-09T10:11:39.326661Z","steps":["trace[1703516970] 'agreement among raft nodes before linearized reading' (duration: 244.731586ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:39.326682Z","caller":"traceutil/trace.go:171","msg":"trace[781131921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24936; }","duration":"223.061932ms","start":"2026-07-09T10:11:39.103607Z","end":"2026-07-09T10:11:39.326668Z","steps":["trace[781131921] 'agreement among raft nodes before linearized reading' (duration: 222.94254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:39.326835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.742338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.18\" ","response":"range_response_count:1 size:137"} {"level":"warn","ts":"2026-07-09T10:11:39.32686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.671023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T10:11:39.326921Z","caller":"traceutil/trace.go:171","msg":"trace[1749661016] range","detail":"{range_begin:/registry/masterleases/199.19.213.18; range_end:; response_count:1; response_revision:24936; }","duration":"244.87243ms","start":"2026-07-09T10:11:39.082025Z","end":"2026-07-09T10:11:39.326898Z","steps":["trace[1749661016] 'agreement among raft nodes before linearized reading' (duration: 244.628336ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:39.326974Z","caller":"traceutil/trace.go:171","msg":"trace[137554644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24936; }","duration":"223.844516ms","start":"2026-07-09T10:11:39.103111Z","end":"2026-07-09T10:11:39.326956Z","steps":["trace[137554644] 'agreement among raft nodes before linearized reading' (duration: 223.5138ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:39.564855Z","caller":"traceutil/trace.go:171","msg":"trace[2020866170] transaction","detail":"{read_only:false; response_revision:24941; number_of_response:1; }","duration":"197.702196ms","start":"2026-07-09T10:11:39.36706Z","end":"2026-07-09T10:11:39.564762Z","steps":["trace[2020866170] 'process raft request' (duration: 197.484031ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:39.565561Z","caller":"traceutil/trace.go:171","msg":"trace[1666495361] transaction","detail":"{read_only:false; response_revision:24938; number_of_response:1; }","duration":"233.316598ms","start":"2026-07-09T10:11:39.332205Z","end":"2026-07-09T10:11:39.565521Z","steps":["trace[1666495361] 'process raft request' (duration: 231.969332ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:39.565868Z","caller":"traceutil/trace.go:171","msg":"trace[267610085] transaction","detail":"{read_only:false; response_revision:24940; number_of_response:1; }","duration":"199.918497ms","start":"2026-07-09T10:11:39.365884Z","end":"2026-07-09T10:11:39.565802Z","steps":["trace[267610085] 'process raft request' (duration: 198.469809ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:39.566109Z","caller":"traceutil/trace.go:171","msg":"trace[1320994303] transaction","detail":"{read_only:false; response_revision:24937; number_of_response:1; }","duration":"233.92504ms","start":"2026-07-09T10:11:39.332171Z","end":"2026-07-09T10:11:39.566096Z","steps":["trace[1320994303] 'process raft request' (duration: 231.696537ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:39.566196Z","caller":"traceutil/trace.go:171","msg":"trace[839734751] transaction","detail":"{read_only:false; response_revision:24939; number_of_response:1; }","duration":"231.984183ms","start":"2026-07-09T10:11:39.334192Z","end":"2026-07-09T10:11:39.566176Z","steps":["trace[839734751] 'process raft request' (duration: 230.036685ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:39.72664Z","caller":"traceutil/trace.go:171","msg":"trace[674342169] linearizableReadLoop","detail":"{readStateIndex:25756; appliedIndex:25755; }","duration":"113.665821ms","start":"2026-07-09T10:11:39.612942Z","end":"2026-07-09T10:11:39.726607Z","steps":["trace[674342169] 'read index received' (duration: 40.360854ms)","trace[674342169] 'applied index is now lower than readState.Index' (duration: 73.303507ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:39.726649Z","caller":"traceutil/trace.go:171","msg":"trace[1965663490] transaction","detail":"{read_only:false; response_revision:24942; number_of_response:1; }","duration":"318.902291ms","start":"2026-07-09T10:11:39.407721Z","end":"2026-07-09T10:11:39.726623Z","steps":["trace[1965663490] 'process raft request' (duration: 245.543704ms)","trace[1965663490] 'compare' (duration: 73.207294ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:11:39.726809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.854425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-09T10:11:39.726849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:39.407681Z","time spent":"319.056434ms","remote":"127.0.0.1:44532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:39.726869Z","caller":"traceutil/trace.go:171","msg":"trace[931536385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24942; }","duration":"113.951746ms","start":"2026-07-09T10:11:39.612903Z","end":"2026-07-09T10:11:39.726855Z","steps":["trace[931536385] 'agreement among raft nodes before linearized reading' (duration: 113.809724ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:40.015512Z","caller":"traceutil/trace.go:171","msg":"trace[931111670] linearizableReadLoop","detail":"{readStateIndex:25757; appliedIndex:25756; }","duration":"287.791994ms","start":"2026-07-09T10:11:39.7277Z","end":"2026-07-09T10:11:40.015492Z","steps":["trace[931111670] 'read index received' (duration: 266.688789ms)","trace[931111670] 'applied index is now lower than readState.Index' (duration: 21.102185ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:11:40.015658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.941837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T10:11:40.015689Z","caller":"traceutil/trace.go:171","msg":"trace[966952462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24943; }","duration":"288.024859ms","start":"2026-07-09T10:11:39.727654Z","end":"2026-07-09T10:11:40.015679Z","steps":["trace[966952462] 'agreement among raft nodes before linearized reading' (duration: 287.956688ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:40.015886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.165832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-07-09T10:11:40.015681Z","caller":"traceutil/trace.go:171","msg":"trace[1628781637] transaction","detail":"{read_only:false; response_revision:24943; number_of_response:1; }","duration":"401.056699ms","start":"2026-07-09T10:11:39.614562Z","end":"2026-07-09T10:11:40.015619Z","steps":["trace[1628781637] 'process raft request' (duration: 379.80475ms)","trace[1628781637] 'compare' (duration: 21.026894ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:40.015968Z","caller":"traceutil/trace.go:171","msg":"trace[94331441] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:24943; }","duration":"287.316185ms","start":"2026-07-09T10:11:39.728633Z","end":"2026-07-09T10:11:40.015949Z","steps":["trace[94331441] 'agreement among raft nodes before linearized reading' (duration: 287.06205ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:40.016221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:39.614537Z","time spent":"401.545527ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:40.546754Z","caller":"traceutil/trace.go:171","msg":"trace[956376954] transaction","detail":"{read_only:false; response_revision:24945; number_of_response:1; }","duration":"107.595435ms","start":"2026-07-09T10:11:40.439129Z","end":"2026-07-09T10:11:40.546724Z","steps":["trace[956376954] 'process raft request' (duration: 107.426672ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:40.978996Z","caller":"traceutil/trace.go:171","msg":"trace[459536153] transaction","detail":"{read_only:false; response_revision:24946; number_of_response:1; }","duration":"137.604772ms","start":"2026-07-09T10:11:40.841353Z","end":"2026-07-09T10:11:40.978958Z","steps":["trace[459536153] 'process raft request' (duration: 137.445569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:41.271669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.92708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:11:41.272228Z","caller":"traceutil/trace.go:171","msg":"trace[128773184] transaction","detail":"{read_only:false; response_revision:24948; number_of_response:1; }","duration":"238.548229ms","start":"2026-07-09T10:11:41.033654Z","end":"2026-07-09T10:11:41.272202Z","steps":["trace[128773184] 'process raft request' (duration: 238.134081ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:41.272265Z","caller":"traceutil/trace.go:171","msg":"trace[2026985997] transaction","detail":"{read_only:false; response_revision:24947; number_of_response:1; }","duration":"239.634529ms","start":"2026-07-09T10:11:41.032474Z","end":"2026-07-09T10:11:41.272108Z","steps":["trace[2026985997] 'process raft request' (duration: 105.189499ms)","trace[2026985997] 'compare' (duration: 133.524102ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:41.477983Z","caller":"traceutil/trace.go:171","msg":"trace[538711601] transaction","detail":"{read_only:false; response_revision:24949; number_of_response:1; }","duration":"146.010543ms","start":"2026-07-09T10:11:41.331912Z","end":"2026-07-09T10:11:41.477922Z","steps":["trace[538711601] 'process raft request' (duration: 145.828779ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:41.61868Z","caller":"traceutil/trace.go:171","msg":"trace[1832299572] transaction","detail":"{read_only:false; response_revision:24950; number_of_response:1; }","duration":"283.690285ms","start":"2026-07-09T10:11:41.334973Z","end":"2026-07-09T10:11:41.618663Z","steps":["trace[1832299572] 'process raft request' (duration: 275.11715ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:41.920247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.8312ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:11:41.92053Z","caller":"traceutil/trace.go:171","msg":"trace[1515446623] linearizableReadLoop","detail":"{readStateIndex:25769; appliedIndex:25766; }","duration":"258.156065ms","start":"2026-07-09T10:11:41.662352Z","end":"2026-07-09T10:11:41.920508Z","steps":["trace[1515446623] 'read index received' (duration: 100.04343ms)","trace[1515446623] 'applied index is now lower than readState.Index' (duration: 158.111175ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:41.92061Z","caller":"traceutil/trace.go:171","msg":"trace[1387787893] transaction","detail":"{read_only:false; response_revision:24954; number_of_response:1; }","duration":"297.155934ms","start":"2026-07-09T10:11:41.623421Z","end":"2026-07-09T10:11:41.920577Z","steps":["trace[1387787893] 'process raft request' (duration: 296.96278ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:41.920684Z","caller":"traceutil/trace.go:171","msg":"trace[1401480825] transaction","detail":"{read_only:false; response_revision:24955; number_of_response:1; }","duration":"296.792987ms","start":"2026-07-09T10:11:41.62386Z","end":"2026-07-09T10:11:41.920653Z","steps":["trace[1401480825] 'process raft request' (duration: 296.599633ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:41.92073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.376699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-09T10:11:41.920607Z","caller":"traceutil/trace.go:171","msg":"trace[644826368] transaction","detail":"{read_only:false; response_revision:24953; number_of_response:1; }","duration":"297.560261ms","start":"2026-07-09T10:11:41.622987Z","end":"2026-07-09T10:11:41.920547Z","steps":["trace[644826368] 'process raft request' (duration: 139.326974ms)","trace[644826368] 'compare' (duration: 157.661517ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:41.920779Z","caller":"traceutil/trace.go:171","msg":"trace[414470134] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24955; }","duration":"258.45665ms","start":"2026-07-09T10:11:41.662306Z","end":"2026-07-09T10:11:41.920763Z","steps":["trace[414470134] 'agreement among raft nodes before linearized reading' (duration: 258.273767ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:42.269337Z","caller":"traceutil/trace.go:171","msg":"trace[99952577] transaction","detail":"{read_only:false; response_revision:24956; number_of_response:1; }","duration":"248.00717ms","start":"2026-07-09T10:11:42.021291Z","end":"2026-07-09T10:11:42.269298Z","steps":["trace[99952577] 'process raft request' (duration: 188.827644ms)","trace[99952577] 'compare' (duration: 58.888941ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:51.293682Z","caller":"traceutil/trace.go:171","msg":"trace[2075490782] transaction","detail":"{read_only:false; response_revision:25025; number_of_response:1; }","duration":"260.01529ms","start":"2026-07-09T10:11:51.033645Z","end":"2026-07-09T10:11:51.293661Z","steps":["trace[2075490782] 'process raft request' (duration: 259.870058ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:51.870524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.408098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:11:51.870658Z","caller":"traceutil/trace.go:171","msg":"trace[280113385] transaction","detail":"{read_only:false; response_revision:25026; number_of_response:1; }","duration":"566.549045ms","start":"2026-07-09T10:11:51.304083Z","end":"2026-07-09T10:11:51.870632Z","steps":["trace[280113385] 'process raft request' (duration: 255.907972ms)","trace[280113385] 'compare' (duration: 310.232874ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:11:51.870771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.304058Z","time spent":"566.664546ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:11:52.406989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.792895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:11:52.40744Z","caller":"traceutil/trace.go:171","msg":"trace[1050017543] transaction","detail":"{read_only:false; response_revision:25027; number_of_response:1; }","duration":"1.100061395s","start":"2026-07-09T10:11:51.307348Z","end":"2026-07-09T10:11:52.407409Z","steps":["trace[1050017543] 'process raft request' (duration: 737.69126ms)","trace[1050017543] 'compare' (duration: 361.5662ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:11:52.407609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.307317Z","time spent":"1.100241798s","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:52.408451Z","caller":"traceutil/trace.go:171","msg":"trace[808703769] transaction","detail":"{read_only:false; response_revision:25029; number_of_response:1; }","duration":"742.141544ms","start":"2026-07-09T10:11:51.666294Z","end":"2026-07-09T10:11:52.408436Z","steps":["trace[808703769] 'process raft request' (duration: 741.819648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:52.408582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.620122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T10:11:52.408631Z","caller":"traceutil/trace.go:171","msg":"trace[558047000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25031; }","duration":"794.713263ms","start":"2026-07-09T10:11:51.613908Z","end":"2026-07-09T10:11:52.408621Z","steps":["trace[558047000] 'agreement among raft nodes before linearized reading' (duration: 794.615102ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:52.408663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.613884Z","time spent":"794.771115ms","remote":"127.0.0.1:44514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-09T10:11:52.408591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.666271Z","time spent":"742.276587ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:52.408857Z","caller":"traceutil/trace.go:171","msg":"trace[834312593] transaction","detail":"{read_only:false; response_revision:25028; number_of_response:1; }","duration":"901.789519ms","start":"2026-07-09T10:11:51.507055Z","end":"2026-07-09T10:11:52.408844Z","steps":["trace[834312593] 'process raft request' (duration: 900.114487ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:52.408467Z","caller":"traceutil/trace.go:171","msg":"trace[1291802452] linearizableReadLoop","detail":"{readStateIndex:25844; appliedIndex:25842; }","duration":"794.406269ms","start":"2026-07-09T10:11:51.61395Z","end":"2026-07-09T10:11:52.408357Z","steps":["trace[1291802452] 'read index received' (duration: 431.009813ms)","trace[1291802452] 'applied index is now lower than readState.Index' (duration: 363.395166ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:52.40892Z","caller":"traceutil/trace.go:171","msg":"trace[405683542] transaction","detail":"{read_only:false; response_revision:25030; number_of_response:1; }","duration":"740.794759ms","start":"2026-07-09T10:11:51.668103Z","end":"2026-07-09T10:11:52.408898Z","steps":["trace[405683542] 'process raft request' (duration: 740.067615ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:52.409248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.507029Z","time spent":"902.119945ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:11:52.409372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.66809Z","time spent":"741.208726ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:11:52.409514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.100546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-09T10:11:52.409549Z","caller":"traceutil/trace.go:171","msg":"trace[774564984] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25031; }","duration":"739.152847ms","start":"2026-07-09T10:11:51.670383Z","end":"2026-07-09T10:11:52.409535Z","steps":["trace[774564984] 'agreement among raft nodes before linearized reading' (duration: 739.030375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:52.409578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.670373Z","time spent":"739.196768ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-09T10:11:52.409673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.992907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-09T10:11:52.409696Z","caller":"traceutil/trace.go:171","msg":"trace[249281346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25031; }","duration":"438.048118ms","start":"2026-07-09T10:11:51.971638Z","end":"2026-07-09T10:11:52.409686Z","steps":["trace[249281346] 'agreement among raft nodes before linearized reading' (duration: 437.994137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:52.40971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.971613Z","time spent":"438.09318ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T10:11:52.409722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.841238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"} {"level":"info","ts":"2026-07-09T10:11:52.409767Z","caller":"traceutil/trace.go:171","msg":"trace[1550126434] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:25031; }","duration":"421.899898ms","start":"2026-07-09T10:11:51.987853Z","end":"2026-07-09T10:11:52.409753Z","steps":["trace[1550126434] 'agreement among raft nodes before linearized reading' (duration: 421.629643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:52.40979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.373862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-09T10:11:52.409808Z","caller":"traceutil/trace.go:171","msg":"trace[1943208192] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25031; }","duration":"441.437203ms","start":"2026-07-09T10:11:51.968363Z","end":"2026-07-09T10:11:52.4098Z","steps":["trace[1943208192] 'agreement among raft nodes before linearized reading' (duration: 441.386762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:52.409809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.987845Z","time spent":"421.954959ms","remote":"127.0.0.1:44664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":1885,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" "} {"level":"warn","ts":"2026-07-09T10:11:52.409822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.968336Z","time spent":"441.482325ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-09T10:11:52.409898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.86042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T10:11:52.409915Z","caller":"traceutil/trace.go:171","msg":"trace[1845134509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25031; }","duration":"442.922541ms","start":"2026-07-09T10:11:51.966988Z","end":"2026-07-09T10:11:52.40991Z","steps":["trace[1845134509] 'agreement among raft nodes before linearized reading' (duration: 442.87408ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:52.409929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:51.966958Z","time spent":"442.967463ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T10:11:52.410017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.173053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-09T10:11:52.410037Z","caller":"traceutil/trace.go:171","msg":"trace[212563385] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25031; }","duration":"274.215924ms","start":"2026-07-09T10:11:52.135814Z","end":"2026-07-09T10:11:52.41003Z","steps":["trace[212563385] 'agreement among raft nodes before linearized reading' (duration: 274.154862ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:56.547706Z","caller":"traceutil/trace.go:171","msg":"trace[688656922] transaction","detail":"{read_only:false; response_revision:25113; number_of_response:1; }","duration":"125.403926ms","start":"2026-07-09T10:11:56.422273Z","end":"2026-07-09T10:11:56.547676Z","steps":["trace[688656922] 'process raft request' (duration: 125.134111ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:56.79485Z","caller":"traceutil/trace.go:171","msg":"trace[1680786274] transaction","detail":"{read_only:false; response_revision:25114; number_of_response:1; }","duration":"369.765778ms","start":"2026-07-09T10:11:56.42505Z","end":"2026-07-09T10:11:56.794815Z","steps":["trace[1680786274] 'process raft request' (duration: 301.907274ms)","trace[1680786274] 'compare' (duration: 67.561727ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:11:56.795036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.425015Z","time spent":"369.93008ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:56.795119Z","caller":"traceutil/trace.go:171","msg":"trace[1915874206] transaction","detail":"{read_only:false; response_revision:25115; number_of_response:1; }","duration":"370.016142ms","start":"2026-07-09T10:11:56.425073Z","end":"2026-07-09T10:11:56.79509Z","steps":["trace[1915874206] 'process raft request' (duration: 369.643045ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:56.795261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.425015Z","time spent":"370.169234ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:56.795823Z","caller":"traceutil/trace.go:171","msg":"trace[856324844] transaction","detail":"{read_only:false; response_revision:25116; number_of_response:1; }","duration":"370.610953ms","start":"2026-07-09T10:11:56.425144Z","end":"2026-07-09T10:11:56.795755Z","steps":["trace[856324844] 'process raft request' (duration: 369.859349ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:56.795842Z","caller":"traceutil/trace.go:171","msg":"trace[982479847] linearizableReadLoop","detail":"{readStateIndex:25934; appliedIndex:25929; }","duration":"360.937357ms","start":"2026-07-09T10:11:56.434873Z","end":"2026-07-09T10:11:56.79581Z","steps":["trace[982479847] 'read index received' (duration: 112.615941ms)","trace[982479847] 'applied index is now lower than readState.Index' (duration: 248.319846ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:56.795997Z","caller":"traceutil/trace.go:171","msg":"trace[1364754217] transaction","detail":"{read_only:false; response_revision:25117; number_of_response:1; }","duration":"370.683074ms","start":"2026-07-09T10:11:56.425298Z","end":"2026-07-09T10:11:56.795981Z","steps":["trace[1364754217] 'process raft request' (duration: 370.365938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:56.796003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.425114Z","time spent":"370.787556ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:56.796048Z","caller":"traceutil/trace.go:171","msg":"trace[230545311] transaction","detail":"{read_only:false; response_revision:25118; number_of_response:1; }","duration":"162.988799ms","start":"2026-07-09T10:11:56.63304Z","end":"2026-07-09T10:11:56.796029Z","steps":["trace[230545311] 'process raft request' (duration: 162.872926ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:56.796115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.425288Z","time spent":"370.743926ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:11:56.79631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.057023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T10:11:56.796334Z","caller":"traceutil/trace.go:171","msg":"trace[626482465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25118; }","duration":"357.109605ms","start":"2026-07-09T10:11:56.439217Z","end":"2026-07-09T10:11:56.796327Z","steps":["trace[626482465] 'agreement among raft nodes before linearized reading' (duration: 357.007603ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:56.796314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.353136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-07-09T10:11:56.796406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.538119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-09T10:11:56.796396Z","caller":"traceutil/trace.go:171","msg":"trace[1025603258] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25118; }","duration":"361.460687ms","start":"2026-07-09T10:11:56.434914Z","end":"2026-07-09T10:11:56.796375Z","steps":["trace[1025603258] 'agreement among raft nodes before linearized reading' (duration: 361.190272ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:56.796426Z","caller":"traceutil/trace.go:171","msg":"trace[1135074375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25118; }","duration":"361.58719ms","start":"2026-07-09T10:11:56.434833Z","end":"2026-07-09T10:11:56.79642Z","steps":["trace[1135074375] 'agreement among raft nodes before linearized reading' (duration: 361.535459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:56.796449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.434822Z","time spent":"361.623821ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T10:11:56.79645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.434908Z","time spent":"361.528639ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-09T10:11:56.796441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.377639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-09T10:11:56.796498Z","caller":"traceutil/trace.go:171","msg":"trace[556499030] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25118; }","duration":"357.4679ms","start":"2026-07-09T10:11:56.439018Z","end":"2026-07-09T10:11:56.796486Z","steps":["trace[556499030] 'agreement among raft nodes before linearized reading' (duration: 357.281967ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:56.796536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.426917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f206db7-c55a-4cad-82d1-d015c483b19c\" ","response":"range_response_count:1 size:3643"} {"level":"warn","ts":"2026-07-09T10:11:56.796538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.439001Z","time spent":"357.521662ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-09T10:11:56.796557Z","caller":"traceutil/trace.go:171","msg":"trace[1849226938] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2f206db7-c55a-4cad-82d1-d015c483b19c; range_end:; response_count:1; response_revision:25118; }","duration":"324.474549ms","start":"2026-07-09T10:11:56.472073Z","end":"2026-07-09T10:11:56.796547Z","steps":["trace[1849226938] 'agreement among raft nodes before linearized reading' (duration: 324.420608ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:56.796574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.472058Z","time spent":"324.512509ms","remote":"127.0.0.1:44694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3666,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f206db7-c55a-4cad-82d1-d015c483b19c\" "} {"level":"warn","ts":"2026-07-09T10:11:56.796353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.439208Z","time spent":"357.140675ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T10:11:56.801161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.494047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-09T10:11:56.801213Z","caller":"traceutil/trace.go:171","msg":"trace[778523844] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25118; }","duration":"362.587189ms","start":"2026-07-09T10:11:56.43861Z","end":"2026-07-09T10:11:56.801197Z","steps":["trace[778523844] 'agreement among raft nodes before linearized reading' (duration: 357.969251ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:56.801252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.438595Z","time spent":"362.65013ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-09T10:11:57.115199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.584501ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:11:57.115409Z","caller":"traceutil/trace.go:171","msg":"trace[358809270] transaction","detail":"{read_only:false; response_revision:25120; number_of_response:1; }","duration":"313.495627ms","start":"2026-07-09T10:11:56.801895Z","end":"2026-07-09T10:11:57.115391Z","steps":["trace[358809270] 'process raft request' (duration: 313.398506ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:57.115504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.801874Z","time spent":"313.566968ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:57.115622Z","caller":"traceutil/trace.go:171","msg":"trace[1607925192] transaction","detail":"{read_only:false; response_revision:25119; number_of_response:1; }","duration":"313.715791ms","start":"2026-07-09T10:11:56.801895Z","end":"2026-07-09T10:11:57.115611Z","steps":["trace[1607925192] 'process raft request' (duration: 151.63835ms)","trace[1607925192] 'compare' (duration: 161.232345ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:11:57.115668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.801871Z","time spent":"313.772132ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:57.172791Z","caller":"traceutil/trace.go:171","msg":"trace[1619517134] linearizableReadLoop","detail":"{readStateIndex:25940; appliedIndex:25937; }","duration":"207.185237ms","start":"2026-07-09T10:11:56.965575Z","end":"2026-07-09T10:11:57.172761Z","steps":["trace[1619517134] 'read index received' (duration: 206.921441ms)","trace[1619517134] 'applied index is now lower than readState.Index' (duration: 262.316µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:11:57.173076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.479952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f206db7-c55a-4cad-82d1-d015c483b19c\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-07-09T10:11:57.173181Z","caller":"traceutil/trace.go:171","msg":"trace[1491275125] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2f206db7-c55a-4cad-82d1-d015c483b19c; range_end:; response_count:1; response_revision:25123; }","duration":"207.639085ms","start":"2026-07-09T10:11:56.965524Z","end":"2026-07-09T10:11:57.173163Z","steps":["trace[1491275125] 'agreement among raft nodes before linearized reading' (duration: 207.34558ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:57.173263Z","caller":"traceutil/trace.go:171","msg":"trace[954618814] transaction","detail":"{read_only:false; response_revision:25121; number_of_response:1; }","duration":"371.260375ms","start":"2026-07-09T10:11:56.801962Z","end":"2026-07-09T10:11:57.173222Z","steps":["trace[954618814] 'process raft request' (duration: 370.565182ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:57.173309Z","caller":"traceutil/trace.go:171","msg":"trace[766026475] transaction","detail":"{read_only:false; response_revision:25122; number_of_response:1; }","duration":"371.268475ms","start":"2026-07-09T10:11:56.80201Z","end":"2026-07-09T10:11:57.173279Z","steps":["trace[766026475] 'process raft request' (duration: 370.655714ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:57.173393Z","caller":"traceutil/trace.go:171","msg":"trace[1435079507] transaction","detail":"{read_only:false; response_revision:25123; number_of_response:1; }","duration":"369.285169ms","start":"2026-07-09T10:11:56.804065Z","end":"2026-07-09T10:11:57.17335Z","steps":["trace[1435079507] 'process raft request' (duration: 368.645927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:11:57.173438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.801979Z","time spent":"371.382628ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:11:57.173442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.801931Z","time spent":"371.425199ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:11:57.173524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:11:56.804045Z","time spent":"369.416821ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:11:57.44107Z","caller":"traceutil/trace.go:171","msg":"trace[1231526957] transaction","detail":"{read_only:false; response_revision:25124; number_of_response:1; }","duration":"258.793647ms","start":"2026-07-09T10:11:57.182241Z","end":"2026-07-09T10:11:57.441035Z","steps":["trace[1231526957] 'process raft request' (duration: 258.606854ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:57.443375Z","caller":"traceutil/trace.go:171","msg":"trace[1651156601] transaction","detail":"{read_only:false; response_revision:25125; number_of_response:1; }","duration":"123.702564ms","start":"2026-07-09T10:11:57.319653Z","end":"2026-07-09T10:11:57.443355Z","steps":["trace[1651156601] 'process raft request' (duration: 123.446909ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:59.442438Z","caller":"traceutil/trace.go:171","msg":"trace[131475452] transaction","detail":"{read_only:false; response_revision:25137; number_of_response:1; }","duration":"227.64501ms","start":"2026-07-09T10:11:59.214759Z","end":"2026-07-09T10:11:59.442404Z","steps":["trace[131475452] 'process raft request' (duration: 131.357561ms)","trace[131475452] 'compare' (duration: 96.141586ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:11:59.473795Z","caller":"traceutil/trace.go:171","msg":"trace[1413666920] transaction","detail":"{read_only:false; response_revision:25138; number_of_response:1; }","duration":"255.563256ms","start":"2026-07-09T10:11:59.218198Z","end":"2026-07-09T10:11:59.473762Z","steps":["trace[1413666920] 'process raft request' (duration: 255.342582ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:59.474099Z","caller":"traceutil/trace.go:171","msg":"trace[1263473986] transaction","detail":"{read_only:false; response_revision:25139; number_of_response:1; }","duration":"255.683637ms","start":"2026-07-09T10:11:59.218403Z","end":"2026-07-09T10:11:59.474087Z","steps":["trace[1263473986] 'process raft request' (duration: 255.311831ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:59.474229Z","caller":"traceutil/trace.go:171","msg":"trace[54574126] transaction","detail":"{read_only:false; response_revision:25141; number_of_response:1; }","duration":"255.738449ms","start":"2026-07-09T10:11:59.218467Z","end":"2026-07-09T10:11:59.474206Z","steps":["trace[54574126] 'process raft request' (duration: 255.664387ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:59.474289Z","caller":"traceutil/trace.go:171","msg":"trace[632090466] transaction","detail":"{read_only:false; response_revision:25142; number_of_response:1; }","duration":"255.784639ms","start":"2026-07-09T10:11:59.218493Z","end":"2026-07-09T10:11:59.474278Z","steps":["trace[632090466] 'process raft request' (duration: 255.676877ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:11:59.474267Z","caller":"traceutil/trace.go:171","msg":"trace[1762608424] transaction","detail":"{read_only:false; response_revision:25140; number_of_response:1; }","duration":"255.81903ms","start":"2026-07-09T10:11:59.218411Z","end":"2026-07-09T10:11:59.47423Z","steps":["trace[1762608424] 'process raft request' (duration: 255.587386ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:03.784479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.942141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T10:12:03.784605Z","caller":"traceutil/trace.go:171","msg":"trace[400606080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25194; }","duration":"171.120004ms","start":"2026-07-09T10:12:03.613447Z","end":"2026-07-09T10:12:03.784567Z","steps":["trace[400606080] 'range keys from in-memory index tree' (duration: 170.859009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:09.104312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.677865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-07-09T10:12:09.104382Z","caller":"traceutil/trace.go:171","msg":"trace[2119048871] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:25238; }","duration":"121.798858ms","start":"2026-07-09T10:12:08.982567Z","end":"2026-07-09T10:12:09.104366Z","steps":["trace[2119048871] 'range keys from in-memory index tree' (duration: 121.534483ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:09.303882Z","caller":"traceutil/trace.go:171","msg":"trace[550834323] transaction","detail":"{read_only:false; response_revision:25239; number_of_response:1; }","duration":"185.506791ms","start":"2026-07-09T10:12:09.118355Z","end":"2026-07-09T10:12:09.303862Z","steps":["trace[550834323] 'process raft request' (duration: 89.550359ms)","trace[550834323] 'compare' (duration: 95.635797ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:09.675597Z","caller":"traceutil/trace.go:171","msg":"trace[786959568] transaction","detail":"{read_only:false; response_revision:25240; number_of_response:1; }","duration":"162.335746ms","start":"2026-07-09T10:12:09.513241Z","end":"2026-07-09T10:12:09.675577Z","steps":["trace[786959568] 'process raft request' (duration: 162.204763ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:09.675734Z","caller":"traceutil/trace.go:171","msg":"trace[1416125685] linearizableReadLoop","detail":"{readStateIndex:26061; appliedIndex:26060; }","duration":"154.190619ms","start":"2026-07-09T10:12:09.521535Z","end":"2026-07-09T10:12:09.675725Z","steps":["trace[1416125685] 'read index received' (duration: 153.844523ms)","trace[1416125685] 'applied index is now lower than readState.Index' (duration: 344.716µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:12:09.67587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.321863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-09T10:12:09.675895Z","caller":"traceutil/trace.go:171","msg":"trace[1837625024] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25240; }","duration":"154.388704ms","start":"2026-07-09T10:12:09.521498Z","end":"2026-07-09T10:12:09.675887Z","steps":["trace[1837625024] 'agreement among raft nodes before linearized reading' (duration: 154.289862ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:09.676082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.919705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-09T10:12:09.676142Z","caller":"traceutil/trace.go:171","msg":"trace[1865645928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25240; }","duration":"154.004526ms","start":"2026-07-09T10:12:09.522125Z","end":"2026-07-09T10:12:09.676129Z","steps":["trace[1865645928] 'agreement among raft nodes before linearized reading' (duration: 153.834083ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:09.676145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.816967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-09T10:12:09.676181Z","caller":"traceutil/trace.go:171","msg":"trace[1346006329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25240; }","duration":"148.95729ms","start":"2026-07-09T10:12:09.527214Z","end":"2026-07-09T10:12:09.676171Z","steps":["trace[1346006329] 'agreement among raft nodes before linearized reading' (duration: 148.858398ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:09.676234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.596069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-09T10:12:09.676262Z","caller":"traceutil/trace.go:171","msg":"trace[317090555] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25240; }","duration":"152.63976ms","start":"2026-07-09T10:12:09.523615Z","end":"2026-07-09T10:12:09.676255Z","steps":["trace[317090555] 'agreement among raft nodes before linearized reading' (duration: 152.582299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:09.676289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.3295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:217"} {"level":"info","ts":"2026-07-09T10:12:09.676314Z","caller":"traceutil/trace.go:171","msg":"trace[1334084393] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:25240; }","duration":"145.37237ms","start":"2026-07-09T10:12:09.530935Z","end":"2026-07-09T10:12:09.676308Z","steps":["trace[1334084393] 'agreement among raft nodes before linearized reading' (duration: 145.307909ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:09.676499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.101103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T10:12:09.676574Z","caller":"traceutil/trace.go:171","msg":"trace[829857607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25240; }","duration":"149.190404ms","start":"2026-07-09T10:12:09.527378Z","end":"2026-07-09T10:12:09.676569Z","steps":["trace[829857607] 'agreement among raft nodes before linearized reading' (duration: 149.082652ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:16.225252Z","caller":"traceutil/trace.go:171","msg":"trace[1388358631] transaction","detail":"{read_only:false; response_revision:25291; number_of_response:1; }","duration":"110.384658ms","start":"2026-07-09T10:12:16.114838Z","end":"2026-07-09T10:12:16.225223Z","steps":["trace[1388358631] 'process raft request' (duration: 110.205685ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:19.984598Z","caller":"traceutil/trace.go:171","msg":"trace[999664664] transaction","detail":"{read_only:false; response_revision:25321; number_of_response:1; }","duration":"149.847866ms","start":"2026-07-09T10:12:19.834587Z","end":"2026-07-09T10:12:19.984435Z","steps":["trace[999664664] 'process raft request' (duration: 70.81178ms)","trace[999664664] 'compare' (duration: 78.805102ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:12:22.041838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.285818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:12:22.04209Z","caller":"traceutil/trace.go:171","msg":"trace[306288955] linearizableReadLoop","detail":"{readStateIndex:26161; appliedIndex:26160; }","duration":"204.504565ms","start":"2026-07-09T10:12:21.837552Z","end":"2026-07-09T10:12:22.042057Z","steps":["trace[306288955] 'read index received' (duration: 58.910551ms)","trace[306288955] 'applied index is now lower than readState.Index' (duration: 145.591564ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:22.042254Z","caller":"traceutil/trace.go:171","msg":"trace[1456189670] transaction","detail":"{read_only:false; response_revision:25338; number_of_response:1; }","duration":"204.738799ms","start":"2026-07-09T10:12:21.837476Z","end":"2026-07-09T10:12:22.042215Z","steps":["trace[1456189670] 'process raft request' (duration: 58.974451ms)","trace[1456189670] 'compare' (duration: 144.707758ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:22.042275Z","caller":"traceutil/trace.go:171","msg":"trace[561975736] transaction","detail":"{read_only:false; response_revision:25340; number_of_response:1; }","duration":"203.573268ms","start":"2026-07-09T10:12:21.838641Z","end":"2026-07-09T10:12:22.042214Z","steps":["trace[561975736] 'process raft request' (duration: 203.408515ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:22.042276Z","caller":"traceutil/trace.go:171","msg":"trace[1992129101] transaction","detail":"{read_only:false; response_revision:25339; number_of_response:1; }","duration":"203.750601ms","start":"2026-07-09T10:12:21.838456Z","end":"2026-07-09T10:12:22.042206Z","steps":["trace[1992129101] 'process raft request' (duration: 203.511667ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:22.042435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.852372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1446"} {"level":"info","ts":"2026-07-09T10:12:22.042482Z","caller":"traceutil/trace.go:171","msg":"trace[1328999881] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25340; }","duration":"204.953984ms","start":"2026-07-09T10:12:21.837512Z","end":"2026-07-09T10:12:22.042466Z","steps":["trace[1328999881] 'agreement among raft nodes before linearized reading' (duration: 204.75062ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:27.923529Z","caller":"traceutil/trace.go:171","msg":"trace[939712549] linearizableReadLoop","detail":"{readStateIndex:26210; appliedIndex:26209; }","duration":"115.972046ms","start":"2026-07-09T10:12:27.807527Z","end":"2026-07-09T10:12:27.923499Z","steps":["trace[939712549] 'read index received' (duration: 115.737702ms)","trace[939712549] 'applied index is now lower than readState.Index' (duration: 233.314µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:27.923673Z","caller":"traceutil/trace.go:171","msg":"trace[1785421511] transaction","detail":"{read_only:false; response_revision:25385; number_of_response:1; }","duration":"182.36078ms","start":"2026-07-09T10:12:27.741302Z","end":"2026-07-09T10:12:27.923662Z","steps":["trace[1785421511] 'process raft request' (duration: 181.994183ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:27.923872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.64332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T10:12:27.923965Z","caller":"traceutil/trace.go:171","msg":"trace[234784030] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:25385; }","duration":"115.825963ms","start":"2026-07-09T10:12:27.808114Z","end":"2026-07-09T10:12:27.92394Z","steps":["trace[234784030] 'agreement among raft nodes before linearized reading' (duration: 115.67072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:27.924147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.582158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-09T10:12:27.924182Z","caller":"traceutil/trace.go:171","msg":"trace[1501125566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25385; }","duration":"116.695131ms","start":"2026-07-09T10:12:27.807477Z","end":"2026-07-09T10:12:27.924173Z","steps":["trace[1501125566] 'agreement among raft nodes before linearized reading' (duration: 116.529137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:28.22717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.9046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-09T10:12:28.22723Z","caller":"traceutil/trace.go:171","msg":"trace[718992130] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25386; }","duration":"159.015351ms","start":"2026-07-09T10:12:28.0682Z","end":"2026-07-09T10:12:28.227215Z","steps":["trace[718992130] 'range keys from in-memory index tree' (duration: 158.759376ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:28.227237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.994192ms","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-07-09T10:12:28.22727Z","caller":"traceutil/trace.go:171","msg":"trace[413436675] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25386; }","duration":"159.060092ms","start":"2026-07-09T10:12:28.0682Z","end":"2026-07-09T10:12:28.22726Z","steps":["trace[413436675] 'range keys from in-memory index tree' (duration: 158.880799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:28.227245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.789425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-09T10:12:28.227322Z","caller":"traceutil/trace.go:171","msg":"trace[2020839602] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25386; }","duration":"186.939308ms","start":"2026-07-09T10:12:28.040367Z","end":"2026-07-09T10:12:28.227307Z","steps":["trace[2020839602] 'range keys from in-memory index tree' (duration: 186.608701ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:28.22747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.162994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T10:12:28.22755Z","caller":"traceutil/trace.go:171","msg":"trace[1341542545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25386; }","duration":"159.269646ms","start":"2026-07-09T10:12:28.068259Z","end":"2026-07-09T10:12:28.227528Z","steps":["trace[1341542545] 'range keys from in-memory index tree' (duration: 158.973031ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:42.208226Z","caller":"traceutil/trace.go:171","msg":"trace[1499868555] linearizableReadLoop","detail":"{readStateIndex:26316; appliedIndex:26315; }","duration":"155.686648ms","start":"2026-07-09T10:12:42.052521Z","end":"2026-07-09T10:12:42.208208Z","steps":["trace[1499868555] 'read index received' (duration: 155.516025ms)","trace[1499868555] 'applied index is now lower than readState.Index' (duration: 169.573µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:42.208279Z","caller":"traceutil/trace.go:171","msg":"trace[1324243886] transaction","detail":"{read_only:false; response_revision:25488; number_of_response:1; }","duration":"198.749525ms","start":"2026-07-09T10:12:42.009499Z","end":"2026-07-09T10:12:42.208249Z","steps":["trace[1324243886] 'process raft request' (duration: 198.583742ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:42.208381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.846722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-09T10:12:42.208412Z","caller":"traceutil/trace.go:171","msg":"trace[1082072766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25488; }","duration":"155.937594ms","start":"2026-07-09T10:12:42.052467Z","end":"2026-07-09T10:12:42.208404Z","steps":["trace[1082072766] 'agreement among raft nodes before linearized reading' (duration: 155.814252ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:42.424752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.247204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:12:42.42486Z","caller":"traceutil/trace.go:171","msg":"trace[2011787733] linearizableReadLoop","detail":"{readStateIndex:26317; appliedIndex:26316; }","duration":"132.772848ms","start":"2026-07-09T10:12:42.292072Z","end":"2026-07-09T10:12:42.424845Z","steps":["trace[2011787733] 'read index received' (duration: 21.36352ms)","trace[2011787733] 'applied index is now lower than readState.Index' (duration: 111.408028ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:12:42.425036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.785738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T10:12:42.425073Z","caller":"traceutil/trace.go:171","msg":"trace[662420204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25489; }","duration":"109.837669ms","start":"2026-07-09T10:12:42.315225Z","end":"2026-07-09T10:12:42.425062Z","steps":["trace[662420204] 'agreement among raft nodes before linearized reading' (duration: 109.700005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:42.425073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.990753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11795"} {"level":"info","ts":"2026-07-09T10:12:42.42513Z","caller":"traceutil/trace.go:171","msg":"trace[1741648827] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25489; }","duration":"133.080734ms","start":"2026-07-09T10:12:42.292034Z","end":"2026-07-09T10:12:42.425115Z","steps":["trace[1741648827] 'agreement among raft nodes before linearized reading' (duration: 132.892759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:42.425143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.499704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-09T10:12:42.425223Z","caller":"traceutil/trace.go:171","msg":"trace[684475683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25489; }","duration":"106.602085ms","start":"2026-07-09T10:12:42.318602Z","end":"2026-07-09T10:12:42.425204Z","steps":["trace[684475683] 'agreement among raft nodes before linearized reading' (duration: 106.366081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:42.425298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.453813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-09T10:12:42.425333Z","caller":"traceutil/trace.go:171","msg":"trace[1998033893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25489; }","duration":"107.498964ms","start":"2026-07-09T10:12:42.317825Z","end":"2026-07-09T10:12:42.425324Z","steps":["trace[1998033893] 'agreement among raft nodes before linearized reading' (duration: 107.413412ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:42.425356Z","caller":"traceutil/trace.go:171","msg":"trace[1837501188] transaction","detail":"{read_only:false; response_revision:25489; number_of_response:1; }","duration":"213.392277ms","start":"2026-07-09T10:12:42.21195Z","end":"2026-07-09T10:12:42.425343Z","steps":["trace[1837501188] 'process raft request' (duration: 101.479799ms)","trace[1837501188] 'compare' (duration: 111.150923ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:12:42.425452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.968962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-09T10:12:42.425484Z","caller":"traceutil/trace.go:171","msg":"trace[2062222590] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25489; }","duration":"108.014382ms","start":"2026-07-09T10:12:42.317463Z","end":"2026-07-09T10:12:42.425477Z","steps":["trace[2062222590] 'agreement among raft nodes before linearized reading' (duration: 107.937331ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:46.651419Z","caller":"traceutil/trace.go:171","msg":"trace[2124865625] linearizableReadLoop","detail":"{readStateIndex:26359; appliedIndex:26358; }","duration":"179.980784ms","start":"2026-07-09T10:12:46.471411Z","end":"2026-07-09T10:12:46.651392Z","steps":["trace[2124865625] 'read index received' (duration: 179.806991ms)","trace[2124865625] 'applied index is now lower than readState.Index' (duration: 172.523µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:46.651567Z","caller":"traceutil/trace.go:171","msg":"trace[1244769615] transaction","detail":"{read_only:false; response_revision:25530; number_of_response:1; }","duration":"187.319025ms","start":"2026-07-09T10:12:46.464205Z","end":"2026-07-09T10:12:46.651524Z","steps":["trace[1244769615] 'process raft request' (duration: 186.993779ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:46.651696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.270889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-09T10:12:46.651757Z","caller":"traceutil/trace.go:171","msg":"trace[1361461655] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25530; }","duration":"180.369941ms","start":"2026-07-09T10:12:46.471371Z","end":"2026-07-09T10:12:46.651741Z","steps":["trace[1361461655] 'agreement among raft nodes before linearized reading' (duration: 180.164548ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:46.67844Z","caller":"traceutil/trace.go:171","msg":"trace[1673759434] transaction","detail":"{read_only:false; response_revision:25531; number_of_response:1; }","duration":"194.88925ms","start":"2026-07-09T10:12:46.483526Z","end":"2026-07-09T10:12:46.678416Z","steps":["trace[1673759434] 'process raft request' (duration: 194.722657ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:46.678557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.769369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-09T10:12:46.678616Z","caller":"traceutil/trace.go:171","msg":"trace[796294938] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25531; }","duration":"205.840721ms","start":"2026-07-09T10:12:46.472762Z","end":"2026-07-09T10:12:46.678603Z","steps":["trace[796294938] 'agreement among raft nodes before linearized reading' (duration: 205.729438ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:46.678461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.932743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-09T10:12:46.678746Z","caller":"traceutil/trace.go:171","msg":"trace[1532845374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25531; }","duration":"206.26138ms","start":"2026-07-09T10:12:46.472462Z","end":"2026-07-09T10:12:46.678723Z","steps":["trace[1532845374] 'agreement among raft nodes before linearized reading' (duration: 205.873592ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:46.816393Z","caller":"traceutil/trace.go:171","msg":"trace[787253414] transaction","detail":"{read_only:false; response_revision:25533; number_of_response:1; }","duration":"134.230736ms","start":"2026-07-09T10:12:46.682134Z","end":"2026-07-09T10:12:46.816365Z","steps":["trace[787253414] 'process raft request' (duration: 134.129894ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:46.81646Z","caller":"traceutil/trace.go:171","msg":"trace[1866013759] transaction","detail":"{read_only:false; response_revision:25532; number_of_response:1; }","duration":"160.687054ms","start":"2026-07-09T10:12:46.655726Z","end":"2026-07-09T10:12:46.816413Z","steps":["trace[1866013759] 'process raft request' (duration: 89.921446ms)","trace[1866013759] 'compare' (duration: 70.454692ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:46.8166Z","caller":"traceutil/trace.go:171","msg":"trace[779323045] linearizableReadLoop","detail":"{readStateIndex:26361; appliedIndex:26360; }","duration":"137.05785ms","start":"2026-07-09T10:12:46.679514Z","end":"2026-07-09T10:12:46.816572Z","steps":["trace[779323045] 'read index received' (duration: 66.241601ms)","trace[779323045] 'applied index is now lower than readState.Index' (duration: 70.814109ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:46.816639Z","caller":"traceutil/trace.go:171","msg":"trace[1596520432] transaction","detail":"{read_only:false; response_revision:25534; number_of_response:1; }","duration":"134.452591ms","start":"2026-07-09T10:12:46.682157Z","end":"2026-07-09T10:12:46.816609Z","steps":["trace[1596520432] 'process raft request' (duration: 134.160905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:46.816782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.259574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T10:12:46.816904Z","caller":"traceutil/trace.go:171","msg":"trace[1168693466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25534; }","duration":"137.422087ms","start":"2026-07-09T10:12:46.679465Z","end":"2026-07-09T10:12:46.816887Z","steps":["trace[1168693466] 'agreement among raft nodes before linearized reading' (duration: 137.235453ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:52.496267Z","caller":"traceutil/trace.go:171","msg":"trace[879220996] linearizableReadLoop","detail":"{readStateIndex:26403; appliedIndex:26402; }","duration":"230.173478ms","start":"2026-07-09T10:12:52.266071Z","end":"2026-07-09T10:12:52.496245Z","steps":["trace[879220996] 'read index received' (duration: 229.958383ms)","trace[879220996] 'applied index is now lower than readState.Index' (duration: 214.325µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:52.496359Z","caller":"traceutil/trace.go:171","msg":"trace[2098563408] transaction","detail":"{read_only:false; response_revision:25573; number_of_response:1; }","duration":"248.376648ms","start":"2026-07-09T10:12:52.247965Z","end":"2026-07-09T10:12:52.496342Z","steps":["trace[2098563408] 'process raft request' (duration: 248.133762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:52.496451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.364642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T10:12:52.496486Z","caller":"traceutil/trace.go:171","msg":"trace[1487194819] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:25573; }","duration":"230.456273ms","start":"2026-07-09T10:12:52.266016Z","end":"2026-07-09T10:12:52.496472Z","steps":["trace[1487194819] 'agreement among raft nodes before linearized reading' (duration: 230.332721ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:52.632253Z","caller":"traceutil/trace.go:171","msg":"trace[558263597] transaction","detail":"{read_only:false; response_revision:25574; number_of_response:1; }","duration":"132.086336ms","start":"2026-07-09T10:12:52.500115Z","end":"2026-07-09T10:12:52.632202Z","steps":["trace[558263597] 'process raft request' (duration: 131.877932ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:52.88631Z","caller":"traceutil/trace.go:171","msg":"trace[1191793879] transaction","detail":"{read_only:false; response_revision:25575; number_of_response:1; }","duration":"208.036343ms","start":"2026-07-09T10:12:52.678244Z","end":"2026-07-09T10:12:52.88628Z","steps":["trace[1191793879] 'process raft request' (duration: 141.838753ms)","trace[1191793879] 'compare' (duration: 66.061507ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:52.887544Z","caller":"traceutil/trace.go:171","msg":"trace[1578050777] transaction","detail":"{read_only:false; response_revision:25576; number_of_response:1; }","duration":"191.354493ms","start":"2026-07-09T10:12:52.696128Z","end":"2026-07-09T10:12:52.887483Z","steps":["trace[1578050777] 'process raft request' (duration: 191.142939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:53.281876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.357002ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-09T10:12:53.282085Z","caller":"traceutil/trace.go:171","msg":"trace[317423807] transaction","detail":"{read_only:false; response_revision:25578; number_of_response:1; }","duration":"390.518086ms","start":"2026-07-09T10:12:52.891549Z","end":"2026-07-09T10:12:53.282067Z","steps":["trace[317423807] 'process raft request' (duration: 390.438954ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:53.282174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:52.891527Z","time spent":"390.598377ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:12:53.282324Z","caller":"traceutil/trace.go:171","msg":"trace[1010405832] linearizableReadLoop","detail":"{readStateIndex:26407; appliedIndex:26406; }","duration":"394.875959ms","start":"2026-07-09T10:12:52.887411Z","end":"2026-07-09T10:12:53.282287Z","steps":["trace[1010405832] 'read index received' (duration: 101.959357ms)","trace[1010405832] 'applied index is now lower than readState.Index' (duration: 292.914032ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:53.282448Z","caller":"traceutil/trace.go:171","msg":"trace[382309679] transaction","detail":"{read_only:false; response_revision:25577; number_of_response:1; }","duration":"397.806476ms","start":"2026-07-09T10:12:52.884626Z","end":"2026-07-09T10:12:53.282433Z","steps":["trace[382309679] 'process raft request' (duration: 104.770492ms)","trace[382309679] 'compare' (duration: 292.162086ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:12:53.282564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:52.88459Z","time spent":"397.893796ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:12:53.282792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.669816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-07-09T10:12:53.282803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.179395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-09T10:12:53.282836Z","caller":"traceutil/trace.go:171","msg":"trace[1700355004] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25578; }","duration":"443.252067ms","start":"2026-07-09T10:12:52.839574Z","end":"2026-07-09T10:12:53.282826Z","steps":["trace[1700355004] 'agreement among raft nodes before linearized reading' (duration: 443.128115ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:53.282834Z","caller":"traceutil/trace.go:171","msg":"trace[905723019] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25578; }","duration":"442.728718ms","start":"2026-07-09T10:12:52.840093Z","end":"2026-07-09T10:12:53.282822Z","steps":["trace[905723019] 'agreement among raft nodes before linearized reading' (duration: 442.580205ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:53.28286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:52.839554Z","time spent":"443.299778ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-09T10:12:53.282867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:52.840085Z","time spent":"442.773028ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-09T10:12:53.604541Z","caller":"traceutil/trace.go:171","msg":"trace[432500373] transaction","detail":"{read_only:false; response_revision:25579; number_of_response:1; }","duration":"612.677179ms","start":"2026-07-09T10:12:52.991837Z","end":"2026-07-09T10:12:53.604514Z","steps":["trace[432500373] 'process raft request' (duration: 579.706636ms)","trace[432500373] 'compare' (duration: 32.583255ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:53.604565Z","caller":"traceutil/trace.go:171","msg":"trace[1263789099] transaction","detail":"{read_only:false; response_revision:25580; number_of_response:1; }","duration":"612.587358ms","start":"2026-07-09T10:12:52.991925Z","end":"2026-07-09T10:12:53.604512Z","steps":["trace[1263789099] 'process raft request' (duration: 612.462165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:53.604663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:52.991796Z","time spent":"612.803371ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:12:53.604714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:52.991885Z","time spent":"612.74131ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:12:53.604714Z","caller":"traceutil/trace.go:171","msg":"trace[782484049] transaction","detail":"{read_only:false; response_revision:25581; number_of_response:1; }","duration":"612.435524ms","start":"2026-07-09T10:12:52.992261Z","end":"2026-07-09T10:12:53.604696Z","steps":["trace[782484049] 'process raft request' (duration: 612.21359ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:53.604808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:52.992248Z","time spent":"612.518526ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T10:12:53.604879Z","caller":"traceutil/trace.go:171","msg":"trace[1755214505] linearizableReadLoop","detail":"{readStateIndex:26413; appliedIndex:26408; }","duration":"322.471369ms","start":"2026-07-09T10:12:53.282391Z","end":"2026-07-09T10:12:53.604862Z","steps":["trace[1755214505] 'read index received' (duration: 289.13989ms)","trace[1755214505] 'applied index is now lower than readState.Index' (duration: 33.330509ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T10:12:53.605021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.133094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-09T10:12:53.605062Z","caller":"traceutil/trace.go:171","msg":"trace[429536046] transaction","detail":"{read_only:false; response_revision:25582; number_of_response:1; }","duration":"591.159208ms","start":"2026-07-09T10:12:53.01389Z","end":"2026-07-09T10:12:53.605049Z","steps":["trace[429536046] 'process raft request' (duration: 590.721698ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:53.60507Z","caller":"traceutil/trace.go:171","msg":"trace[48797120] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:25583; }","duration":"619.236646ms","start":"2026-07-09T10:12:52.985822Z","end":"2026-07-09T10:12:53.605058Z","steps":["trace[48797120] 'agreement among raft nodes before linearized reading' (duration: 619.110552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:53.605104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:52.985799Z","time spent":"619.295357ms","remote":"127.0.0.1:41112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"info","ts":"2026-07-09T10:12:53.60511Z","caller":"traceutil/trace.go:171","msg":"trace[1495149856] transaction","detail":"{read_only:false; response_revision:25583; number_of_response:1; }","duration":"591.162487ms","start":"2026-07-09T10:12:53.013919Z","end":"2026-07-09T10:12:53.605082Z","steps":["trace[1495149856] 'process raft request' (duration: 590.881361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:53.605128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:53.013862Z","time spent":"591.229988ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:12:53.605245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:53.01388Z","time spent":"591.2874ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:12:53.60525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.298123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-07-09T10:12:53.605356Z","caller":"traceutil/trace.go:171","msg":"trace[422173170] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:25583; }","duration":"612.438966ms","start":"2026-07-09T10:12:52.992883Z","end":"2026-07-09T10:12:53.605322Z","steps":["trace[422173170] 'agreement among raft nodes before linearized reading' (duration: 612.211671ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:53.605395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:52.992867Z","time spent":"612.518267ms","remote":"127.0.0.1:44664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1881,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "} {"level":"info","ts":"2026-07-09T10:12:53.823222Z","caller":"traceutil/trace.go:171","msg":"trace[1252256793] transaction","detail":"{read_only:false; response_revision:25584; number_of_response:1; }","duration":"536.328024ms","start":"2026-07-09T10:12:53.286838Z","end":"2026-07-09T10:12:53.823166Z","steps":["trace[1252256793] 'process raft request' (duration: 476.248681ms)","trace[1252256793] 'compare' (duration: 59.661265ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:53.823334Z","caller":"traceutil/trace.go:171","msg":"trace[1714508714] linearizableReadLoop","detail":"{readStateIndex:26415; appliedIndex:26413; }","duration":"214.621569ms","start":"2026-07-09T10:12:53.608659Z","end":"2026-07-09T10:12:53.82328Z","steps":["trace[1714508714] 'read index received' (duration: 154.442764ms)","trace[1714508714] 'applied index is now lower than readState.Index' (duration: 60.177715ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T10:12:53.823469Z","caller":"traceutil/trace.go:171","msg":"trace[562478676] transaction","detail":"{read_only:false; response_revision:25585; number_of_response:1; }","duration":"536.251833ms","start":"2026-07-09T10:12:53.287204Z","end":"2026-07-09T10:12:53.823456Z","steps":["trace[562478676] 'process raft request' (duration: 535.857854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T10:12:53.823454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:53.286822Z","time spent":"536.508297ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:12:53.823633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T10:12:53.287189Z","time spent":"536.327635ms","remote":"127.0.0.1:44776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T10:12:53.82385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.17029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2c3bd248-2176-4836-85a8-053cf6569e23\" ","response":"range_response_count:1 size:1319"} {"level":"info","ts":"2026-07-09T10:12:53.823978Z","caller":"traceutil/trace.go:171","msg":"trace[444754351] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2c3bd248-2176-4836-85a8-053cf6569e23; range_end:; response_count:1; response_revision:25585; }","duration":"215.328724ms","start":"2026-07-09T10:12:53.608616Z","end":"2026-07-09T10:12:53.823945Z","steps":["trace[444754351] 'agreement among raft nodes before linearized reading' (duration: 214.841395ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:53.833143Z","caller":"traceutil/trace.go:171","msg":"trace[1926802167] transaction","detail":"{read_only:false; response_revision:25586; number_of_response:1; }","duration":"196.945239ms","start":"2026-07-09T10:12:53.63617Z","end":"2026-07-09T10:12:53.833115Z","steps":["trace[1926802167] 'process raft request' (duration: 196.761246ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T10:12:56.532221Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006741.wal"} {"level":"info","ts":"2026-07-09T10:13:56.39179Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23292} {"level":"info","ts":"2026-07-09T10:13:56.521038Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23292,"took":"124.546841ms","hash":3851335036,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":36020224,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-07-09T10:13:56.521123Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3851335036,"revision":23292,"compact-revision":20190} {"level":"info","ts":"2026-07-09T10:18:56.398222Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26238} {"level":"info","ts":"2026-07-09T10:18:56.534798Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26238,"took":"132.180155ms","hash":3795146907,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":34795520,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-07-09T10:18:56.534934Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3795146907,"revision":26238,"compact-revision":23292} {"level":"info","ts":"2026-07-09T10:19:19.039715Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6d0358acb671c233","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-09T10:19:19.045155Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-09T10:19:19.045286Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-09T10:23:56.403635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28912} {"level":"info","ts":"2026-07-09T10:23:56.542408Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28912,"took":"134.815715ms","hash":3925862840,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":31367168,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-09T10:23:56.542496Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3925862840,"revision":28912,"compact-revision":26238} {"level":"info","ts":"2026-07-09T10:28:56.412709Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31136} {"level":"info","ts":"2026-07-09T10:28:56.538441Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31136,"took":"121.293987ms","hash":351904314,"current-db-size-bytes":58331136,"current-db-size":"58 MB","current-db-size-in-use-bytes":31428608,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-09T10:28:56.538491Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":351904314,"revision":31136,"compact-revision":28912} {"level":"info","ts":"2026-07-09T10:33:56.422164Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33399} {"level":"info","ts":"2026-07-09T10:33:56.569395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33399,"took":"141.193259ms","hash":3446668466,"current-db-size-bytes":59375616,"current-db-size":"59 MB","current-db-size-in-use-bytes":32358400,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-09T10:33:56.569472Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3446668466,"revision":33399,"compact-revision":31136} {"level":"info","ts":"2026-07-09T10:38:56.428034Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35697} {"level":"info","ts":"2026-07-09T10:38:56.56841Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35697,"took":"134.391062ms","hash":2660624842,"current-db-size-bytes":59375616,"current-db-size":"59 MB","current-db-size-in-use-bytes":31391744,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-09T10:38:56.568469Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2660624842,"revision":35697,"compact-revision":33399} {"level":"info","ts":"2026-07-09T10:40:43.626284Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6d0358acb671c233","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-09T10:40:43.631006Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-07-09T10:40:43.631116Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-07-09T10:43:56.435529Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37924} {"level":"info","ts":"2026-07-09T10:43:56.54839Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37924,"took":"108.686834ms","hash":792881967,"current-db-size-bytes":59375616,"current-db-size":"59 MB","current-db-size-in-use-bytes":31797248,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-09T10:43:56.548451Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":792881967,"revision":37924,"compact-revision":35697}