{"level":"warn","ts":"2026-06-23T18:44:31.887405Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T18:44:31.887483Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.191: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.191:2380","--initial-cluster=instance=https://199.19.213.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.191:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-23T18:44:31.887542Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T18:44:31.887552Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-06-23T18:44:31.887578Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T18:44:31.888424Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"]} {"level":"info","ts":"2026-06-23T18:44:31.888498Z","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.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.191:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-23T18:44:31.892047Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.548664ms"} {"level":"info","ts":"2026-06-23T18:44:31.897076Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e892d50a3a4fc0f4","cluster-id":"21eccdda20ff4e92"} {"level":"info","ts":"2026-06-23T18:44:31.897237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=()"} {"level":"info","ts":"2026-06-23T18:44:31.897279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 0"} {"level":"info","ts":"2026-06-23T18:44:31.897302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e892d50a3a4fc0f4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-23T18:44:31.897321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 1"} {"level":"info","ts":"2026-06-23T18:44:31.897381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"warn","ts":"2026-06-23T18:44:31.902197Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-23T18:44:31.903736Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-23T18:44:31.905023Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-23T18:44:31.908417Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e892d50a3a4fc0f4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-23T18:44:31.908524Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T18:44:31.908601Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T18:44:31.908612Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T18:44:31.908934Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e892d50a3a4fc0f4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-23T18:44:31.90955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"info","ts":"2026-06-23T18:44:31.909649Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","added-peer-id":"e892d50a3a4fc0f4","added-peer-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-06-23T18:44:31.918053Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T18:44:31.918206Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-06-23T18:44:31.918253Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-06-23T18:44:31.918412Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e892d50a3a4fc0f4","initial-advertise-peer-urls":["https://199.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-23T18:44:31.918474Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-23T18:44:32.400871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 is starting a new election at term 1"} {"level":"info","ts":"2026-06-23T18:44:32.400947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-23T18:44:32.400965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgPreVoteResp from e892d50a3a4fc0f4 at term 1"} {"level":"info","ts":"2026-06-23T18:44:32.400976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became candidate at term 2"} {"level":"info","ts":"2026-06-23T18:44:32.400982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgVoteResp from e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-06-23T18:44:32.400991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became leader at term 2"} {"level":"info","ts":"2026-06-23T18:44:32.400999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e892d50a3a4fc0f4 elected leader e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-06-23T18:44:32.40902Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:44:32.417126Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e892d50a3a4fc0f4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.191:2379]}","request-path":"/0/members/e892d50a3a4fc0f4/attributes","cluster-id":"21eccdda20ff4e92","publish-timeout":"7s"} {"level":"info","ts":"2026-06-23T18:44:32.417141Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T18:44:32.417187Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T18:44:32.417868Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:44:32.418011Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:44:32.418045Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:44:32.418155Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-23T18:44:32.418181Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-23T18:44:32.420549Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.191:2379"} {"level":"info","ts":"2026-06-23T18:44:32.42055Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-23T18:44:46.311897Z","caller":"traceutil/trace.go:171","msg":"trace[1778229831] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"123.827657ms","start":"2026-06-23T18:44:46.188017Z","end":"2026-06-23T18:44:46.311844Z","steps":["trace[1778229831] 'process raft request' (duration: 115.352871ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:15.505264Z","caller":"traceutil/trace.go:171","msg":"trace[2143051598] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"142.66338ms","start":"2026-06-23T18:45:15.362574Z","end":"2026-06-23T18:45:15.505237Z","steps":["trace[2143051598] 'process raft request' (duration: 142.503736ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:15.676485Z","caller":"traceutil/trace.go:171","msg":"trace[1760602195] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"206.503018ms","start":"2026-06-23T18:45:15.469955Z","end":"2026-06-23T18:45:15.676458Z","steps":["trace[1760602195] 'read index received' (duration: 35.402001ms)","trace[1760602195] 'applied index is now lower than readState.Index' (duration: 171.099147ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:15.676663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.689123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.191\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-23T18:45:15.676747Z","caller":"traceutil/trace.go:171","msg":"trace[57345601] range","detail":"{range_begin:/registry/masterleases/199.19.213.191; range_end:; response_count:1; response_revision:637; }","duration":"206.827777ms","start":"2026-06-23T18:45:15.469907Z","end":"2026-06-23T18:45:15.676735Z","steps":["trace[57345601] 'agreement among raft nodes before linearized reading' (duration: 206.685813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:15.677004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.784299ms","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-06-23T18:45:15.677134Z","caller":"traceutil/trace.go:171","msg":"trace[1296034902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"163.917382ms","start":"2026-06-23T18:45:15.51316Z","end":"2026-06-23T18:45:15.677078Z","steps":["trace[1296034902] 'agreement among raft nodes before linearized reading' (duration: 163.594493ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:15.676632Z","caller":"traceutil/trace.go:171","msg":"trace[1822412751] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"243.857336ms","start":"2026-06-23T18:45:15.432726Z","end":"2026-06-23T18:45:15.676583Z","steps":["trace[1822412751] 'process raft request' (duration: 234.240753ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:15.887874Z","caller":"traceutil/trace.go:171","msg":"trace[808676290] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"145.830949ms","start":"2026-06-23T18:45:15.742015Z","end":"2026-06-23T18:45:15.887846Z","steps":["trace[808676290] 'process raft request' (duration: 145.674425ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:16.452041Z","caller":"traceutil/trace.go:171","msg":"trace[232875335] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"122.909041ms","start":"2026-06-23T18:45:16.329064Z","end":"2026-06-23T18:45:16.451973Z","steps":["trace[232875335] 'read index received' (duration: 118.163238ms)","trace[232875335] 'applied index is now lower than readState.Index' (duration: 4.743993ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:16.452061Z","caller":"traceutil/trace.go:171","msg":"trace[1941404862] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"145.062957ms","start":"2026-06-23T18:45:16.306929Z","end":"2026-06-23T18:45:16.451992Z","steps":["trace[1941404862] 'process raft request' (duration: 140.816417ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:16.45218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.106336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-23T18:45:16.452233Z","caller":"traceutil/trace.go:171","msg":"trace[183106744] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"123.202999ms","start":"2026-06-23T18:45:16.329008Z","end":"2026-06-23T18:45:16.452211Z","steps":["trace[183106744] 'agreement among raft nodes before linearized reading' (duration: 123.036404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:32.039564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.490984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:45:32.039729Z","caller":"traceutil/trace.go:171","msg":"trace[1312203933] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"258.429228ms","start":"2026-06-23T18:45:31.781261Z","end":"2026-06-23T18:45:32.039691Z","steps":["trace[1312203933] 'process raft request' (duration: 109.368287ms)","trace[1312203933] 'compare' (duration: 148.364511ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:46:18.892415Z","caller":"traceutil/trace.go:171","msg":"trace[1597069055] linearizableReadLoop","detail":"{readStateIndex:1488; appliedIndex:1487; }","duration":"141.887681ms","start":"2026-06-23T18:46:18.75051Z","end":"2026-06-23T18:46:18.892398Z","steps":["trace[1597069055] 'read index received' (duration: 141.766538ms)","trace[1597069055] 'applied index is now lower than readState.Index' (duration: 120.323µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:46:18.892502Z","caller":"traceutil/trace.go:171","msg":"trace[1864953934] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"142.937352ms","start":"2026-06-23T18:46:18.749534Z","end":"2026-06-23T18:46:18.892471Z","steps":["trace[1864953934] 'process raft request' (duration: 142.761497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:18.892578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.061467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-23T18:46:18.8926Z","caller":"traceutil/trace.go:171","msg":"trace[1385903318] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1445; }","duration":"142.13141ms","start":"2026-06-23T18:46:18.750462Z","end":"2026-06-23T18:46:18.892594Z","steps":["trace[1385903318] 'agreement among raft nodes before linearized reading' (duration: 142.037426ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:46:18.892774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.537487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-23T18:46:18.89279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.101152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-23T18:46:18.892938Z","caller":"traceutil/trace.go:171","msg":"trace[1848934285] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1445; }","duration":"139.328839ms","start":"2026-06-23T18:46:18.753583Z","end":"2026-06-23T18:46:18.892912Z","steps":["trace[1848934285] 'agreement among raft nodes before linearized reading' (duration: 139.00975ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:18.892864Z","caller":"traceutil/trace.go:171","msg":"trace[1743364813] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1445; }","duration":"137.696022ms","start":"2026-06-23T18:46:18.755154Z","end":"2026-06-23T18:46:18.89285Z","steps":["trace[1743364813] 'agreement among raft nodes before linearized reading' (duration: 137.480576ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:42.054599Z","caller":"traceutil/trace.go:171","msg":"trace[581874949] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"236.966922ms","start":"2026-06-23T18:46:41.817612Z","end":"2026-06-23T18:46:42.054578Z","steps":["trace[581874949] 'process raft request' (duration: 236.801126ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:46:42.10102Z","caller":"traceutil/trace.go:171","msg":"trace[2142971848] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"180.607281ms","start":"2026-06-23T18:46:41.920385Z","end":"2026-06-23T18:46:42.100992Z","steps":["trace[2142971848] 'process raft request' (duration: 180.362794ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:47:31.259259Z","caller":"traceutil/trace.go:171","msg":"trace[942279118] linearizableReadLoop","detail":"{readStateIndex:2244; appliedIndex:2243; }","duration":"106.641054ms","start":"2026-06-23T18:47:31.152596Z","end":"2026-06-23T18:47:31.259237Z","steps":["trace[942279118] 'read index received' (duration: 106.513981ms)","trace[942279118] 'applied index is now lower than readState.Index' (duration: 125.943µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:47:31.259422Z","caller":"traceutil/trace.go:171","msg":"trace[115356636] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"120.396817ms","start":"2026-06-23T18:47:31.138973Z","end":"2026-06-23T18:47:31.25937Z","steps":["trace[115356636] 'process raft request' (duration: 120.124559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:31.259555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.927113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T18:47:31.260291Z","caller":"traceutil/trace.go:171","msg":"trace[2000210353] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2162; }","duration":"107.727465ms","start":"2026-06-23T18:47:31.152523Z","end":"2026-06-23T18:47:31.26025Z","steps":["trace[2000210353] 'agreement among raft nodes before linearized reading' (duration: 106.894981ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:47:31.470446Z","caller":"traceutil/trace.go:171","msg":"trace[477642859] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2244; }","duration":"184.324783ms","start":"2026-06-23T18:47:31.286084Z","end":"2026-06-23T18:47:31.470408Z","steps":["trace[477642859] 'read index received' (duration: 177.141339ms)","trace[477642859] 'applied index is now lower than readState.Index' (duration: 7.182124ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:47:31.470483Z","caller":"traceutil/trace.go:171","msg":"trace[1411700485] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"211.53874ms","start":"2026-06-23T18:47:31.258922Z","end":"2026-06-23T18:47:31.470461Z","steps":["trace[1411700485] 'process raft request' (duration: 204.316334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:31.470692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.594961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-23T18:47:31.470708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.080507ms","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-06-23T18:47:31.470753Z","caller":"traceutil/trace.go:171","msg":"trace[521782577] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2163; }","duration":"184.703864ms","start":"2026-06-23T18:47:31.286033Z","end":"2026-06-23T18:47:31.470737Z","steps":["trace[521782577] 'agreement among raft nodes before linearized reading' (duration: 184.513438ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:47:31.470756Z","caller":"traceutil/trace.go:171","msg":"trace[654716276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2163; }","duration":"183.18324ms","start":"2026-06-23T18:47:31.287563Z","end":"2026-06-23T18:47:31.470746Z","steps":["trace[654716276] 'agreement among raft nodes before linearized reading' (duration: 183.021945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:47:31.471118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.054739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-23T18:47:31.471238Z","caller":"traceutil/trace.go:171","msg":"trace[1166816824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2163; }","duration":"182.230013ms","start":"2026-06-23T18:47:31.288982Z","end":"2026-06-23T18:47:31.471212Z","steps":["trace[1166816824] 'agreement among raft nodes before linearized reading' (duration: 181.711627ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:52:37.030124Z","caller":"traceutil/trace.go:171","msg":"trace[673379579] linearizableReadLoop","detail":"{readStateIndex:4967; appliedIndex:4965; }","duration":"111.278037ms","start":"2026-06-23T18:52:36.918819Z","end":"2026-06-23T18:52:37.030097Z","steps":["trace[673379579] 'read index received' (duration: 30.263169ms)","trace[673379579] 'applied index is now lower than readState.Index' (duration: 81.013678ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:52:37.030182Z","caller":"traceutil/trace.go:171","msg":"trace[291336257] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"112.08291ms","start":"2026-06-23T18:52:36.918075Z","end":"2026-06-23T18:52:37.030158Z","steps":["trace[291336257] 'process raft request' (duration: 79.427871ms)","trace[291336257] 'compare' (duration: 32.483944ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:52:37.030295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.460022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T18:52:37.030353Z","caller":"traceutil/trace.go:171","msg":"trace[398054420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4783; }","duration":"111.549705ms","start":"2026-06-23T18:52:36.918792Z","end":"2026-06-23T18:52:37.030342Z","steps":["trace[398054420] 'agreement among raft nodes before linearized reading' (duration: 111.412531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:52:37.030407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.523594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-06-23T18:52:37.030452Z","caller":"traceutil/trace.go:171","msg":"trace[482585520] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4783; }","duration":"111.627167ms","start":"2026-06-23T18:52:36.918814Z","end":"2026-06-23T18:52:37.030441Z","steps":["trace[482585520] 'agreement among raft nodes before linearized reading' (duration: 111.459382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:52:37.030569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.088469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-23T18:52:37.030595Z","caller":"traceutil/trace.go:171","msg":"trace[1959490552] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4783; }","duration":"105.140941ms","start":"2026-06-23T18:52:36.925446Z","end":"2026-06-23T18:52:37.030587Z","steps":["trace[1959490552] 'agreement among raft nodes before linearized reading' (duration: 105.090059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:52:40.652953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.443637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-06-23T18:52:40.653032Z","caller":"traceutil/trace.go:171","msg":"trace[1475111104] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:4941; }","duration":"259.563631ms","start":"2026-06-23T18:52:40.393454Z","end":"2026-06-23T18:52:40.653018Z","steps":["trace[1475111104] 'range keys from in-memory index tree' (duration: 259.193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:52:40.653023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.755784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:52:40.653094Z","caller":"traceutil/trace.go:171","msg":"trace[1626900677] linearizableReadLoop","detail":"{readStateIndex:5128; appliedIndex:5127; }","duration":"136.346687ms","start":"2026-06-23T18:52:40.516735Z","end":"2026-06-23T18:52:40.653082Z","steps":["trace[1626900677] 'read index received' (duration: 21.390577ms)","trace[1626900677] 'applied index is now lower than readState.Index' (duration: 114.9551ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:52:40.653102Z","caller":"traceutil/trace.go:171","msg":"trace[1426284700] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"138.626572ms","start":"2026-06-23T18:52:40.514464Z","end":"2026-06-23T18:52:40.65309Z","steps":["trace[1426284700] 'process raft request' (duration: 23.717784ms)","trace[1426284700] 'compare' (duration: 114.566188ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:52:40.653367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.765304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-147f614c-b821-4cd1-850b-deb4ddd4f8c7\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-06-23T18:52:40.6534Z","caller":"traceutil/trace.go:171","msg":"trace[527534407] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-147f614c-b821-4cd1-850b-deb4ddd4f8c7; range_end:; response_count:1; response_revision:4942; }","duration":"108.842326ms","start":"2026-06-23T18:52:40.544548Z","end":"2026-06-23T18:52:40.653391Z","steps":["trace[527534407] 'agreement among raft nodes before linearized reading' (duration: 108.760244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:52:40.653727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.974354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786864"} {"level":"info","ts":"2026-06-23T18:52:40.65382Z","caller":"traceutil/trace.go:171","msg":"trace[1773932933] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4942; }","duration":"137.084457ms","start":"2026-06-23T18:52:40.5167Z","end":"2026-06-23T18:52:40.653784Z","steps":["trace[1773932933] 'agreement among raft nodes before linearized reading' (duration: 136.426699ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:52:40.773448Z","caller":"traceutil/trace.go:171","msg":"trace[634054894] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"112.322825ms","start":"2026-06-23T18:52:40.661103Z","end":"2026-06-23T18:52:40.773426Z","steps":["trace[634054894] 'process raft request' (duration: 112.148641ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:52:52.774511Z","caller":"traceutil/trace.go:171","msg":"trace[230471106] transaction","detail":"{read_only:false; response_revision:5179; number_of_response:1; }","duration":"105.242485ms","start":"2026-06-23T18:52:52.669252Z","end":"2026-06-23T18:52:52.774494Z","steps":["trace[230471106] 'process raft request' (duration: 105.142552ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:52:52.803814Z","caller":"traceutil/trace.go:171","msg":"trace[1222816362] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"111.218393ms","start":"2026-06-23T18:52:52.69256Z","end":"2026-06-23T18:52:52.803778Z","steps":["trace[1222816362] 'process raft request' (duration: 111.031838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:53:00.560586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.179867ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:53:00.560795Z","caller":"traceutil/trace.go:171","msg":"trace[879006286] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"281.999866ms","start":"2026-06-23T18:53:00.278766Z","end":"2026-06-23T18:53:00.560766Z","steps":["trace[879006286] 'process raft request' (duration: 69.578862ms)","trace[879006286] 'compare' (duration: 212.103695ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:53:00.560975Z","caller":"traceutil/trace.go:171","msg":"trace[1110657886] transaction","detail":"{read_only:false; response_revision:5343; number_of_response:1; }","duration":"121.100744ms","start":"2026-06-23T18:53:00.439847Z","end":"2026-06-23T18:53:00.560947Z","steps":["trace[1110657886] 'process raft request' (duration: 120.821496ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:53:00.561085Z","caller":"traceutil/trace.go:171","msg":"trace[357285739] linearizableReadLoop","detail":"{readStateIndex:5542; appliedIndex:5540; }","duration":"111.911683ms","start":"2026-06-23T18:53:00.449156Z","end":"2026-06-23T18:53:00.561067Z","steps":["trace[357285739] 'read index received' (duration: 26.580084ms)","trace[357285739] 'applied index is now lower than readState.Index' (duration: 85.330149ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:53:00.615003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.293411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c0c4ebd6-99dc-455f-b2b3-aa99b4130759\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-06-23T18:53:00.615027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.875395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9dpnk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-23T18:53:00.615088Z","caller":"traceutil/trace.go:171","msg":"trace[731606853] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c0c4ebd6-99dc-455f-b2b3-aa99b4130759; range_end:; response_count:1; response_revision:5343; }","duration":"139.449314ms","start":"2026-06-23T18:53:00.475617Z","end":"2026-06-23T18:53:00.615066Z","steps":["trace[731606853] 'agreement among raft nodes before linearized reading' (duration: 139.219758ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:53:00.615127Z","caller":"traceutil/trace.go:171","msg":"trace[184844068] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9dpnk; range_end:; response_count:1; response_revision:5343; }","duration":"165.976898ms","start":"2026-06-23T18:53:00.449099Z","end":"2026-06-23T18:53:00.615076Z","steps":["trace[184844068] 'agreement among raft nodes before linearized reading' (duration: 112.053248ms)","trace[184844068] 'range keys from in-memory index tree' (duration: 53.767926ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:53:00.615149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.994135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-23T18:53:00.615205Z","caller":"traceutil/trace.go:171","msg":"trace[1184041690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5343; }","duration":"125.074457ms","start":"2026-06-23T18:53:00.490115Z","end":"2026-06-23T18:53:00.615189Z","steps":["trace[1184041690] 'agreement among raft nodes before linearized reading' (duration: 124.889392ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:53:00.982144Z","caller":"traceutil/trace.go:171","msg":"trace[841221444] linearizableReadLoop","detail":"{readStateIndex:5545; appliedIndex:5544; }","duration":"157.96229ms","start":"2026-06-23T18:53:00.824158Z","end":"2026-06-23T18:53:00.982121Z","steps":["trace[841221444] 'read index received' (duration: 157.879607ms)","trace[841221444] 'applied index is now lower than readState.Index' (duration: 81.613µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:53:00.982313Z","caller":"traceutil/trace.go:171","msg":"trace[1607972867] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"175.409724ms","start":"2026-06-23T18:53:00.806792Z","end":"2026-06-23T18:53:00.982201Z","steps":["trace[1607972867] 'process raft request' (duration: 175.183188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:53:00.982362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.183786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-23T18:53:00.982416Z","caller":"traceutil/trace.go:171","msg":"trace[1393446489] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5345; }","duration":"158.288639ms","start":"2026-06-23T18:53:00.824116Z","end":"2026-06-23T18:53:00.982404Z","steps":["trace[1393446489] 'agreement among raft nodes before linearized reading' (duration: 158.118344ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:53:00.988035Z","caller":"traceutil/trace.go:171","msg":"trace[1967189600] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"162.997762ms","start":"2026-06-23T18:53:00.825016Z","end":"2026-06-23T18:53:00.988014Z","steps":["trace[1967189600] 'process raft request' (duration: 162.683993ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:54:05.90757Z","caller":"traceutil/trace.go:171","msg":"trace[605335026] transaction","detail":"{read_only:false; response_revision:5954; number_of_response:1; }","duration":"100.358297ms","start":"2026-06-23T18:54:05.807169Z","end":"2026-06-23T18:54:05.907527Z","steps":["trace[605335026] 'process raft request' (duration: 100.121661ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:54:32.461314Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3019} {"level":"info","ts":"2026-06-23T18:54:32.546438Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3019,"took":"83.534558ms","hash":1131983794,"current-db-size-bytes":58654720,"current-db-size":"59 MB","current-db-size-in-use-bytes":32280576,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-23T18:54:32.547509Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1131983794,"revision":3019,"compact-revision":-1} {"level":"info","ts":"2026-06-23T18:59:00.952982Z","caller":"traceutil/trace.go:171","msg":"trace[851644493] transaction","detail":"{read_only:false; response_revision:8145; number_of_response:1; }","duration":"108.739623ms","start":"2026-06-23T18:59:00.844222Z","end":"2026-06-23T18:59:00.952961Z","steps":["trace[851644493] 'process raft request' (duration: 108.589118ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:59:12.552268Z","caller":"traceutil/trace.go:171","msg":"trace[1550465296] transaction","detail":"{read_only:false; response_revision:8206; number_of_response:1; }","duration":"202.828781ms","start":"2026-06-23T18:59:12.349405Z","end":"2026-06-23T18:59:12.552233Z","steps":["trace[1550465296] 'process raft request' (duration: 202.597874ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:59:12.670029Z","caller":"traceutil/trace.go:171","msg":"trace[518444409] transaction","detail":"{read_only:false; response_revision:8207; number_of_response:1; }","duration":"113.822829ms","start":"2026-06-23T18:59:12.556167Z","end":"2026-06-23T18:59:12.669989Z","steps":["trace[518444409] 'process raft request' (duration: 69.304152ms)","trace[518444409] 'compare' (duration: 44.243858ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:59:13.341812Z","caller":"traceutil/trace.go:171","msg":"trace[264563150] transaction","detail":"{read_only:false; response_revision:8212; number_of_response:1; }","duration":"177.700486ms","start":"2026-06-23T18:59:13.164085Z","end":"2026-06-23T18:59:13.341786Z","steps":["trace[264563150] 'process raft request' (duration: 177.555032ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:59:14.093017Z","caller":"traceutil/trace.go:171","msg":"trace[386516487] transaction","detail":"{read_only:false; response_revision:8214; number_of_response:1; }","duration":"114.411175ms","start":"2026-06-23T18:59:13.978565Z","end":"2026-06-23T18:59:14.092976Z","steps":["trace[386516487] 'process raft request' (duration: 114.203468ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:59:32.470537Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6146} {"level":"info","ts":"2026-06-23T18:59:32.558373Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6146,"took":"86.207563ms","hash":814127178,"current-db-size-bytes":58654720,"current-db-size":"59 MB","current-db-size-in-use-bytes":23175168,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-23T18:59:32.558452Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":814127178,"revision":6146,"compact-revision":3019} {"level":"info","ts":"2026-06-23T18:59:41.548167Z","caller":"traceutil/trace.go:171","msg":"trace[2066267476] linearizableReadLoop","detail":"{readStateIndex:8712; appliedIndex:8711; }","duration":"393.765504ms","start":"2026-06-23T18:59:41.154379Z","end":"2026-06-23T18:59:41.548144Z","steps":["trace[2066267476] 'read index received' (duration: 393.542497ms)","trace[2066267476] 'applied index is now lower than readState.Index' (duration: 221.936µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:59:41.548275Z","caller":"traceutil/trace.go:171","msg":"trace[1205056110] transaction","detail":"{read_only:false; response_revision:8416; number_of_response:1; }","duration":"418.678003ms","start":"2026-06-23T18:59:41.129576Z","end":"2026-06-23T18:59:41.548254Z","steps":["trace[1205056110] 'process raft request' (duration: 418.413255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:59:41.548489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.085782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-23T18:59:41.548527Z","caller":"traceutil/trace.go:171","msg":"trace[243863804] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8416; }","duration":"394.168285ms","start":"2026-06-23T18:59:41.154348Z","end":"2026-06-23T18:59:41.548516Z","steps":["trace[243863804] 'agreement among raft nodes before linearized reading' (duration: 393.930698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:59:41.548568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:59:41.154333Z","time spent":"394.226996ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-23T18:59:41.548509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:59:41.129554Z","time spent":"418.819596ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:59:41.548631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.802699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-23T18:59:41.548671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.225055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-23T18:59:41.548714Z","caller":"traceutil/trace.go:171","msg":"trace[1624801497] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8416; }","duration":"351.928793ms","start":"2026-06-23T18:59:41.196766Z","end":"2026-06-23T18:59:41.548695Z","steps":["trace[1624801497] 'agreement among raft nodes before linearized reading' (duration: 351.668766ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:59:41.548741Z","caller":"traceutil/trace.go:171","msg":"trace[1250758184] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:8416; }","duration":"279.322827ms","start":"2026-06-23T18:59:41.269399Z","end":"2026-06-23T18:59:41.548722Z","steps":["trace[1250758184] 'agreement among raft nodes before linearized reading' (duration: 279.0972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:59:41.548761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:59:41.196752Z","time spent":"352.001375ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-23T18:59:41.548913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.927613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T18:59:41.549069Z","caller":"traceutil/trace.go:171","msg":"trace[331168779] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:8416; }","duration":"307.19833ms","start":"2026-06-23T18:59:41.24184Z","end":"2026-06-23T18:59:41.549038Z","steps":["trace[331168779] 'agreement among raft nodes before linearized reading' (duration: 306.803839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:59:41.549038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.174942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-23T18:59:41.549151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:59:41.24183Z","time spent":"307.303313ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-06-23T18:59:41.549167Z","caller":"traceutil/trace.go:171","msg":"trace[1261527231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8416; }","duration":"318.378579ms","start":"2026-06-23T18:59:41.230762Z","end":"2026-06-23T18:59:41.549141Z","steps":["trace[1261527231] 'agreement among raft nodes before linearized reading' (duration: 317.943546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:59:41.549401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:59:41.230744Z","time spent":"318.638986ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T18:59:54.127234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.564692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T18:59:54.127319Z","caller":"traceutil/trace.go:171","msg":"trace[197280703] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8526; }","duration":"235.741748ms","start":"2026-06-23T18:59:53.891565Z","end":"2026-06-23T18:59:54.127306Z","steps":["trace[197280703] 'process raft request' (duration: 109.95794ms)","trace[197280703] 'compare' (duration: 125.434258ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:59:54.134075Z","caller":"traceutil/trace.go:171","msg":"trace[1131717318] linearizableReadLoop","detail":"{readStateIndex:8828; appliedIndex:8826; }","duration":"196.158601ms","start":"2026-06-23T18:59:53.937899Z","end":"2026-06-23T18:59:54.134058Z","steps":["trace[1131717318] 'read index received' (duration: 63.678672ms)","trace[1131717318] 'applied index is now lower than readState.Index' (duration: 132.479159ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:59:54.134143Z","caller":"traceutil/trace.go:171","msg":"trace[1744867067] transaction","detail":"{read_only:false; response_revision:8527; number_of_response:1; }","duration":"241.895762ms","start":"2026-06-23T18:59:53.892221Z","end":"2026-06-23T18:59:54.134117Z","steps":["trace[1744867067] 'process raft request' (duration: 241.730857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:59:54.134277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.363687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:59:54.13485Z","caller":"traceutil/trace.go:171","msg":"trace[507675967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8527; }","duration":"196.946293ms","start":"2026-06-23T18:59:53.937884Z","end":"2026-06-23T18:59:54.13483Z","steps":["trace[507675967] 'agreement among raft nodes before linearized reading' (duration: 196.319585ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:59:54.982071Z","caller":"traceutil/trace.go:171","msg":"trace[74795035] transaction","detail":"{read_only:false; response_revision:8533; number_of_response:1; }","duration":"234.316857ms","start":"2026-06-23T18:59:54.747698Z","end":"2026-06-23T18:59:54.982014Z","steps":["trace[74795035] 'process raft request' (duration: 230.411175ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:59:54.997327Z","caller":"traceutil/trace.go:171","msg":"trace[1773722656] transaction","detail":"{read_only:false; response_revision:8534; number_of_response:1; }","duration":"133.378186ms","start":"2026-06-23T18:59:54.863884Z","end":"2026-06-23T18:59:54.997262Z","steps":["trace[1773722656] 'process raft request' (duration: 133.199271ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:00:24.335194Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023c7.wal"} {"level":"info","ts":"2026-06-23T19:02:03.201026Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e892d50a3a4fc0f4","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T19:02:03.206616Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-23T19:02:03.206742Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-23T19:03:29.491298Z","caller":"traceutil/trace.go:171","msg":"trace[1577372936] linearizableReadLoop","detail":"{readStateIndex:10690; appliedIndex:10689; }","duration":"103.372551ms","start":"2026-06-23T19:03:29.387903Z","end":"2026-06-23T19:03:29.491276Z","steps":["trace[1577372936] 'read index received' (duration: 103.184426ms)","trace[1577372936] 'applied index is now lower than readState.Index' (duration: 187.325µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:03:29.491491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.578197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-23T19:03:29.491526Z","caller":"traceutil/trace.go:171","msg":"trace[1472250370] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10336; }","duration":"103.657399ms","start":"2026-06-23T19:03:29.387857Z","end":"2026-06-23T19:03:29.491514Z","steps":["trace[1472250370] 'agreement among raft nodes before linearized reading' (duration: 103.517335ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:03:29.491831Z","caller":"traceutil/trace.go:171","msg":"trace[1159316927] transaction","detail":"{read_only:false; response_revision:10336; number_of_response:1; }","duration":"107.964312ms","start":"2026-06-23T19:03:29.383855Z","end":"2026-06-23T19:03:29.49182Z","steps":["trace[1159316927] 'process raft request' (duration: 107.302213ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:04:32.47856Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8319} {"level":"info","ts":"2026-06-23T19:04:32.55821Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8319,"took":"77.195862ms","hash":1034625950,"current-db-size-bytes":58654720,"current-db-size":"59 MB","current-db-size-in-use-bytes":26755072,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-23T19:04:32.55828Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1034625950,"revision":8319,"compact-revision":6146} {"level":"info","ts":"2026-06-23T19:09:32.483998Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11009} {"level":"info","ts":"2026-06-23T19:09:32.570896Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11009,"took":"82.608977ms","hash":2256907840,"current-db-size-bytes":58654720,"current-db-size":"59 MB","current-db-size-in-use-bytes":28524544,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-23T19:09:32.570954Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2256907840,"revision":11009,"compact-revision":8319} {"level":"info","ts":"2026-06-23T19:11:15.122937Z","caller":"traceutil/trace.go:171","msg":"trace[1392609351] transaction","detail":"{read_only:false; response_revision:13730; number_of_response:1; }","duration":"369.050741ms","start":"2026-06-23T19:11:14.753854Z","end":"2026-06-23T19:11:15.122905Z","steps":["trace[1392609351] 'process raft request' (duration: 368.826704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:11:15.123141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:11:14.753827Z","time spent":"369.221425ms","remote":"127.0.0.1:46052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12483,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:11:15.161844Z","caller":"traceutil/trace.go:171","msg":"trace[864046635] linearizableReadLoop","detail":"{readStateIndex:14197; appliedIndex:14195; }","duration":"263.661695ms","start":"2026-06-23T19:11:14.898162Z","end":"2026-06-23T19:11:15.161823Z","steps":["trace[864046635] 'read index received' (duration: 224.71503ms)","trace[864046635] 'applied index is now lower than readState.Index' (duration: 38.945515ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:11:15.162005Z","caller":"traceutil/trace.go:171","msg":"trace[1542785744] transaction","detail":"{read_only:false; response_revision:13731; number_of_response:1; }","duration":"399.692427ms","start":"2026-06-23T19:11:14.762266Z","end":"2026-06-23T19:11:15.161959Z","steps":["trace[1542785744] 'process raft request' (duration: 387.820117ms)","trace[1542785744] 'compare' (duration: 11.626253ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:11:15.162178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.999985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-23T19:11:15.162203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:11:14.762241Z","time spent":"399.862372ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:11:15.162222Z","caller":"traceutil/trace.go:171","msg":"trace[554153727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13731; }","duration":"264.091508ms","start":"2026-06-23T19:11:14.898118Z","end":"2026-06-23T19:11:15.162209Z","steps":["trace[554153727] 'agreement among raft nodes before linearized reading' (duration: 263.822989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:11:15.162238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.365288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-23T19:11:15.16232Z","caller":"traceutil/trace.go:171","msg":"trace[1523272781] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:13731; }","duration":"183.46961ms","start":"2026-06-23T19:11:14.978827Z","end":"2026-06-23T19:11:15.162297Z","steps":["trace[1523272781] 'agreement among raft nodes before linearized reading' (duration: 183.312286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:11:15.162333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.663382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-23T19:11:15.162394Z","caller":"traceutil/trace.go:171","msg":"trace[639939755] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13731; }","duration":"193.736515ms","start":"2026-06-23T19:11:14.968645Z","end":"2026-06-23T19:11:15.162381Z","steps":["trace[639939755] 'agreement among raft nodes before linearized reading' (duration: 193.587951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:11:15.162209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.882578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T19:11:15.162511Z","caller":"traceutil/trace.go:171","msg":"trace[1075281064] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13731; }","duration":"223.249989ms","start":"2026-06-23T19:11:14.939254Z","end":"2026-06-23T19:11:15.162504Z","steps":["trace[1075281064] 'agreement among raft nodes before linearized reading' (duration: 222.887139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:11:15.162511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.706242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-23T19:11:15.162624Z","caller":"traceutil/trace.go:171","msg":"trace[1171874332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13731; }","duration":"194.865597ms","start":"2026-06-23T19:11:14.96773Z","end":"2026-06-23T19:11:15.162596Z","steps":["trace[1171874332] 'agreement among raft nodes before linearized reading' (duration: 194.538228ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:11:24.302131Z","caller":"traceutil/trace.go:171","msg":"trace[1334037108] transaction","detail":"{read_only:false; response_revision:13901; number_of_response:1; }","duration":"318.971978ms","start":"2026-06-23T19:11:23.982616Z","end":"2026-06-23T19:11:24.301588Z","steps":["trace[1334037108] 'process raft request' (duration: 318.811273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:11:24.302286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:11:23.982597Z","time spent":"319.616286ms","remote":"127.0.0.1:46052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13184,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:11:24.361228Z","caller":"traceutil/trace.go:171","msg":"trace[580870947] linearizableReadLoop","detail":"{readStateIndex:14371; appliedIndex:14370; }","duration":"246.181975ms","start":"2026-06-23T19:11:24.115023Z","end":"2026-06-23T19:11:24.361205Z","steps":["trace[580870947] 'read index received' (duration: 186.686362ms)","trace[580870947] 'applied index is now lower than readState.Index' (duration: 59.494883ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:11:24.36135Z","caller":"traceutil/trace.go:171","msg":"trace[1361089641] transaction","detail":"{read_only:false; response_revision:13902; number_of_response:1; }","duration":"347.047852ms","start":"2026-06-23T19:11:24.014265Z","end":"2026-06-23T19:11:24.361312Z","steps":["trace[1361089641] 'process raft request' (duration: 332.910367ms)","trace[1361089641] 'compare' (duration: 13.927339ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:11:24.36142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.383371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9dpnk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-23T19:11:24.361451Z","caller":"traceutil/trace.go:171","msg":"trace[1223501364] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9dpnk; range_end:; response_count:1; response_revision:13902; }","duration":"246.435272ms","start":"2026-06-23T19:11:24.115008Z","end":"2026-06-23T19:11:24.361444Z","steps":["trace[1223501364] 'agreement among raft nodes before linearized reading' (duration: 246.294778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:11:24.361514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:11:24.014245Z","time spent":"347.186205ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:13:02.179033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.060649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-khht2\" ","response":"range_response_count:1 size:22124"} {"level":"info","ts":"2026-06-23T19:13:02.17912Z","caller":"traceutil/trace.go:171","msg":"trace[1099539597] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-khht2; range_end:; response_count:1; response_revision:14985; }","duration":"132.175623ms","start":"2026-06-23T19:13:02.046924Z","end":"2026-06-23T19:13:02.1791Z","steps":["trace[1099539597] 'range keys from in-memory index tree' (duration: 131.928405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:13:02.179464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.265179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-khht2\" ","response":"range_response_count:1 size:22124"} {"level":"info","ts":"2026-06-23T19:13:02.179508Z","caller":"traceutil/trace.go:171","msg":"trace[958365225] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-khht2; range_end:; response_count:1; response_revision:14985; }","duration":"115.342621ms","start":"2026-06-23T19:13:02.064155Z","end":"2026-06-23T19:13:02.179497Z","steps":["trace[958365225] 'range keys from in-memory index tree' (duration: 115.143365ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:13:03.014306Z","caller":"traceutil/trace.go:171","msg":"trace[1751028950] transaction","detail":"{read_only:false; response_revision:14988; number_of_response:1; }","duration":"121.162507ms","start":"2026-06-23T19:13:02.893117Z","end":"2026-06-23T19:13:03.01428Z","steps":["trace[1751028950] 'process raft request' (duration: 121.006052ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:14:32.489764Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13076} {"level":"info","ts":"2026-06-23T19:14:32.571053Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13076,"took":"78.523207ms","hash":3070840889,"current-db-size-bytes":58654720,"current-db-size":"59 MB","current-db-size-in-use-bytes":31739904,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-23T19:14:32.571131Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3070840889,"revision":13076,"compact-revision":11009} {"level":"info","ts":"2026-06-23T19:18:43.514544Z","caller":"traceutil/trace.go:171","msg":"trace[1225216061] transaction","detail":"{read_only:false; response_revision:17585; number_of_response:1; }","duration":"140.809918ms","start":"2026-06-23T19:18:43.373713Z","end":"2026-06-23T19:18:43.514523Z","steps":["trace[1225216061] 'process raft request' (duration: 140.706615ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:18:43.633688Z","caller":"traceutil/trace.go:171","msg":"trace[202360733] transaction","detail":"{read_only:false; response_revision:17586; number_of_response:1; }","duration":"259.953076ms","start":"2026-06-23T19:18:43.373712Z","end":"2026-06-23T19:18:43.633665Z","steps":["trace[202360733] 'process raft request' (duration: 259.699759ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:18:43.634063Z","caller":"traceutil/trace.go:171","msg":"trace[1033045856] transaction","detail":"{read_only:false; response_revision:17587; number_of_response:1; }","duration":"260.306478ms","start":"2026-06-23T19:18:43.373743Z","end":"2026-06-23T19:18:43.63405Z","steps":["trace[1033045856] 'process raft request' (duration: 259.875995ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:18:43.63414Z","caller":"traceutil/trace.go:171","msg":"trace[421994473] linearizableReadLoop","detail":"{readStateIndex:18176; appliedIndex:18174; }","duration":"239.490023ms","start":"2026-06-23T19:18:43.394628Z","end":"2026-06-23T19:18:43.634118Z","steps":["trace[421994473] 'read index received' (duration: 119.966703ms)","trace[421994473] 'applied index is now lower than readState.Index' (duration: 119.52238ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:18:43.634985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.339846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-23T19:18:43.635108Z","caller":"traceutil/trace.go:171","msg":"trace[1817265538] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17588; }","duration":"240.446119ms","start":"2026-06-23T19:18:43.394612Z","end":"2026-06-23T19:18:43.635058Z","steps":["trace[1817265538] 'agreement among raft nodes before linearized reading' (duration: 240.081769ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:18:43.635323Z","caller":"traceutil/trace.go:171","msg":"trace[1495491892] transaction","detail":"{read_only:false; response_revision:17588; number_of_response:1; }","duration":"127.521608ms","start":"2026-06-23T19:18:43.507744Z","end":"2026-06-23T19:18:43.635266Z","steps":["trace[1495491892] 'process raft request' (duration: 126.144169ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:18:49.967666Z","caller":"traceutil/trace.go:171","msg":"trace[2137387125] linearizableReadLoop","detail":"{readStateIndex:18363; appliedIndex:18362; }","duration":"162.318213ms","start":"2026-06-23T19:18:49.805309Z","end":"2026-06-23T19:18:49.967627Z","steps":["trace[2137387125] 'read index received' (duration: 133.079387ms)","trace[2137387125] 'applied index is now lower than readState.Index' (duration: 29.236506ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:18:49.967971Z","caller":"traceutil/trace.go:171","msg":"trace[1839526812] transaction","detail":"{read_only:false; response_revision:17772; number_of_response:1; }","duration":"274.652738ms","start":"2026-06-23T19:18:49.693291Z","end":"2026-06-23T19:18:49.967944Z","steps":["trace[1839526812] 'process raft request' (duration: 245.125073ms)","trace[1839526812] 'compare' (duration: 29.048381ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:18:49.968116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.785937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:18:49.968195Z","caller":"traceutil/trace.go:171","msg":"trace[688792057] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:17772; }","duration":"162.917701ms","start":"2026-06-23T19:18:49.805257Z","end":"2026-06-23T19:18:49.968174Z","steps":["trace[688792057] 'agreement among raft nodes before linearized reading' (duration: 162.780697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:18:50.009133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.152281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-23T19:18:50.009422Z","caller":"traceutil/trace.go:171","msg":"trace[1181939514] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17773; }","duration":"153.437809ms","start":"2026-06-23T19:18:49.855908Z","end":"2026-06-23T19:18:50.009346Z","steps":["trace[1181939514] 'agreement among raft nodes before linearized reading' (duration: 153.035618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:18:50.349155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.676277ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:18:50.349463Z","caller":"traceutil/trace.go:171","msg":"trace[1246656977] linearizableReadLoop","detail":"{readStateIndex:18365; appliedIndex:18364; }","duration":"276.372717ms","start":"2026-06-23T19:18:50.073072Z","end":"2026-06-23T19:18:50.349444Z","steps":["trace[1246656977] 'read index received' (duration: 158.245397ms)","trace[1246656977] 'applied index is now lower than readState.Index' (duration: 118.1253ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:18:50.349493Z","caller":"traceutil/trace.go:171","msg":"trace[1245183132] transaction","detail":"{read_only:false; response_revision:17774; number_of_response:1; }","duration":"293.538659ms","start":"2026-06-23T19:18:50.05593Z","end":"2026-06-23T19:18:50.349469Z","steps":["trace[1245183132] 'process raft request' (duration: 175.44334ms)","trace[1245183132] 'compare' (duration: 117.137311ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:18:50.349642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.562563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:18:50.349688Z","caller":"traceutil/trace.go:171","msg":"trace[88012086] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:17774; }","duration":"276.646795ms","start":"2026-06-23T19:18:50.07303Z","end":"2026-06-23T19:18:50.349677Z","steps":["trace[88012086] 'agreement among raft nodes before linearized reading' (duration: 276.543252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:18:50.349734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.041235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:18:50.349767Z","caller":"traceutil/trace.go:171","msg":"trace[647736847] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:17774; }","duration":"120.122877ms","start":"2026-06-23T19:18:50.229634Z","end":"2026-06-23T19:18:50.349757Z","steps":["trace[647736847] 'agreement among raft nodes before linearized reading' (duration: 120.058475ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:19:32.496867Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15580} {"level":"info","ts":"2026-06-23T19:19:32.587921Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15580,"took":"87.468052ms","hash":284894657,"current-db-size-bytes":58654720,"current-db-size":"59 MB","current-db-size-in-use-bytes":33730560,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-23T19:19:32.587989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":284894657,"revision":15580,"compact-revision":13076} {"level":"info","ts":"2026-06-23T19:22:11.674498Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e892d50a3a4fc0f4","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T19:22:11.682094Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-23T19:22:11.68224Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"warn","ts":"2026-06-23T19:23:35.363496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.915122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:23:35.363737Z","caller":"traceutil/trace.go:171","msg":"trace[1612525738] linearizableReadLoop","detail":"{readStateIndex:20550; appliedIndex:20549; }","duration":"129.637134ms","start":"2026-06-23T19:23:35.233978Z","end":"2026-06-23T19:23:35.363616Z","steps":["trace[1612525738] 'read index received' (duration: 56.981µs)","trace[1612525738] 'applied index is now lower than readState.Index' (duration: 129.579013ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:23:35.363791Z","caller":"traceutil/trace.go:171","msg":"trace[1345815321] transaction","detail":"{read_only:false; response_revision:19885; number_of_response:1; }","duration":"237.151096ms","start":"2026-06-23T19:23:35.126588Z","end":"2026-06-23T19:23:35.363739Z","steps":["trace[1345815321] 'process raft request' (duration: 91.917574ms)","trace[1345815321] 'compare' (duration: 144.625784ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:23:35.364084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.086747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-23T19:23:35.364171Z","caller":"traceutil/trace.go:171","msg":"trace[494752090] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19885; }","duration":"130.228051ms","start":"2026-06-23T19:23:35.233921Z","end":"2026-06-23T19:23:35.36415Z","steps":["trace[494752090] 'agreement among raft nodes before linearized reading' (duration: 129.855851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:23:40.933135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.644289ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-06-23T19:23:40.933265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.142531ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:23:40.933365Z","caller":"traceutil/trace.go:171","msg":"trace[820800488] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:19914; }","duration":"121.246394ms","start":"2026-06-23T19:23:40.812101Z","end":"2026-06-23T19:23:40.933347Z","steps":["trace[820800488] 'range keys from in-memory index tree' (duration: 121.12914ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:23:41.101485Z","caller":"traceutil/trace.go:171","msg":"trace[636746988] transaction","detail":"{read_only:false; response_revision:19915; number_of_response:1; }","duration":"121.558572ms","start":"2026-06-23T19:23:40.979878Z","end":"2026-06-23T19:23:41.101436Z","steps":["trace[636746988] 'process raft request' (duration: 121.14234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:23:41.431051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.266106ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:23:41.431164Z","caller":"traceutil/trace.go:171","msg":"trace[894043755] linearizableReadLoop","detail":"{readStateIndex:20583; appliedIndex:20582; }","duration":"325.130686ms","start":"2026-06-23T19:23:41.106Z","end":"2026-06-23T19:23:41.431131Z","steps":["trace[894043755] 'read index received' (duration: 62.667905ms)","trace[894043755] 'applied index is now lower than readState.Index' (duration: 262.461481ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:23:41.431263Z","caller":"traceutil/trace.go:171","msg":"trace[330695896] transaction","detail":"{read_only:false; response_revision:19916; number_of_response:1; }","duration":"376.961703ms","start":"2026-06-23T19:23:41.054287Z","end":"2026-06-23T19:23:41.431249Z","steps":["trace[330695896] 'process raft request' (duration: 114.424389ms)","trace[330695896] 'compare' (duration: 261.988758ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:23:41.431328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:23:41.054261Z","time spent":"377.032705ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:23:41.431497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.490567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-06-23T19:23:41.431487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.225608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T19:23:41.431555Z","caller":"traceutil/trace.go:171","msg":"trace[16653632] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:19916; }","duration":"325.59317ms","start":"2026-06-23T19:23:41.105947Z","end":"2026-06-23T19:23:41.431541Z","steps":["trace[16653632] 'agreement among raft nodes before linearized reading' (duration: 325.433465ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:23:41.431574Z","caller":"traceutil/trace.go:171","msg":"trace[1418942480] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:19916; }","duration":"177.367842ms","start":"2026-06-23T19:23:41.254184Z","end":"2026-06-23T19:23:41.431552Z","steps":["trace[1418942480] 'agreement among raft nodes before linearized reading' (duration: 177.213388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:23:41.431597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:23:41.105927Z","time spent":"325.661922ms","remote":"127.0.0.1:46052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-23T19:23:41.604584Z","caller":"traceutil/trace.go:171","msg":"trace[1455281931] transaction","detail":"{read_only:false; response_revision:19918; number_of_response:1; }","duration":"168.703024ms","start":"2026-06-23T19:23:41.435849Z","end":"2026-06-23T19:23:41.604552Z","steps":["trace[1455281931] 'process raft request' (duration: 165.79594ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:23:41.604781Z","caller":"traceutil/trace.go:171","msg":"trace[1126124678] linearizableReadLoop","detail":"{readStateIndex:20586; appliedIndex:20584; }","duration":"104.02434ms","start":"2026-06-23T19:23:41.500716Z","end":"2026-06-23T19:23:41.604741Z","steps":["trace[1126124678] 'read index received' (duration: 100.787547ms)","trace[1126124678] 'applied index is now lower than readState.Index' (duration: 3.233383ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:23:41.605032Z","caller":"traceutil/trace.go:171","msg":"trace[2058624698] transaction","detail":"{read_only:false; response_revision:19919; number_of_response:1; }","duration":"167.339505ms","start":"2026-06-23T19:23:41.437654Z","end":"2026-06-23T19:23:41.604993Z","steps":["trace[2058624698] 'process raft request' (duration: 166.818841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:23:41.605139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.385671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:23:41.605193Z","caller":"traceutil/trace.go:171","msg":"trace[1976016458] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:19919; }","duration":"104.525795ms","start":"2026-06-23T19:23:41.500652Z","end":"2026-06-23T19:23:41.605178Z","steps":["trace[1976016458] 'agreement among raft nodes before linearized reading' (duration: 104.253057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:23:42.177617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.020928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:23:42.177842Z","caller":"traceutil/trace.go:171","msg":"trace[590695457] linearizableReadLoop","detail":"{readStateIndex:20589; appliedIndex:20587; }","duration":"123.590442ms","start":"2026-06-23T19:23:42.054202Z","end":"2026-06-23T19:23:42.177793Z","steps":["trace[590695457] 'read index received' (duration: 114.221383ms)","trace[590695457] 'applied index is now lower than readState.Index' (duration: 9.367949ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:23:42.177885Z","caller":"traceutil/trace.go:171","msg":"trace[747534519] transaction","detail":"{read_only:false; response_revision:19922; number_of_response:1; }","duration":"199.279011ms","start":"2026-06-23T19:23:41.978573Z","end":"2026-06-23T19:23:42.177852Z","steps":["trace[747534519] 'process raft request' (duration: 199.154697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:23:42.177978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.779678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-23T19:23:42.178015Z","caller":"traceutil/trace.go:171","msg":"trace[1634778658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19922; }","duration":"123.85374ms","start":"2026-06-23T19:23:42.054152Z","end":"2026-06-23T19:23:42.178006Z","steps":["trace[1634778658] 'agreement among raft nodes before linearized reading' (duration: 123.723546ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:23:42.178029Z","caller":"traceutil/trace.go:171","msg":"trace[2010262142] transaction","detail":"{read_only:false; response_revision:19921; number_of_response:1; }","duration":"199.735254ms","start":"2026-06-23T19:23:41.978274Z","end":"2026-06-23T19:23:42.178009Z","steps":["trace[2010262142] 'process raft request' (duration: 71.17894ms)","trace[2010262142] 'compare' (duration: 127.645237ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:23:42.358078Z","caller":"traceutil/trace.go:171","msg":"trace[709411246] transaction","detail":"{read_only:false; response_revision:19923; number_of_response:1; }","duration":"175.387737ms","start":"2026-06-23T19:23:42.182664Z","end":"2026-06-23T19:23:42.358052Z","steps":["trace[709411246] 'process raft request' (duration: 141.082934ms)","trace[709411246] 'compare' (duration: 34.142808ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:24:32.503041Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18162} {"level":"info","ts":"2026-06-23T19:24:32.611329Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18162,"took":"104.433663ms","hash":194384419,"current-db-size-bytes":58654720,"current-db-size":"59 MB","current-db-size-in-use-bytes":30412800,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-23T19:24:32.611401Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":194384419,"revision":18162,"compact-revision":15580} {"level":"info","ts":"2026-06-23T19:29:32.509627Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20450} {"level":"info","ts":"2026-06-23T19:29:32.614926Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20450,"took":"102.3281ms","hash":125836176,"current-db-size-bytes":58654720,"current-db-size":"59 MB","current-db-size-in-use-bytes":44044288,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-06-23T19:29:32.615003Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":125836176,"revision":20450,"compact-revision":18162} {"level":"warn","ts":"2026-06-23T19:30:45.922301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.868526ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:30:45.922601Z","caller":"traceutil/trace.go:171","msg":"trace[1179217608] transaction","detail":"{read_only:false; response_revision:24387; number_of_response:1; }","duration":"140.241996ms","start":"2026-06-23T19:30:45.782336Z","end":"2026-06-23T19:30:45.922578Z","steps":["trace[1179217608] 'process raft request' (duration: 140.166404ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:45.922603Z","caller":"traceutil/trace.go:171","msg":"trace[2005694333] transaction","detail":"{read_only:false; response_revision:24385; number_of_response:1; }","duration":"143.473158ms","start":"2026-06-23T19:30:45.779074Z","end":"2026-06-23T19:30:45.922548Z","steps":["trace[2005694333] 'process raft request' (duration: 11.284263ms)","trace[2005694333] 'compare' (duration: 131.669881ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:45.922748Z","caller":"traceutil/trace.go:171","msg":"trace[1207854985] transaction","detail":"{read_only:false; response_revision:24386; number_of_response:1; }","duration":"142.201152ms","start":"2026-06-23T19:30:45.780526Z","end":"2026-06-23T19:30:45.922727Z","steps":["trace[1207854985] 'process raft request' (duration: 141.906714ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:51.080634Z","caller":"traceutil/trace.go:171","msg":"trace[198857600] transaction","detail":"{read_only:false; response_revision:24420; number_of_response:1; }","duration":"113.476069ms","start":"2026-06-23T19:30:50.967137Z","end":"2026-06-23T19:30:51.080613Z","steps":["trace[198857600] 'process raft request' (duration: 113.328335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:51.471488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.887742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:30:51.471561Z","caller":"traceutil/trace.go:171","msg":"trace[2109331655] linearizableReadLoop","detail":"{readStateIndex:25215; appliedIndex:25213; }","duration":"423.592191ms","start":"2026-06-23T19:30:51.047956Z","end":"2026-06-23T19:30:51.471548Z","steps":["trace[2109331655] 'read index received' (duration: 32.451169ms)","trace[2109331655] 'applied index is now lower than readState.Index' (duration: 391.140132ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:51.471696Z","caller":"traceutil/trace.go:171","msg":"trace[2094656100] transaction","detail":"{read_only:false; response_revision:24421; number_of_response:1; }","duration":"502.648275ms","start":"2026-06-23T19:30:50.96904Z","end":"2026-06-23T19:30:51.471689Z","steps":["trace[2094656100] 'process raft request' (duration: 263.453835ms)","trace[2094656100] 'compare' (duration: 238.803979ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:30:51.47173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:50.969034Z","time spent":"502.678395ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:30:51.472092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.117515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:30:51.472178Z","caller":"traceutil/trace.go:171","msg":"trace[533276715] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedrainrules/; range_end:/registry/cluster.x-k8s.io/machinedrainrules0; response_count:0; response_revision:24421; }","duration":"424.238569ms","start":"2026-06-23T19:30:51.047915Z","end":"2026-06-23T19:30:51.472153Z","steps":["trace[533276715] 'agreement among raft nodes before linearized reading' (duration: 424.086125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:51.472237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:51.047896Z","time spent":"424.325302ms","remote":"127.0.0.1:47738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinedrainrules/\" range_end:\"/registry/cluster.x-k8s.io/machinedrainrules0\" count_only:true "} {"level":"warn","ts":"2026-06-23T19:30:51.797486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.623292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:30:51.797702Z","caller":"traceutil/trace.go:171","msg":"trace[1278407186] transaction","detail":"{read_only:false; response_revision:24423; number_of_response:1; }","duration":"133.679429ms","start":"2026-06-23T19:30:51.664005Z","end":"2026-06-23T19:30:51.797685Z","steps":["trace[1278407186] 'process raft request' (duration: 133.601547ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:51.797818Z","caller":"traceutil/trace.go:171","msg":"trace[482388040] linearizableReadLoop","detail":"{readStateIndex:25216; appliedIndex:25215; }","duration":"326.183871ms","start":"2026-06-23T19:30:51.471574Z","end":"2026-06-23T19:30:51.797758Z","steps":["trace[482388040] 'read index received' (duration: 182.087215ms)","trace[482388040] 'applied index is now lower than readState.Index' (duration: 144.090576ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:30:51.797882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.511388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T19:30:51.797887Z","caller":"traceutil/trace.go:171","msg":"trace[1289014647] transaction","detail":"{read_only:false; response_revision:24422; number_of_response:1; }","duration":"411.138264ms","start":"2026-06-23T19:30:51.386698Z","end":"2026-06-23T19:30:51.797837Z","steps":["trace[1289014647] 'process raft request' (duration: 267.051089ms)","trace[1289014647] 'compare' (duration: 143.381345ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:51.797969Z","caller":"traceutil/trace.go:171","msg":"trace[446168117] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24423; }","duration":"526.61324ms","start":"2026-06-23T19:30:51.271331Z","end":"2026-06-23T19:30:51.797944Z","steps":["trace[446168117] 'agreement among raft nodes before linearized reading' (duration: 526.448296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:51.797992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.626777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-655958ddbb-r6jq7.18bbcb1a4c04583f\" ","response":"range_response_count:1 size:2109"} {"level":"warn","ts":"2026-06-23T19:30:51.798027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:51.271274Z","time spent":"526.737634ms","remote":"127.0.0.1:35752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-06-23T19:30:51.798075Z","caller":"traceutil/trace.go:171","msg":"trace[555354337] range","detail":"{range_begin:/registry/events/openstack/glance-api-655958ddbb-r6jq7.18bbcb1a4c04583f; range_end:; response_count:1; response_revision:24423; }","duration":"558.74533ms","start":"2026-06-23T19:30:51.239307Z","end":"2026-06-23T19:30:51.798052Z","steps":["trace[555354337] 'agreement among raft nodes before linearized reading' (duration: 558.507954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:51.798112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:51.239296Z","time spent":"558.807652ms","remote":"127.0.0.1:45942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":2132,"request content":"key:\"/registry/events/openstack/glance-api-655958ddbb-r6jq7.18bbcb1a4c04583f\" "} {"level":"warn","ts":"2026-06-23T19:30:51.798106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.604451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-23T19:30:51.798136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:51.386671Z","time spent":"411.307379ms","remote":"127.0.0.1:46152","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-06-23T19:30:51.798194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.590083ms","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-06-23T19:30:51.798198Z","caller":"traceutil/trace.go:171","msg":"trace[1673736092] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24423; }","duration":"577.701724ms","start":"2026-06-23T19:30:51.220474Z","end":"2026-06-23T19:30:51.798176Z","steps":["trace[1673736092] 'agreement among raft nodes before linearized reading' (duration: 577.464747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:51.798276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:51.220414Z","time spent":"577.848647ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-23T19:30:51.798337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.149995ms","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-06-23T19:30:51.798376Z","caller":"traceutil/trace.go:171","msg":"trace[619640682] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24423; }","duration":"102.238227ms","start":"2026-06-23T19:30:51.696126Z","end":"2026-06-23T19:30:51.798365Z","steps":["trace[619640682] 'agreement among raft nodes before linearized reading' (duration: 102.142975ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:51.798622Z","caller":"traceutil/trace.go:171","msg":"trace[1463554196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24423; }","duration":"157.700026ms","start":"2026-06-23T19:30:51.640532Z","end":"2026-06-23T19:30:51.798232Z","steps":["trace[1463554196] 'agreement among raft nodes before linearized reading' (duration: 157.461719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:52.071319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.949389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:30:52.071468Z","caller":"traceutil/trace.go:171","msg":"trace[959753536] transaction","detail":"{read_only:false; response_revision:24424; number_of_response:1; }","duration":"270.555818ms","start":"2026-06-23T19:30:51.800891Z","end":"2026-06-23T19:30:52.071447Z","steps":["trace[959753536] 'process raft request' (duration: 138.375223ms)","trace[959753536] 'compare' (duration: 131.698522ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:52.07725Z","caller":"traceutil/trace.go:171","msg":"trace[784601346] transaction","detail":"{read_only:false; response_revision:24425; number_of_response:1; }","duration":"275.52082ms","start":"2026-06-23T19:30:51.801689Z","end":"2026-06-23T19:30:52.07721Z","steps":["trace[784601346] 'process raft request' (duration: 275.097378ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:52.07777Z","caller":"traceutil/trace.go:171","msg":"trace[326290798] transaction","detail":"{read_only:false; response_revision:24426; number_of_response:1; }","duration":"275.474588ms","start":"2026-06-23T19:30:51.802264Z","end":"2026-06-23T19:30:52.077739Z","steps":["trace[326290798] 'process raft request' (duration: 274.865961ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:52.078005Z","caller":"traceutil/trace.go:171","msg":"trace[1430539534] transaction","detail":"{read_only:false; response_revision:24427; number_of_response:1; }","duration":"275.105658ms","start":"2026-06-23T19:30:51.802867Z","end":"2026-06-23T19:30:52.077972Z","steps":["trace[1430539534] 'process raft request' (duration: 274.727027ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:52.07819Z","caller":"traceutil/trace.go:171","msg":"trace[2103411512] transaction","detail":"{read_only:false; response_revision:24428; number_of_response:1; }","duration":"274.613794ms","start":"2026-06-23T19:30:51.803556Z","end":"2026-06-23T19:30:52.078169Z","steps":["trace[2103411512] 'process raft request' (duration: 274.205293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:52.07837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.522634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:30:52.078441Z","caller":"traceutil/trace.go:171","msg":"trace[1976388595] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24428; }","duration":"140.668308ms","start":"2026-06-23T19:30:51.937757Z","end":"2026-06-23T19:30:52.078426Z","steps":["trace[1976388595] 'agreement among raft nodes before linearized reading' (duration: 140.527464ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:52.078018Z","caller":"traceutil/trace.go:171","msg":"trace[1290268824] linearizableReadLoop","detail":"{readStateIndex:25222; appliedIndex:25217; }","duration":"140.173084ms","start":"2026-06-23T19:30:51.937814Z","end":"2026-06-23T19:30:52.077987Z","steps":["trace[1290268824] 'read index received' (duration: 1.477493ms)","trace[1290268824] 'applied index is now lower than readState.Index' (duration: 138.682441ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:52.407398Z","caller":"traceutil/trace.go:171","msg":"trace[1802625013] linearizableReadLoop","detail":"{readStateIndex:25225; appliedIndex:25222; }","duration":"327.90806ms","start":"2026-06-23T19:30:52.079465Z","end":"2026-06-23T19:30:52.407373Z","steps":["trace[1802625013] 'read index received' (duration: 327.698664ms)","trace[1802625013] 'applied index is now lower than readState.Index' (duration: 208.256µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:52.407452Z","caller":"traceutil/trace.go:171","msg":"trace[1009861273] transaction","detail":"{read_only:false; response_revision:24429; number_of_response:1; }","duration":"463.922986ms","start":"2026-06-23T19:30:51.943482Z","end":"2026-06-23T19:30:52.407405Z","steps":["trace[1009861273] 'process raft request' (duration: 463.627548ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:52.407476Z","caller":"traceutil/trace.go:171","msg":"trace[1489741300] transaction","detail":"{read_only:false; response_revision:24430; number_of_response:1; }","duration":"462.221397ms","start":"2026-06-23T19:30:51.945224Z","end":"2026-06-23T19:30:52.407445Z","steps":["trace[1489741300] 'process raft request' (duration: 462.055793ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:52.40753Z","caller":"traceutil/trace.go:171","msg":"trace[388158202] transaction","detail":"{read_only:false; response_revision:24431; number_of_response:1; }","duration":"458.993104ms","start":"2026-06-23T19:30:51.948511Z","end":"2026-06-23T19:30:52.407504Z","steps":["trace[388158202] 'process raft request' (duration: 458.818399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:52.407641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:51.948495Z","time spent":"459.067907ms","remote":"127.0.0.1:46152","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-06-23T19:30:52.407645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:51.943449Z","time spent":"464.091201ms","remote":"127.0.0.1:46152","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-06-23T19:30:52.407653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:51.945207Z","time spent":"462.33493ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:30:52.407712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.195678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:30:52.407838Z","caller":"traceutil/trace.go:171","msg":"trace[252686587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24431; }","duration":"328.390234ms","start":"2026-06-23T19:30:52.079422Z","end":"2026-06-23T19:30:52.407813Z","steps":["trace[252686587] 'agreement among raft nodes before linearized reading' (duration: 328.125156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:52.407902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:52.079404Z","time spent":"328.488827ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T19:30:52.492572Z","caller":"traceutil/trace.go:171","msg":"trace[1836377744] transaction","detail":"{read_only:false; response_revision:24432; number_of_response:1; }","duration":"373.66878ms","start":"2026-06-23T19:30:52.118871Z","end":"2026-06-23T19:30:52.49254Z","steps":["trace[1836377744] 'process raft request' (duration: 358.881137ms)","trace[1836377744] 'compare' (duration: 14.500975ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:30:52.492761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:52.118841Z","time spent":"373.826594ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:30:52.493065Z","caller":"traceutil/trace.go:171","msg":"trace[1237149201] transaction","detail":"{read_only:false; response_revision:24433; number_of_response:1; }","duration":"191.545115ms","start":"2026-06-23T19:30:52.30149Z","end":"2026-06-23T19:30:52.493035Z","steps":["trace[1237149201] 'process raft request' (duration: 190.992409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:52.493311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.324815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-23T19:30:52.493392Z","caller":"traceutil/trace.go:171","msg":"trace[1513661775] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24433; }","duration":"267.427748ms","start":"2026-06-23T19:30:52.225931Z","end":"2026-06-23T19:30:52.493359Z","steps":["trace[1513661775] 'agreement among raft nodes before linearized reading' (duration: 267.14887ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:52.773237Z","caller":"traceutil/trace.go:171","msg":"trace[912149614] linearizableReadLoop","detail":"{readStateIndex:25229; appliedIndex:25227; }","duration":"254.192109ms","start":"2026-06-23T19:30:52.51902Z","end":"2026-06-23T19:30:52.773212Z","steps":["trace[912149614] 'read index received' (duration: 73.012901ms)","trace[912149614] 'applied index is now lower than readState.Index' (duration: 181.178367ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:52.773408Z","caller":"traceutil/trace.go:171","msg":"trace[2057595123] transaction","detail":"{read_only:false; response_revision:24435; number_of_response:1; }","duration":"274.772708ms","start":"2026-06-23T19:30:52.498576Z","end":"2026-06-23T19:30:52.773349Z","steps":["trace[2057595123] 'process raft request' (duration: 274.48196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:52.773496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.522238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-23T19:30:52.773541Z","caller":"traceutil/trace.go:171","msg":"trace[2082671520] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24435; }","duration":"254.61189ms","start":"2026-06-23T19:30:52.518916Z","end":"2026-06-23T19:30:52.773528Z","steps":["trace[2082671520] 'agreement among raft nodes before linearized reading' (duration: 254.392894ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:53.873118Z","caller":"traceutil/trace.go:171","msg":"trace[1338407351] transaction","detail":"{read_only:false; response_revision:24439; number_of_response:1; }","duration":"106.890911ms","start":"2026-06-23T19:30:53.766207Z","end":"2026-06-23T19:30:53.873097Z","steps":["trace[1338407351] 'process raft request' (duration: 106.754017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:54.184778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.943014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:30:54.184926Z","caller":"traceutil/trace.go:171","msg":"trace[240878153] linearizableReadLoop","detail":"{readStateIndex:25234; appliedIndex:25233; }","duration":"244.552853ms","start":"2026-06-23T19:30:53.940351Z","end":"2026-06-23T19:30:54.184904Z","steps":["trace[240878153] 'read index received' (duration: 79.324052ms)","trace[240878153] 'applied index is now lower than readState.Index' (duration: 165.226951ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:54.184972Z","caller":"traceutil/trace.go:171","msg":"trace[890779801] transaction","detail":"{read_only:false; response_revision:24440; number_of_response:1; }","duration":"381.377392ms","start":"2026-06-23T19:30:53.803553Z","end":"2026-06-23T19:30:54.18493Z","steps":["trace[890779801] 'process raft request' (duration: 216.194212ms)","trace[890779801] 'compare' (duration: 164.81437ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:30:54.185043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.695897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:30:54.185072Z","caller":"traceutil/trace.go:171","msg":"trace[871662170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24440; }","duration":"244.725898ms","start":"2026-06-23T19:30:53.940336Z","end":"2026-06-23T19:30:54.185062Z","steps":["trace[871662170] 'agreement among raft nodes before linearized reading' (duration: 244.668946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:54.185165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.909688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-23T19:30:54.185156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:53.803524Z","time spent":"381.532176ms","remote":"127.0.0.1:46152","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-06-23T19:30:54.185178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.333569ms","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-06-23T19:30:54.185213Z","caller":"traceutil/trace.go:171","msg":"trace[1547695914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24440; }","duration":"102.001681ms","start":"2026-06-23T19:30:54.083204Z","end":"2026-06-23T19:30:54.185205Z","steps":["trace[1547695914] 'agreement among raft nodes before linearized reading' (duration: 101.884928ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:54.18524Z","caller":"traceutil/trace.go:171","msg":"trace[970456556] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24440; }","duration":"103.440632ms","start":"2026-06-23T19:30:54.081784Z","end":"2026-06-23T19:30:54.185225Z","steps":["trace[970456556] 'agreement among raft nodes before linearized reading' (duration: 103.264937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:54.185301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.99183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-23T19:30:54.185318Z","caller":"traceutil/trace.go:171","msg":"trace[200331260] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24440; }","duration":"102.016861ms","start":"2026-06-23T19:30:54.083294Z","end":"2026-06-23T19:30:54.185311Z","steps":["trace[200331260] 'agreement among raft nodes before linearized reading' (duration: 101.969089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:54.185461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.936718ms","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-06-23T19:30:54.185527Z","caller":"traceutil/trace.go:171","msg":"trace[747225513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24440; }","duration":"103.072611ms","start":"2026-06-23T19:30:54.082431Z","end":"2026-06-23T19:30:54.185503Z","steps":["trace[747225513] 'agreement among raft nodes before linearized reading' (duration: 102.919597ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:54.420607Z","caller":"traceutil/trace.go:171","msg":"trace[230203500] linearizableReadLoop","detail":"{readStateIndex:25238; appliedIndex:25235; }","duration":"229.373658ms","start":"2026-06-23T19:30:54.191214Z","end":"2026-06-23T19:30:54.420587Z","steps":["trace[230203500] 'read index received' (duration: 90.195134ms)","trace[230203500] 'applied index is now lower than readState.Index' (duration: 139.177724ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:30:54.42071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.474932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T19:30:54.420734Z","caller":"traceutil/trace.go:171","msg":"trace[1265262468] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:24444; }","duration":"229.531813ms","start":"2026-06-23T19:30:54.191193Z","end":"2026-06-23T19:30:54.420725Z","steps":["trace[1265262468] 'agreement among raft nodes before linearized reading' (duration: 229.471402ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:54.420882Z","caller":"traceutil/trace.go:171","msg":"trace[505719388] transaction","detail":"{read_only:false; response_revision:24444; number_of_response:1; }","duration":"229.801131ms","start":"2026-06-23T19:30:54.191073Z","end":"2026-06-23T19:30:54.420874Z","steps":["trace[505719388] 'process raft request' (duration: 229.481822ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:54.420818Z","caller":"traceutil/trace.go:171","msg":"trace[913513597] transaction","detail":"{read_only:false; response_revision:24443; number_of_response:1; }","duration":"230.907223ms","start":"2026-06-23T19:30:54.189895Z","end":"2026-06-23T19:30:54.420803Z","steps":["trace[913513597] 'process raft request' (duration: 230.618334ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:54.421037Z","caller":"traceutil/trace.go:171","msg":"trace[564266121] transaction","detail":"{read_only:false; response_revision:24442; number_of_response:1; }","duration":"231.402658ms","start":"2026-06-23T19:30:54.189612Z","end":"2026-06-23T19:30:54.421015Z","steps":["trace[564266121] 'process raft request' (duration: 213.810463ms)","trace[564266121] 'compare' (duration: 16.874753ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:54.568893Z","caller":"traceutil/trace.go:171","msg":"trace[1066192471] transaction","detail":"{read_only:false; response_revision:24445; number_of_response:1; }","duration":"155.796981ms","start":"2026-06-23T19:30:54.413072Z","end":"2026-06-23T19:30:54.568869Z","steps":["trace[1066192471] 'process raft request' (duration: 142.571933ms)","trace[1066192471] 'compare' (duration: 12.93634ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:54.726937Z","caller":"traceutil/trace.go:171","msg":"trace[47003737] transaction","detail":"{read_only:false; response_revision:24446; number_of_response:1; }","duration":"312.748917ms","start":"2026-06-23T19:30:54.414139Z","end":"2026-06-23T19:30:54.726888Z","steps":["trace[47003737] 'process raft request' (duration: 310.553634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:54.727093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:54.414118Z","time spent":"312.89739ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:30:54.727132Z","caller":"traceutil/trace.go:171","msg":"trace[776034479] linearizableReadLoop","detail":"{readStateIndex:25242; appliedIndex:25238; }","duration":"192.457652ms","start":"2026-06-23T19:30:54.534478Z","end":"2026-06-23T19:30:54.726936Z","steps":["trace[776034479] 'read index received' (duration: 21.178577ms)","trace[776034479] 'applied index is now lower than readState.Index' (duration: 171.277175ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:54.727229Z","caller":"traceutil/trace.go:171","msg":"trace[2051911553] transaction","detail":"{read_only:false; response_revision:24448; number_of_response:1; }","duration":"228.70836ms","start":"2026-06-23T19:30:54.498506Z","end":"2026-06-23T19:30:54.727214Z","steps":["trace[2051911553] 'process raft request' (duration: 228.280058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:54.727289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.799152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:30:54.727335Z","caller":"traceutil/trace.go:171","msg":"trace[1294538595] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:24448; }","duration":"192.851673ms","start":"2026-06-23T19:30:54.53447Z","end":"2026-06-23T19:30:54.727321Z","steps":["trace[1294538595] 'agreement among raft nodes before linearized reading' (duration: 192.759991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:54.727401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.71209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-23T19:30:54.727453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.996102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-23T19:30:54.727483Z","caller":"traceutil/trace.go:171","msg":"trace[1981982668] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:24448; }","duration":"182.046913ms","start":"2026-06-23T19:30:54.545427Z","end":"2026-06-23T19:30:54.727474Z","steps":["trace[1981982668] 'agreement among raft nodes before linearized reading' (duration: 181.895989ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:54.727486Z","caller":"traceutil/trace.go:171","msg":"trace[49698463] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:24448; }","duration":"184.849183ms","start":"2026-06-23T19:30:54.542618Z","end":"2026-06-23T19:30:54.727468Z","steps":["trace[49698463] 'agreement among raft nodes before linearized reading' (duration: 184.648798ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:54.726843Z","caller":"traceutil/trace.go:171","msg":"trace[1914990] transaction","detail":"{read_only:false; response_revision:24447; number_of_response:1; }","duration":"312.543611ms","start":"2026-06-23T19:30:54.414275Z","end":"2026-06-23T19:30:54.726818Z","steps":["trace[1914990] 'process raft request' (duration: 312.477909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:54.727825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:54.414267Z","time spent":"313.419225ms","remote":"127.0.0.1:46152","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-06-23T19:30:54.727998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.820355ms","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-06-23T19:30:54.728056Z","caller":"traceutil/trace.go:171","msg":"trace[1560972998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24448; }","duration":"131.910218ms","start":"2026-06-23T19:30:54.596137Z","end":"2026-06-23T19:30:54.728047Z","steps":["trace[1560972998] 'agreement among raft nodes before linearized reading' (duration: 131.187977ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:54.897219Z","caller":"traceutil/trace.go:171","msg":"trace[1381306973] linearizableReadLoop","detail":"{readStateIndex:25244; appliedIndex:25243; }","duration":"111.544344ms","start":"2026-06-23T19:30:54.785644Z","end":"2026-06-23T19:30:54.897188Z","steps":["trace[1381306973] 'read index received' (duration: 109.530677ms)","trace[1381306973] 'applied index is now lower than readState.Index' (duration: 2.012687ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:54.897338Z","caller":"traceutil/trace.go:171","msg":"trace[461867096] transaction","detail":"{read_only:false; response_revision:24450; number_of_response:1; }","duration":"114.922412ms","start":"2026-06-23T19:30:54.782361Z","end":"2026-06-23T19:30:54.897283Z","steps":["trace[461867096] 'process raft request' (duration: 112.801461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:54.897495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.815782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:30:54.897599Z","caller":"traceutil/trace.go:171","msg":"trace[777303994] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24450; }","duration":"111.968767ms","start":"2026-06-23T19:30:54.785601Z","end":"2026-06-23T19:30:54.89757Z","steps":["trace[777303994] 'agreement among raft nodes before linearized reading' (duration: 111.780212ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:55.464104Z","caller":"traceutil/trace.go:171","msg":"trace[76746202] linearizableReadLoop","detail":"{readStateIndex:25245; appliedIndex:25244; }","duration":"209.013396ms","start":"2026-06-23T19:30:55.255067Z","end":"2026-06-23T19:30:55.46408Z","steps":["trace[76746202] 'read index received' (duration: 208.766359ms)","trace[76746202] 'applied index is now lower than readState.Index' (duration: 246.207µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:55.464146Z","caller":"traceutil/trace.go:171","msg":"trace[1662818911] transaction","detail":"{read_only:false; response_revision:24451; number_of_response:1; }","duration":"295.075199ms","start":"2026-06-23T19:30:55.169056Z","end":"2026-06-23T19:30:55.464132Z","steps":["trace[1662818911] 'process raft request' (duration: 294.864344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:55.464322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.995828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-06-23T19:30:55.464309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.213661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:30:55.464364Z","caller":"traceutil/trace.go:171","msg":"trace[958548987] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24451; }","duration":"192.093332ms","start":"2026-06-23T19:30:55.272258Z","end":"2026-06-23T19:30:55.464351Z","steps":["trace[958548987] 'agreement among raft nodes before linearized reading' (duration: 191.942897ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:55.464409Z","caller":"traceutil/trace.go:171","msg":"trace[1919514095] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:24451; }","duration":"209.369976ms","start":"2026-06-23T19:30:55.255011Z","end":"2026-06-23T19:30:55.464381Z","steps":["trace[1919514095] 'agreement among raft nodes before linearized reading' (duration: 209.16927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:55.464305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.952303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:30:55.464503Z","caller":"traceutil/trace.go:171","msg":"trace[1049554294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24451; }","duration":"129.188569ms","start":"2026-06-23T19:30:55.335297Z","end":"2026-06-23T19:30:55.464486Z","steps":["trace[1049554294] 'agreement among raft nodes before linearized reading' (duration: 128.961743ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:55.678458Z","caller":"traceutil/trace.go:171","msg":"trace[1789899787] linearizableReadLoop","detail":"{readStateIndex:25246; appliedIndex:25245; }","duration":"155.186504ms","start":"2026-06-23T19:30:55.52324Z","end":"2026-06-23T19:30:55.678426Z","steps":["trace[1789899787] 'read index received' (duration: 107.633632ms)","trace[1789899787] 'applied index is now lower than readState.Index' (duration: 47.551462ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:55.678518Z","caller":"traceutil/trace.go:171","msg":"trace[502896922] transaction","detail":"{read_only:false; response_revision:24452; number_of_response:1; }","duration":"157.791138ms","start":"2026-06-23T19:30:55.520687Z","end":"2026-06-23T19:30:55.678479Z","steps":["trace[502896922] 'process raft request' (duration: 110.170555ms)","trace[502896922] 'compare' (duration: 47.420928ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:30:55.678641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.366999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:30:55.678731Z","caller":"traceutil/trace.go:171","msg":"trace[1830450225] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24452; }","duration":"155.481032ms","start":"2026-06-23T19:30:55.523227Z","end":"2026-06-23T19:30:55.678708Z","steps":["trace[1830450225] 'agreement among raft nodes before linearized reading' (duration: 155.306867ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:55.744341Z","caller":"traceutil/trace.go:171","msg":"trace[7053968] transaction","detail":"{read_only:false; response_revision:24453; number_of_response:1; }","duration":"210.653722ms","start":"2026-06-23T19:30:55.533654Z","end":"2026-06-23T19:30:55.744308Z","steps":["trace[7053968] 'process raft request' (duration: 210.443556ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:55.744564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.177648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.191\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-23T19:30:55.744726Z","caller":"traceutil/trace.go:171","msg":"trace[1578774286] range","detail":"{range_begin:/registry/masterleases/199.19.213.191; range_end:; response_count:1; response_revision:24453; }","duration":"116.421424ms","start":"2026-06-23T19:30:55.62825Z","end":"2026-06-23T19:30:55.744672Z","steps":["trace[1578774286] 'agreement among raft nodes before linearized reading' (duration: 116.057614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:56.015754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.515934ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:30:56.015844Z","caller":"traceutil/trace.go:171","msg":"trace[387497412] linearizableReadLoop","detail":"{readStateIndex:25249; appliedIndex:25248; }","duration":"247.041044ms","start":"2026-06-23T19:30:55.76879Z","end":"2026-06-23T19:30:56.015831Z","steps":["trace[387497412] 'read index received' (duration: 40.358155ms)","trace[387497412] 'applied index is now lower than readState.Index' (duration: 206.681979ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:56.015871Z","caller":"traceutil/trace.go:171","msg":"trace[1199595149] transaction","detail":"{read_only:false; response_revision:24454; number_of_response:1; }","duration":"247.078185ms","start":"2026-06-23T19:30:55.768758Z","end":"2026-06-23T19:30:56.015836Z","steps":["trace[1199595149] 'process raft request' (duration: 40.397106ms)","trace[1199595149] 'compare' (duration: 206.34155ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:30:56.01603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.23804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18433"} {"level":"info","ts":"2026-06-23T19:30:56.016068Z","caller":"traceutil/trace.go:171","msg":"trace[1326528780] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24454; }","duration":"247.312473ms","start":"2026-06-23T19:30:55.768747Z","end":"2026-06-23T19:30:56.016059Z","steps":["trace[1326528780] 'agreement among raft nodes before linearized reading' (duration: 247.155628ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:56.559792Z","caller":"traceutil/trace.go:171","msg":"trace[618606869] linearizableReadLoop","detail":"{readStateIndex:25252; appliedIndex:25251; }","duration":"135.428948ms","start":"2026-06-23T19:30:56.424345Z","end":"2026-06-23T19:30:56.559774Z","steps":["trace[618606869] 'read index received' (duration: 135.279424ms)","trace[618606869] 'applied index is now lower than readState.Index' (duration: 148.684µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:30:56.560192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.627615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-23T19:30:56.560183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.823589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-23T19:30:56.560218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.08485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-23T19:30:56.560243Z","caller":"traceutil/trace.go:171","msg":"trace[1469677793] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24457; }","duration":"135.935922ms","start":"2026-06-23T19:30:56.424297Z","end":"2026-06-23T19:30:56.560233Z","steps":["trace[1469677793] 'agreement among raft nodes before linearized reading' (duration: 135.783978ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:56.560196Z","caller":"traceutil/trace.go:171","msg":"trace[1845424110] transaction","detail":"{read_only:false; response_revision:24457; number_of_response:1; }","duration":"153.312131ms","start":"2026-06-23T19:30:56.406805Z","end":"2026-06-23T19:30:56.560117Z","steps":["trace[1845424110] 'process raft request' (duration: 152.824507ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:56.560273Z","caller":"traceutil/trace.go:171","msg":"trace[120945118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24457; }","duration":"134.714358ms","start":"2026-06-23T19:30:56.425501Z","end":"2026-06-23T19:30:56.560216Z","steps":["trace[120945118] 'agreement among raft nodes before linearized reading' (duration: 134.577274ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:56.560279Z","caller":"traceutil/trace.go:171","msg":"trace[2144981877] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24457; }","duration":"134.147282ms","start":"2026-06-23T19:30:56.426115Z","end":"2026-06-23T19:30:56.560262Z","steps":["trace[2144981877] 'agreement among raft nodes before linearized reading' (duration: 133.985987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:56.875982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.929761ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:30:56.876194Z","caller":"traceutil/trace.go:171","msg":"trace[1958474776] linearizableReadLoop","detail":"{readStateIndex:25256; appliedIndex:25253; }","duration":"282.786058ms","start":"2026-06-23T19:30:56.593391Z","end":"2026-06-23T19:30:56.876177Z","steps":["trace[1958474776] 'read index received' (duration: 130.513478ms)","trace[1958474776] 'applied index is now lower than readState.Index' (duration: 152.27173ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:56.876272Z","caller":"traceutil/trace.go:171","msg":"trace[992936833] transaction","detail":"{read_only:false; response_revision:24459; number_of_response:1; }","duration":"312.121448ms","start":"2026-06-23T19:30:56.564138Z","end":"2026-06-23T19:30:56.87626Z","steps":["trace[992936833] 'process raft request' (duration: 159.833456ms)","trace[992936833] 'compare' (duration: 151.754846ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:30:56.876331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:56.564132Z","time spent":"312.16641ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:30:56.876365Z","caller":"traceutil/trace.go:171","msg":"trace[1537444721] transaction","detail":"{read_only:false; response_revision:24461; number_of_response:1; }","duration":"302.870804ms","start":"2026-06-23T19:30:56.573476Z","end":"2026-06-23T19:30:56.876347Z","steps":["trace[1537444721] 'process raft request' (duration: 302.654778ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:56.876396Z","caller":"traceutil/trace.go:171","msg":"trace[943456203] transaction","detail":"{read_only:false; response_revision:24460; number_of_response:1; }","duration":"311.379717ms","start":"2026-06-23T19:30:56.564971Z","end":"2026-06-23T19:30:56.876351Z","steps":["trace[943456203] 'process raft request' (duration: 311.105399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:56.876433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:56.573462Z","time spent":"302.929465ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:30:56.876532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.119019ms","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:6"} {"level":"warn","ts":"2026-06-23T19:30:56.876565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:30:56.564945Z","time spent":"311.532512ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:30:56.876602Z","caller":"traceutil/trace.go:171","msg":"trace[376163595] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:24461; }","duration":"283.232092ms","start":"2026-06-23T19:30:56.593352Z","end":"2026-06-23T19:30:56.876584Z","steps":["trace[376163595] 'agreement among raft nodes before linearized reading' (duration: 283.039736ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:56.879285Z","caller":"traceutil/trace.go:171","msg":"trace[1593028073] transaction","detail":"{read_only:false; response_revision:24462; number_of_response:1; }","duration":"147.535296ms","start":"2026-06-23T19:30:56.731733Z","end":"2026-06-23T19:30:56.879269Z","steps":["trace[1593028073] 'process raft request' (duration: 147.460114ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:57.025896Z","caller":"traceutil/trace.go:171","msg":"trace[1936184575] transaction","detail":"{read_only:false; response_revision:24463; number_of_response:1; }","duration":"293.99808ms","start":"2026-06-23T19:30:56.731872Z","end":"2026-06-23T19:30:57.02587Z","steps":["trace[1936184575] 'process raft request' (duration: 293.244798ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:57.025988Z","caller":"traceutil/trace.go:171","msg":"trace[392601414] transaction","detail":"{read_only:false; response_revision:24464; number_of_response:1; }","duration":"293.518765ms","start":"2026-06-23T19:30:56.732447Z","end":"2026-06-23T19:30:57.025966Z","steps":["trace[392601414] 'process raft request' (duration: 293.229127ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:57.026416Z","caller":"traceutil/trace.go:171","msg":"trace[1323679845] linearizableReadLoop","detail":"{readStateIndex:25260; appliedIndex:25256; }","duration":"150.172811ms","start":"2026-06-23T19:30:56.876229Z","end":"2026-06-23T19:30:57.026402Z","steps":["trace[1323679845] 'read index received' (duration: 3.024346ms)","trace[1323679845] 'applied index is now lower than readState.Index' (duration: 147.147575ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:30:57.026462Z","caller":"traceutil/trace.go:171","msg":"trace[529614668] transaction","detail":"{read_only:false; response_revision:24465; number_of_response:1; }","duration":"223.616615ms","start":"2026-06-23T19:30:56.802816Z","end":"2026-06-23T19:30:57.026432Z","steps":["trace[529614668] 'process raft request' (duration: 222.924854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:57.026635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.66784ms","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-06-23T19:30:57.026685Z","caller":"traceutil/trace.go:171","msg":"trace[1919708412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24465; }","duration":"272.782813ms","start":"2026-06-23T19:30:56.75388Z","end":"2026-06-23T19:30:57.026663Z","steps":["trace[1919708412] 'agreement among raft nodes before linearized reading' (duration: 272.638049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:30:57.027307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.510995ms","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-06-23T19:30:57.027347Z","caller":"traceutil/trace.go:171","msg":"trace[1143314718] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24465; }","duration":"125.578906ms","start":"2026-06-23T19:30:56.901758Z","end":"2026-06-23T19:30:57.027337Z","steps":["trace[1143314718] 'agreement among raft nodes before linearized reading' (duration: 125.030241ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:57.149092Z","caller":"traceutil/trace.go:171","msg":"trace[1344235417] transaction","detail":"{read_only:false; response_revision:24467; number_of_response:1; }","duration":"118.571335ms","start":"2026-06-23T19:30:57.030491Z","end":"2026-06-23T19:30:57.149063Z","steps":["trace[1344235417] 'process raft request' (duration: 118.495003ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:30:57.149129Z","caller":"traceutil/trace.go:171","msg":"trace[645153169] transaction","detail":"{read_only:false; response_revision:24466; number_of_response:1; }","duration":"118.951365ms","start":"2026-06-23T19:30:57.030147Z","end":"2026-06-23T19:30:57.149099Z","steps":["trace[645153169] 'process raft request' (duration: 116.562877ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:07.448187Z","caller":"traceutil/trace.go:171","msg":"trace[1583638291] transaction","detail":"{read_only:false; response_revision:24537; number_of_response:1; }","duration":"243.159444ms","start":"2026-06-23T19:31:07.205Z","end":"2026-06-23T19:31:07.44816Z","steps":["trace[1583638291] 'process raft request' (duration: 242.979559ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:08.071266Z","caller":"traceutil/trace.go:171","msg":"trace[1407739639] linearizableReadLoop","detail":"{readStateIndex:25335; appliedIndex:25333; }","duration":"816.339298ms","start":"2026-06-23T19:31:07.254896Z","end":"2026-06-23T19:31:08.071235Z","steps":["trace[1407739639] 'read index received' (duration: 193.08945ms)","trace[1407739639] 'applied index is now lower than readState.Index' (duration: 623.248708ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:08.071413Z","caller":"traceutil/trace.go:171","msg":"trace[1416899965] transaction","detail":"{read_only:false; response_revision:24538; number_of_response:1; }","duration":"865.126695ms","start":"2026-06-23T19:31:07.206232Z","end":"2026-06-23T19:31:08.071359Z","steps":["trace[1416899965] 'process raft request' (duration: 864.821307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.071536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.621285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"} {"level":"info","ts":"2026-06-23T19:31:08.071586Z","caller":"traceutil/trace.go:171","msg":"trace[717018812] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24538; }","duration":"816.738339ms","start":"2026-06-23T19:31:07.254831Z","end":"2026-06-23T19:31:08.071569Z","steps":["trace[717018812] 'agreement among raft nodes before linearized reading' (duration: 816.540594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.071634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:07.254805Z","time spent":"816.819301ms","remote":"127.0.0.1:46024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1877,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-23T19:31:08.071988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:07.206202Z","time spent":"865.319221ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:31:08.274544Z","caller":"traceutil/trace.go:171","msg":"trace[1664586131] transaction","detail":"{read_only:false; response_revision:24539; number_of_response:1; }","duration":"752.904281ms","start":"2026-06-23T19:31:07.521606Z","end":"2026-06-23T19:31:08.274511Z","steps":["trace[1664586131] 'process raft request' (duration: 748.411493ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.274694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:07.521588Z","time spent":"753.028854ms","remote":"127.0.0.1:46152","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-06-23T19:31:08.275642Z","caller":"traceutil/trace.go:171","msg":"trace[1350659712] linearizableReadLoop","detail":"{readStateIndex:25337; appliedIndex:25335; }","duration":"204.28972ms","start":"2026-06-23T19:31:08.071338Z","end":"2026-06-23T19:31:08.275627Z","steps":["trace[1350659712] 'read index received' (duration: 198.627078ms)","trace[1350659712] 'applied index is now lower than readState.Index' (duration: 5.657922ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:08.275649Z","caller":"traceutil/trace.go:171","msg":"trace[1640846293] transaction","detail":"{read_only:false; response_revision:24540; number_of_response:1; }","duration":"492.417682ms","start":"2026-06-23T19:31:07.783182Z","end":"2026-06-23T19:31:08.2756Z","steps":["trace[1640846293] 'process raft request' (duration: 490.437555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.275868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.226765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-23T19:31:08.27591Z","caller":"traceutil/trace.go:171","msg":"trace[2021303811] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24541; }","duration":"478.309678ms","start":"2026-06-23T19:31:07.797589Z","end":"2026-06-23T19:31:08.275899Z","steps":["trace[2021303811] 'agreement among raft nodes before linearized reading' (duration: 478.200875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.275933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:07.797547Z","time spent":"478.381519ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":556,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-06-23T19:31:08.275762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.902882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:08.276058Z","caller":"traceutil/trace.go:171","msg":"trace[284447990] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:24541; }","duration":"950.207281ms","start":"2026-06-23T19:31:07.325812Z","end":"2026-06-23T19:31:08.27602Z","steps":["trace[284447990] 'agreement among raft nodes before linearized reading' (duration: 949.910953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.275761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.526118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T19:31:08.276141Z","caller":"traceutil/trace.go:171","msg":"trace[1380678219] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:24541; }","duration":"739.9454ms","start":"2026-06-23T19:31:07.536185Z","end":"2026-06-23T19:31:08.276131Z","steps":["trace[1380678219] 'agreement among raft nodes before linearized reading' (duration: 739.510098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.276139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.669896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-62be58c9-4c4d-41eb-84bb-7d5e0d086221\" ","response":"range_response_count:1 size:1304"} {"level":"info","ts":"2026-06-23T19:31:08.276266Z","caller":"traceutil/trace.go:171","msg":"trace[828076292] range","detail":"{range_begin:/registry/persistentvolumes/pvc-62be58c9-4c4d-41eb-84bb-7d5e0d086221; range_end:; response_count:1; response_revision:24541; }","duration":"200.879621ms","start":"2026-06-23T19:31:08.075368Z","end":"2026-06-23T19:31:08.276247Z","steps":["trace[828076292] 'agreement among raft nodes before linearized reading' (duration: 200.407338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.276167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:07.536165Z","time spent":"739.992831ms","remote":"127.0.0.1:33550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":2,"response size":31,"request content":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-23T19:31:08.27653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:07.783157Z","time spent":"492.695539ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:31:08.276184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:07.325792Z","time spent":"950.350296ms","remote":"127.0.0.1:47862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":29,"request content":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true "} {"level":"warn","ts":"2026-06-23T19:31:08.74673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.552536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:31:08.746828Z","caller":"traceutil/trace.go:171","msg":"trace[1222788560] linearizableReadLoop","detail":"{readStateIndex:25339; appliedIndex:25338; }","duration":"465.093399ms","start":"2026-06-23T19:31:08.281718Z","end":"2026-06-23T19:31:08.746811Z","steps":["trace[1222788560] 'read index received' (duration: 134.401758ms)","trace[1222788560] 'applied index is now lower than readState.Index' (duration: 330.690381ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:08.746953Z","caller":"traceutil/trace.go:171","msg":"trace[1812561356] transaction","detail":"{read_only:false; response_revision:24542; number_of_response:1; }","duration":"465.983404ms","start":"2026-06-23T19:31:08.280945Z","end":"2026-06-23T19:31:08.746929Z","steps":["trace[1812561356] 'process raft request' (duration: 135.15921ms)","trace[1812561356] 'compare' (duration: 330.434173ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:31:08.747084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.451261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-23T19:31:08.747112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.250425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-06-23T19:31:08.747144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.280923Z","time spent":"466.152569ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:31:08.747147Z","caller":"traceutil/trace.go:171","msg":"trace[68751204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24542; }","duration":"295.559224ms","start":"2026-06-23T19:31:08.451573Z","end":"2026-06-23T19:31:08.747132Z","steps":["trace[68751204] 'agreement among raft nodes before linearized reading' (duration: 295.373318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.747099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.343509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:08.747285Z","caller":"traceutil/trace.go:171","msg":"trace[555852166] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:24542; }","duration":"221.577286ms","start":"2026-06-23T19:31:08.52569Z","end":"2026-06-23T19:31:08.747268Z","steps":["trace[555852166] 'agreement among raft nodes before linearized reading' (duration: 221.351239ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:08.747148Z","caller":"traceutil/trace.go:171","msg":"trace[102355624] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24542; }","duration":"104.314877ms","start":"2026-06-23T19:31:08.642822Z","end":"2026-06-23T19:31:08.747137Z","steps":["trace[102355624] 'agreement among raft nodes before linearized reading' (duration: 104.192203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.747641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.892463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-06-23T19:31:08.747743Z","caller":"traceutil/trace.go:171","msg":"trace[1029112000] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:24542; }","duration":"466.004366ms","start":"2026-06-23T19:31:08.281714Z","end":"2026-06-23T19:31:08.747718Z","steps":["trace[1029112000] 'agreement among raft nodes before linearized reading' (duration: 465.718198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:08.747807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.281684Z","time spent":"466.109548ms","remote":"127.0.0.1:46024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1805,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "} {"level":"warn","ts":"2026-06-23T19:31:09.260681Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912728132527252,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-23T19:31:09.447441Z","caller":"traceutil/trace.go:171","msg":"trace[587915446] transaction","detail":"{read_only:false; response_revision:24543; number_of_response:1; }","duration":"696.796304ms","start":"2026-06-23T19:31:08.750626Z","end":"2026-06-23T19:31:09.447422Z","steps":["trace[587915446] 'process raft request' (duration: 696.6645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:09.447669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.750605Z","time spent":"696.959858ms","remote":"127.0.0.1:46152","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-06-23T19:31:10.151738Z","caller":"traceutil/trace.go:171","msg":"trace[936693663] transaction","detail":"{read_only:false; response_revision:24546; number_of_response:1; }","duration":"1.232386223s","start":"2026-06-23T19:31:08.919328Z","end":"2026-06-23T19:31:10.151714Z","steps":["trace[936693663] 'process raft request' (duration: 1.232303021s)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:10.151821Z","caller":"traceutil/trace.go:171","msg":"trace[1805580586] transaction","detail":"{read_only:false; response_revision:24544; number_of_response:1; }","duration":"1.400685422s","start":"2026-06-23T19:31:08.75109Z","end":"2026-06-23T19:31:10.151776Z","steps":["trace[1805580586] 'process raft request' (duration: 1.400293271s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.151897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.919314Z","time spent":"1.232505036s","remote":"127.0.0.1:46152","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-06-23T19:31:10.151848Z","caller":"traceutil/trace.go:171","msg":"trace[270840917] transaction","detail":"{read_only:false; response_revision:24545; number_of_response:1; }","duration":"1.233425312s","start":"2026-06-23T19:31:08.918394Z","end":"2026-06-23T19:31:10.15182Z","steps":["trace[270840917] 'process raft request' (duration: 1.233188285s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.15199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.751074Z","time spent":"1.400825906s","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:31:10.152117Z","caller":"traceutil/trace.go:171","msg":"trace[760024804] transaction","detail":"{read_only:false; response_revision:24547; number_of_response:1; }","duration":"1.088711959s","start":"2026-06-23T19:31:09.063378Z","end":"2026-06-23T19:31:10.15209Z","steps":["trace[760024804] 'process raft request' (duration: 1.088296257s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.152172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.918376Z","time spent":"1.233591347s","remote":"127.0.0.1:46152","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-06-23T19:31:10.152244Z","caller":"traceutil/trace.go:171","msg":"trace[1888106154] transaction","detail":"{read_only:false; response_revision:24548; number_of_response:1; }","duration":"1.087470113s","start":"2026-06-23T19:31:09.064759Z","end":"2026-06-23T19:31:10.152229Z","steps":["trace[1888106154] 'process raft request' (duration: 1.087340039s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.152252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:09.063354Z","time spent":"1.088832892s","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:31:10.152327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:09.064733Z","time spent":"1.087554184s","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:31:10.152413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.391829528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-23T19:31:10.152466Z","caller":"traceutil/trace.go:171","msg":"trace[319079460] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:24548; }","duration":"1.391926381s","start":"2026-06-23T19:31:08.760531Z","end":"2026-06-23T19:31:10.152457Z","steps":["trace[319079460] 'agreement among raft nodes before linearized reading' (duration: 1.391744616s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.152498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.760517Z","time spent":"1.391973913s","remote":"127.0.0.1:46240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":126,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-06-23T19:31:10.152234Z","caller":"traceutil/trace.go:171","msg":"trace[1483418602] linearizableReadLoop","detail":"{readStateIndex:25345; appliedIndex:25339; }","duration":"1.391622463s","start":"2026-06-23T19:31:08.760576Z","end":"2026-06-23T19:31:10.152199Z","steps":["trace[1483418602] 'read index received' (duration: 686.782817ms)","trace[1483418602] 'applied index is now lower than readState.Index' (duration: 704.839036ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:31:10.153007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.269854765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-06-23T19:31:10.153034Z","caller":"traceutil/trace.go:171","msg":"trace[1296065254] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24548; }","duration":"1.269927597s","start":"2026-06-23T19:31:08.883099Z","end":"2026-06-23T19:31:10.153027Z","steps":["trace[1296065254] 'agreement among raft nodes before linearized reading' (duration: 1.269834815s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.153053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.883075Z","time spent":"1.269973899s","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-23T19:31:10.153141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.235873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:10.153165Z","caller":"traceutil/trace.go:171","msg":"trace[1659125063] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:24548; }","duration":"494.303365ms","start":"2026-06-23T19:31:09.658854Z","end":"2026-06-23T19:31:10.153158Z","steps":["trace[1659125063] 'agreement among raft nodes before linearized reading' (duration: 494.267564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.153184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:09.65883Z","time spent":"494.350277ms","remote":"127.0.0.1:45948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-06-23T19:31:10.153306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.611292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:10.153331Z","caller":"traceutil/trace.go:171","msg":"trace[1077797318] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:24548; }","duration":"672.663034ms","start":"2026-06-23T19:31:09.480662Z","end":"2026-06-23T19:31:10.153325Z","steps":["trace[1077797318] 'agreement among raft nodes before linearized reading' (duration: 672.623713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.15335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:09.480651Z","time spent":"672.694094ms","remote":"127.0.0.1:47652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true "} {"level":"warn","ts":"2026-06-23T19:31:10.153452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.214201631s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T19:31:10.153453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.212696168s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-23T19:31:10.153506Z","caller":"traceutil/trace.go:171","msg":"trace[1023987442] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24548; }","duration":"1.212796701s","start":"2026-06-23T19:31:08.940692Z","end":"2026-06-23T19:31:10.153489Z","steps":["trace[1023987442] 'agreement among raft nodes before linearized reading' (duration: 1.212614106s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.153525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.215320503s","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-06-23T19:31:10.153543Z","caller":"traceutil/trace.go:171","msg":"trace[723562430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24548; }","duration":"1.215410916s","start":"2026-06-23T19:31:08.938128Z","end":"2026-06-23T19:31:10.153538Z","steps":["trace[723562430] 'agreement among raft nodes before linearized reading' (duration: 1.215358914s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.153545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.940671Z","time spent":"1.212866353s","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-23T19:31:10.153567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.938113Z","time spent":"1.215449297s","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T19:31:10.153676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.243211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-23T19:31:10.153717Z","caller":"traceutil/trace.go:171","msg":"trace[1104264249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24548; }","duration":"702.296622ms","start":"2026-06-23T19:31:09.451408Z","end":"2026-06-23T19:31:10.153705Z","steps":["trace[1104264249] 'agreement among raft nodes before linearized reading' (duration: 702.20933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.153763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:09.451397Z","time spent":"702.357145ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-23T19:31:10.153878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.131657728s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:10.153907Z","caller":"traceutil/trace.go:171","msg":"trace[1248302595] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:24548; }","duration":"1.131688849s","start":"2026-06-23T19:31:09.022212Z","end":"2026-06-23T19:31:10.1539Z","steps":["trace[1248302595] 'agreement among raft nodes before linearized reading' (duration: 1.131638347s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.153926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:09.022158Z","time spent":"1.131763612s","remote":"127.0.0.1:40296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-06-23T19:31:10.153475Z","caller":"traceutil/trace.go:171","msg":"trace[474630427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24548; }","duration":"1.214298655s","start":"2026-06-23T19:31:08.939171Z","end":"2026-06-23T19:31:10.153469Z","steps":["trace[474630427] 'agreement among raft nodes before linearized reading' (duration: 1.214265224s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.154029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:08.939161Z","time spent":"1.214863061s","remote":"127.0.0.1:45874","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-06-23T19:31:10.154074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.566063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" ","response":"range_response_count:1 size:1566"} {"level":"info","ts":"2026-06-23T19:31:10.154134Z","caller":"traceutil/trace.go:171","msg":"trace[327740408] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0; range_end:; response_count:1; response_revision:24548; }","duration":"890.655126ms","start":"2026-06-23T19:31:09.263462Z","end":"2026-06-23T19:31:10.154117Z","steps":["trace[327740408] 'agreement among raft nodes before linearized reading' (duration: 890.512492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.154179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:09.263441Z","time spent":"890.728089ms","remote":"127.0.0.1:46024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":1589,"request content":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" "} {"level":"info","ts":"2026-06-23T19:31:10.342922Z","caller":"traceutil/trace.go:171","msg":"trace[19002637] transaction","detail":"{read_only:false; response_revision:24550; number_of_response:1; }","duration":"182.090075ms","start":"2026-06-23T19:31:10.160814Z","end":"2026-06-23T19:31:10.342904Z","steps":["trace[19002637] 'process raft request' (duration: 110.470525ms)","trace[19002637] 'compare' (duration: 71.373963ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:10.343245Z","caller":"traceutil/trace.go:171","msg":"trace[470138178] transaction","detail":"{read_only:false; response_revision:24551; number_of_response:1; }","duration":"180.587621ms","start":"2026-06-23T19:31:10.16265Z","end":"2026-06-23T19:31:10.343237Z","steps":["trace[470138178] 'process raft request' (duration: 180.216301ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:10.343367Z","caller":"traceutil/trace.go:171","msg":"trace[293074565] transaction","detail":"{read_only:false; response_revision:24552; number_of_response:1; }","duration":"180.274382ms","start":"2026-06-23T19:31:10.163046Z","end":"2026-06-23T19:31:10.34332Z","steps":["trace[293074565] 'process raft request' (duration: 180.169579ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:10.3435Z","caller":"traceutil/trace.go:171","msg":"trace[6488829] linearizableReadLoop","detail":"{readStateIndex:25350; appliedIndex:25345; }","duration":"179.877311ms","start":"2026-06-23T19:31:10.163616Z","end":"2026-06-23T19:31:10.343494Z","steps":["trace[6488829] 'read index received' (duration: 7.923687ms)","trace[6488829] 'applied index is now lower than readState.Index' (duration: 171.952964ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:10.343558Z","caller":"traceutil/trace.go:171","msg":"trace[1887652319] transaction","detail":"{read_only:false; response_revision:24553; number_of_response:1; }","duration":"180.435327ms","start":"2026-06-23T19:31:10.163094Z","end":"2026-06-23T19:31:10.343529Z","steps":["trace[1887652319] 'process raft request' (duration: 180.19273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.343627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.000955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-621c30bb-7720-4c17-b1e8-042fcb862f21\" ","response":"range_response_count:1 size:1284"} {"level":"info","ts":"2026-06-23T19:31:10.343651Z","caller":"traceutil/trace.go:171","msg":"trace[965911702] range","detail":"{range_begin:/registry/persistentvolumes/pvc-621c30bb-7720-4c17-b1e8-042fcb862f21; range_end:; response_count:1; response_revision:24554; }","duration":"180.057806ms","start":"2026-06-23T19:31:10.163584Z","end":"2026-06-23T19:31:10.343642Z","steps":["trace[965911702] 'agreement among raft nodes before linearized reading' (duration: 179.955223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:10.343779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.866842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:10.343799Z","caller":"traceutil/trace.go:171","msg":"trace[1596789149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24556; }","duration":"177.901884ms","start":"2026-06-23T19:31:10.165893Z","end":"2026-06-23T19:31:10.343795Z","steps":["trace[1596789149] 'agreement among raft nodes before linearized reading' (duration: 177.857133ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:12.716198Z","caller":"traceutil/trace.go:171","msg":"trace[1140164790] transaction","detail":"{read_only:false; response_revision:24630; number_of_response:1; }","duration":"100.287592ms","start":"2026-06-23T19:31:12.615873Z","end":"2026-06-23T19:31:12.716161Z","steps":["trace[1140164790] 'process raft request' (duration: 99.920522ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:19.210115Z","caller":"traceutil/trace.go:171","msg":"trace[1012314638] transaction","detail":"{read_only:false; response_revision:24697; number_of_response:1; }","duration":"138.345232ms","start":"2026-06-23T19:31:19.071732Z","end":"2026-06-23T19:31:19.210077Z","steps":["trace[1012314638] 'process raft request' (duration: 138.107915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:36.876113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.078055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-23T19:31:36.876195Z","caller":"traceutil/trace.go:171","msg":"trace[1698200785] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24843; }","duration":"110.199088ms","start":"2026-06-23T19:31:36.765963Z","end":"2026-06-23T19:31:36.876162Z","steps":["trace[1698200785] 'range keys from in-memory index tree' (duration: 109.848887ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:37.381445Z","caller":"traceutil/trace.go:171","msg":"trace[616534168] linearizableReadLoop","detail":"{readStateIndex:25648; appliedIndex:25647; }","duration":"258.685635ms","start":"2026-06-23T19:31:37.122738Z","end":"2026-06-23T19:31:37.381424Z","steps":["trace[616534168] 'read index received' (duration: 258.578472ms)","trace[616534168] 'applied index is now lower than readState.Index' (duration: 106.393µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:37.381489Z","caller":"traceutil/trace.go:171","msg":"trace[911934440] transaction","detail":"{read_only:false; response_revision:24844; number_of_response:1; }","duration":"301.313041ms","start":"2026-06-23T19:31:37.080149Z","end":"2026-06-23T19:31:37.381462Z","steps":["trace[911934440] 'process raft request' (duration: 301.111445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:37.381574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.826299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:37.381608Z","caller":"traceutil/trace.go:171","msg":"trace[670693122] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24844; }","duration":"258.913662ms","start":"2026-06-23T19:31:37.122682Z","end":"2026-06-23T19:31:37.381596Z","steps":["trace[670693122] 'agreement among raft nodes before linearized reading' (duration: 258.84388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:37.381632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:37.080126Z","time spent":"301.417864ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:31:37.637939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.267047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T19:31:37.638014Z","caller":"traceutil/trace.go:171","msg":"trace[1367220571] linearizableReadLoop","detail":"{readStateIndex:25649; appliedIndex:25648; }","duration":"256.497752ms","start":"2026-06-23T19:31:37.381506Z","end":"2026-06-23T19:31:37.638004Z","steps":["trace[1367220571] 'read index received' (duration: 121.023748ms)","trace[1367220571] 'applied index is now lower than readState.Index' (duration: 135.473254ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:37.638071Z","caller":"traceutil/trace.go:171","msg":"trace[1000478254] transaction","detail":"{read_only:false; response_revision:24845; number_of_response:1; }","duration":"294.014501ms","start":"2026-06-23T19:31:37.344049Z","end":"2026-06-23T19:31:37.638064Z","steps":["trace[1000478254] 'process raft request' (duration: 158.572697ms)","trace[1000478254] 'compare' (duration: 135.190185ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:31:37.638229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.900243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:37.638326Z","caller":"traceutil/trace.go:171","msg":"trace[2091881762] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:24845; }","duration":"354.050067ms","start":"2026-06-23T19:31:37.284252Z","end":"2026-06-23T19:31:37.638302Z","steps":["trace[2091881762] 'agreement among raft nodes before linearized reading' (duration: 353.896423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:37.638383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:37.284228Z","time spent":"354.140019ms","remote":"127.0.0.1:38816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-06-23T19:31:37.799092Z","caller":"traceutil/trace.go:171","msg":"trace[276015640] linearizableReadLoop","detail":"{readStateIndex:25650; appliedIndex:25649; }","duration":"147.318255ms","start":"2026-06-23T19:31:37.651748Z","end":"2026-06-23T19:31:37.799067Z","steps":["trace[276015640] 'read index received' (duration: 126.260189ms)","trace[276015640] 'applied index is now lower than readState.Index' (duration: 21.056986ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:37.799212Z","caller":"traceutil/trace.go:171","msg":"trace[65129431] transaction","detail":"{read_only:false; response_revision:24846; number_of_response:1; }","duration":"156.777567ms","start":"2026-06-23T19:31:37.642422Z","end":"2026-06-23T19:31:37.7992Z","steps":["trace[65129431] 'process raft request' (duration: 135.565617ms)","trace[65129431] 'compare' (duration: 20.854109ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:31:37.799407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.640313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:37.799488Z","caller":"traceutil/trace.go:171","msg":"trace[1488094194] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:24846; }","duration":"147.782027ms","start":"2026-06-23T19:31:37.651687Z","end":"2026-06-23T19:31:37.799469Z","steps":["trace[1488094194] 'agreement among raft nodes before linearized reading' (duration: 147.638773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:37.799456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.018653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10854"} {"level":"info","ts":"2026-06-23T19:31:37.799829Z","caller":"traceutil/trace.go:171","msg":"trace[691308905] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24846; }","duration":"101.423195ms","start":"2026-06-23T19:31:37.698385Z","end":"2026-06-23T19:31:37.799808Z","steps":["trace[691308905] 'agreement among raft nodes before linearized reading' (duration: 100.943371ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:38.180287Z","caller":"traceutil/trace.go:171","msg":"trace[1723219578] linearizableReadLoop","detail":"{readStateIndex:25651; appliedIndex:25650; }","duration":"187.657054ms","start":"2026-06-23T19:31:37.992611Z","end":"2026-06-23T19:31:38.180269Z","steps":["trace[1723219578] 'read index received' (duration: 187.473738ms)","trace[1723219578] 'applied index is now lower than readState.Index' (duration: 182.766µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:38.18035Z","caller":"traceutil/trace.go:171","msg":"trace[1943637172] transaction","detail":"{read_only:false; response_revision:24847; number_of_response:1; }","duration":"370.320614ms","start":"2026-06-23T19:31:37.809996Z","end":"2026-06-23T19:31:38.180316Z","steps":["trace[1943637172] 'process raft request' (duration: 370.148489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.180483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.84869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-23T19:31:38.180554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:37.809981Z","time spent":"370.455687ms","remote":"127.0.0.1:46052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10656,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:31:38.180574Z","caller":"traceutil/trace.go:171","msg":"trace[1407704681] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:24847; }","duration":"187.991454ms","start":"2026-06-23T19:31:37.992562Z","end":"2026-06-23T19:31:38.180554Z","steps":["trace[1407704681] 'agreement among raft nodes before linearized reading' (duration: 187.817059ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:38.442726Z","caller":"traceutil/trace.go:171","msg":"trace[1971021083] transaction","detail":"{read_only:false; response_revision:24849; number_of_response:1; }","duration":"255.01629ms","start":"2026-06-23T19:31:38.187687Z","end":"2026-06-23T19:31:38.442704Z","steps":["trace[1971021083] 'process raft request' (duration: 254.831825ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:38.442944Z","caller":"traceutil/trace.go:171","msg":"trace[1321933968] transaction","detail":"{read_only:false; response_revision:24851; number_of_response:1; }","duration":"246.245418ms","start":"2026-06-23T19:31:38.196682Z","end":"2026-06-23T19:31:38.442928Z","steps":["trace[1321933968] 'process raft request' (duration: 246.165156ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:38.442974Z","caller":"traceutil/trace.go:171","msg":"trace[1333085429] transaction","detail":"{read_only:false; response_revision:24850; number_of_response:1; }","duration":"254.800944ms","start":"2026-06-23T19:31:38.18815Z","end":"2026-06-23T19:31:38.442951Z","steps":["trace[1333085429] 'process raft request' (duration: 254.512366ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:38.708549Z","caller":"traceutil/trace.go:171","msg":"trace[990464569] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"465.349185ms","start":"2026-06-23T19:31:38.243176Z","end":"2026-06-23T19:31:38.708525Z","steps":["trace[990464569] 'process raft request' (duration: 465.138319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.708798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.243153Z","time spent":"465.55296ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:31:38.708854Z","caller":"traceutil/trace.go:171","msg":"trace[35042556] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"460.739273ms","start":"2026-06-23T19:31:38.248056Z","end":"2026-06-23T19:31:38.708795Z","steps":["trace[35042556] 'process raft request' (duration: 460.411834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.709052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.248027Z","time spent":"460.923988ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:31:38.709127Z","caller":"traceutil/trace.go:171","msg":"trace[739774952] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"459.855458ms","start":"2026-06-23T19:31:38.249245Z","end":"2026-06-23T19:31:38.7091Z","steps":["trace[739774952] 'process raft request' (duration: 459.668302ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:38.709111Z","caller":"traceutil/trace.go:171","msg":"trace[1023173787] linearizableReadLoop","detail":"{readStateIndex:25659; appliedIndex:25652; }","duration":"435.076805ms","start":"2026-06-23T19:31:38.273994Z","end":"2026-06-23T19:31:38.70907Z","steps":["trace[1023173787] 'read index received' (duration: 168.508773ms)","trace[1023173787] 'applied index is now lower than readState.Index' (duration: 266.565882ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:38.709223Z","caller":"traceutil/trace.go:171","msg":"trace[78594437] transaction","detail":"{read_only:false; response_revision:24856; number_of_response:1; }","duration":"269.020692ms","start":"2026-06-23T19:31:38.44019Z","end":"2026-06-23T19:31:38.709211Z","steps":["trace[78594437] 'process raft request' (duration: 268.784775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.709251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.249229Z","time spent":"459.95483ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:31:38.709253Z","caller":"traceutil/trace.go:171","msg":"trace[76255313] transaction","detail":"{read_only:false; response_revision:24854; number_of_response:1; }","duration":"460.727613ms","start":"2026-06-23T19:31:38.248487Z","end":"2026-06-23T19:31:38.709215Z","steps":["trace[76255313] 'process raft request' (duration: 460.244569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.709362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.350762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-23T19:31:38.709408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.248462Z","time spent":"460.870447ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:31:38.709433Z","caller":"traceutil/trace.go:171","msg":"trace[1568721030] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24856; }","duration":"435.459506ms","start":"2026-06-23T19:31:38.273957Z","end":"2026-06-23T19:31:38.709416Z","steps":["trace[1568721030] 'agreement among raft nodes before linearized reading' (duration: 435.27422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.709467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.273944Z","time spent":"435.517207ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T19:31:38.954106Z","caller":"traceutil/trace.go:171","msg":"trace[818260001] transaction","detail":"{read_only:false; response_revision:24857; number_of_response:1; }","duration":"509.794323ms","start":"2026-06-23T19:31:38.444281Z","end":"2026-06-23T19:31:38.954076Z","steps":["trace[818260001] 'process raft request' (duration: 509.544146ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:38.954204Z","caller":"traceutil/trace.go:171","msg":"trace[519440210] linearizableReadLoop","detail":"{readStateIndex:25662; appliedIndex:25660; }","duration":"244.950681ms","start":"2026-06-23T19:31:38.709231Z","end":"2026-06-23T19:31:38.954181Z","steps":["trace[519440210] 'read index received' (duration: 244.531449ms)","trace[519440210] 'applied index is now lower than readState.Index' (duration: 417.682µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:38.954232Z","caller":"traceutil/trace.go:171","msg":"trace[597024309] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"508.688171ms","start":"2026-06-23T19:31:38.445508Z","end":"2026-06-23T19:31:38.954196Z","steps":["trace[597024309] 'process raft request' (duration: 508.506056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.954287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.421534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-06-23T19:31:38.954298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.444267Z","time spent":"509.932627ms","remote":"127.0.0.1:46152","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-06-23T19:31:38.95434Z","caller":"traceutil/trace.go:171","msg":"trace[635190382] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24858; }","duration":"476.526397ms","start":"2026-06-23T19:31:38.4778Z","end":"2026-06-23T19:31:38.954327Z","steps":["trace[635190382] 'agreement among raft nodes before linearized reading' (duration: 476.387663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.954337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.631317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-06-23T19:31:38.954339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.445501Z","time spent":"508.785714ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:31:38.954368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.477778Z","time spent":"476.584809ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-23T19:31:38.954369Z","caller":"traceutil/trace.go:171","msg":"trace[962611489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24858; }","duration":"478.717469ms","start":"2026-06-23T19:31:38.475645Z","end":"2026-06-23T19:31:38.954362Z","steps":["trace[962611489] 'agreement among raft nodes before linearized reading' (duration: 478.613756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.954367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.270255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3236"} {"level":"warn","ts":"2026-06-23T19:31:38.954361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.878707ms","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-06-23T19:31:38.954412Z","caller":"traceutil/trace.go:171","msg":"trace[1413618338] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:24858; }","duration":"504.348117ms","start":"2026-06-23T19:31:38.450049Z","end":"2026-06-23T19:31:38.954397Z","steps":["trace[1413618338] 'agreement among raft nodes before linearized reading' (duration: 504.231203ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:38.954434Z","caller":"traceutil/trace.go:171","msg":"trace[73892818] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24858; }","duration":"476.982479ms","start":"2026-06-23T19:31:38.477435Z","end":"2026-06-23T19:31:38.954418Z","steps":["trace[73892818] 'agreement among raft nodes before linearized reading' (duration: 476.802634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.954454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.450035Z","time spent":"504.409318ms","remote":"127.0.0.1:40296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":3259,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"warn","ts":"2026-06-23T19:31:38.954393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.47562Z","time spent":"478.768672ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-23T19:31:38.954491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.477425Z","time spent":"477.051622ms","remote":"127.0.0.1:46152","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-06-23T19:31:38.954782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.961472ms","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-06-23T19:31:38.95581Z","caller":"traceutil/trace.go:171","msg":"trace[1428501121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24858; }","duration":"476.016943ms","start":"2026-06-23T19:31:38.47978Z","end":"2026-06-23T19:31:38.955797Z","steps":["trace[1428501121] 'agreement among raft nodes before linearized reading' (duration: 474.442927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.956309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:31:38.479767Z","time spent":"476.531727ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T19:31:38.974132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.310819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-23T19:31:38.97425Z","caller":"traceutil/trace.go:171","msg":"trace[1360376122] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24859; }","duration":"214.475703ms","start":"2026-06-23T19:31:38.759751Z","end":"2026-06-23T19:31:38.974227Z","steps":["trace[1360376122] 'agreement among raft nodes before linearized reading' (duration: 214.242647ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:38.974645Z","caller":"traceutil/trace.go:171","msg":"trace[776362396] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"257.888813ms","start":"2026-06-23T19:31:38.71674Z","end":"2026-06-23T19:31:38.974629Z","steps":["trace[776362396] 'process raft request' (duration: 256.986886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:38.975266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.066686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:38.975316Z","caller":"traceutil/trace.go:171","msg":"trace[1204818868] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:24859; }","duration":"140.171999ms","start":"2026-06-23T19:31:38.835132Z","end":"2026-06-23T19:31:38.975304Z","steps":["trace[1204818868] 'agreement among raft nodes before linearized reading' (duration: 140.080796ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:39.136687Z","caller":"traceutil/trace.go:171","msg":"trace[1651892369] transaction","detail":"{read_only:false; response_revision:24860; number_of_response:1; }","duration":"178.605693ms","start":"2026-06-23T19:31:38.958052Z","end":"2026-06-23T19:31:39.136658Z","steps":["trace[1651892369] 'process raft request' (duration: 178.374967ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:39.137018Z","caller":"traceutil/trace.go:171","msg":"trace[1356331068] transaction","detail":"{read_only:false; response_revision:24862; number_of_response:1; }","duration":"178.228703ms","start":"2026-06-23T19:31:38.958767Z","end":"2026-06-23T19:31:39.136996Z","steps":["trace[1356331068] 'process raft request' (duration: 178.101429ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:39.137079Z","caller":"traceutil/trace.go:171","msg":"trace[954052044] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"178.46915ms","start":"2026-06-23T19:31:38.958567Z","end":"2026-06-23T19:31:39.137037Z","steps":["trace[954052044] 'process raft request' (duration: 178.041837ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:39.137469Z","caller":"traceutil/trace.go:171","msg":"trace[228469151] transaction","detail":"{read_only:false; response_revision:24863; number_of_response:1; }","duration":"177.477412ms","start":"2026-06-23T19:31:38.959976Z","end":"2026-06-23T19:31:39.137453Z","steps":["trace[228469151] 'process raft request' (duration: 176.992408ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:39.137591Z","caller":"traceutil/trace.go:171","msg":"trace[124676565] transaction","detail":"{read_only:false; response_revision:24865; number_of_response:1; }","duration":"158.390263ms","start":"2026-06-23T19:31:38.979169Z","end":"2026-06-23T19:31:39.137559Z","steps":["trace[124676565] 'process raft request' (duration: 158.345651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:39.137699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.642958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:39.137596Z","caller":"traceutil/trace.go:171","msg":"trace[2084819319] linearizableReadLoop","detail":"{readStateIndex:25668; appliedIndex:25663; }","duration":"160.544575ms","start":"2026-06-23T19:31:38.977034Z","end":"2026-06-23T19:31:39.137579Z","steps":["trace[2084819319] 'read index received' (duration: 159.365691ms)","trace[2084819319] 'applied index is now lower than readState.Index' (duration: 1.177654ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:39.137761Z","caller":"traceutil/trace.go:171","msg":"trace[56898162] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24865; }","duration":"160.740461ms","start":"2026-06-23T19:31:38.977007Z","end":"2026-06-23T19:31:39.137747Z","steps":["trace[56898162] 'agreement among raft nodes before linearized reading' (duration: 160.630528ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:39.137797Z","caller":"traceutil/trace.go:171","msg":"trace[1761163430] transaction","detail":"{read_only:false; response_revision:24864; number_of_response:1; }","duration":"174.363651ms","start":"2026-06-23T19:31:38.963414Z","end":"2026-06-23T19:31:39.137777Z","steps":["trace[1761163430] 'process raft request' (duration: 173.98861ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:39.137915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.778991ms","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-06-23T19:31:39.137956Z","caller":"traceutil/trace.go:171","msg":"trace[858915544] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:24865; }","duration":"160.850163ms","start":"2026-06-23T19:31:38.977093Z","end":"2026-06-23T19:31:39.137943Z","steps":["trace[858915544] 'agreement among raft nodes before linearized reading' (duration: 160.76893ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:40.674471Z","caller":"traceutil/trace.go:171","msg":"trace[1773560852] transaction","detail":"{read_only:false; response_revision:24872; number_of_response:1; }","duration":"111.37271ms","start":"2026-06-23T19:31:40.563078Z","end":"2026-06-23T19:31:40.674451Z","steps":["trace[1773560852] 'process raft request' (duration: 111.255177ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:40.828428Z","caller":"traceutil/trace.go:171","msg":"trace[1751296017] transaction","detail":"{read_only:false; response_revision:24876; number_of_response:1; }","duration":"113.570933ms","start":"2026-06-23T19:31:40.714837Z","end":"2026-06-23T19:31:40.828408Z","steps":["trace[1751296017] 'process raft request' (duration: 113.512872ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:40.828727Z","caller":"traceutil/trace.go:171","msg":"trace[756791858] transaction","detail":"{read_only:false; response_revision:24874; number_of_response:1; }","duration":"115.012596ms","start":"2026-06-23T19:31:40.713703Z","end":"2026-06-23T19:31:40.828715Z","steps":["trace[756791858] 'process raft request' (duration: 114.42749ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:40.82871Z","caller":"traceutil/trace.go:171","msg":"trace[1385215733] transaction","detail":"{read_only:false; response_revision:24877; number_of_response:1; }","duration":"113.836631ms","start":"2026-06-23T19:31:40.714849Z","end":"2026-06-23T19:31:40.828686Z","steps":["trace[1385215733] 'process raft request' (duration: 113.526303ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:40.828795Z","caller":"traceutil/trace.go:171","msg":"trace[39263379] transaction","detail":"{read_only:false; response_revision:24875; number_of_response:1; }","duration":"114.978535ms","start":"2026-06-23T19:31:40.713784Z","end":"2026-06-23T19:31:40.828763Z","steps":["trace[39263379] 'process raft request' (duration: 114.531322ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:40.829195Z","caller":"traceutil/trace.go:171","msg":"trace[210754932] linearizableReadLoop","detail":"{readStateIndex:25683; appliedIndex:25677; }","duration":"113.477192ms","start":"2026-06-23T19:31:40.715708Z","end":"2026-06-23T19:31:40.829185Z","steps":["trace[210754932] 'read index received' (duration: 31.087124ms)","trace[210754932] 'applied index is now lower than readState.Index' (duration: 82.389288ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:40.829206Z","caller":"traceutil/trace.go:171","msg":"trace[104583085] transaction","detail":"{read_only:false; response_revision:24878; number_of_response:1; }","duration":"113.578945ms","start":"2026-06-23T19:31:40.715619Z","end":"2026-06-23T19:31:40.829198Z","steps":["trace[104583085] 'process raft request' (duration: 112.995187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:40.82937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.643667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3235"} {"level":"info","ts":"2026-06-23T19:31:40.829397Z","caller":"traceutil/trace.go:171","msg":"trace[111794952] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:24878; }","duration":"113.707068ms","start":"2026-06-23T19:31:40.715681Z","end":"2026-06-23T19:31:40.829388Z","steps":["trace[111794952] 'agreement among raft nodes before linearized reading' (duration: 113.542264ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:52.529801Z","caller":"traceutil/trace.go:171","msg":"trace[1182388037] transaction","detail":"{read_only:false; response_revision:24960; number_of_response:1; }","duration":"118.553238ms","start":"2026-06-23T19:31:52.411229Z","end":"2026-06-23T19:31:52.529782Z","steps":["trace[1182388037] 'process raft request' (duration: 118.419794ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:57.257613Z","caller":"traceutil/trace.go:171","msg":"trace[827627480] transaction","detail":"{read_only:false; response_revision:24999; number_of_response:1; }","duration":"142.496466ms","start":"2026-06-23T19:31:57.115077Z","end":"2026-06-23T19:31:57.257573Z","steps":["trace[827627480] 'process raft request' (duration: 67.028387ms)","trace[827627480] 'compare' (duration: 75.338525ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:57.53707Z","caller":"traceutil/trace.go:171","msg":"trace[1962725110] transaction","detail":"{read_only:false; response_revision:25001; number_of_response:1; }","duration":"274.165561ms","start":"2026-06-23T19:31:57.262869Z","end":"2026-06-23T19:31:57.537034Z","steps":["trace[1962725110] 'process raft request' (duration: 249.874292ms)","trace[1962725110] 'compare' (duration: 24.006461ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:57.537159Z","caller":"traceutil/trace.go:171","msg":"trace[1645257280] linearizableReadLoop","detail":"{readStateIndex:25812; appliedIndex:25809; }","duration":"183.640899ms","start":"2026-06-23T19:31:57.353484Z","end":"2026-06-23T19:31:57.537125Z","steps":["trace[1645257280] 'read index received' (duration: 159.278959ms)","trace[1645257280] 'applied index is now lower than readState.Index' (duration: 24.3606ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:31:57.537217Z","caller":"traceutil/trace.go:171","msg":"trace[152984089] transaction","detail":"{read_only:false; response_revision:25002; number_of_response:1; }","duration":"273.764639ms","start":"2026-06-23T19:31:57.263419Z","end":"2026-06-23T19:31:57.537184Z","steps":["trace[152984089] 'process raft request' (duration: 273.572083ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:31:57.537316Z","caller":"traceutil/trace.go:171","msg":"trace[164846932] transaction","detail":"{read_only:false; response_revision:25003; number_of_response:1; }","duration":"273.588754ms","start":"2026-06-23T19:31:57.263711Z","end":"2026-06-23T19:31:57.5373Z","steps":["trace[164846932] 'process raft request' (duration: 273.346107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:57.537478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.982548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-23T19:31:57.537556Z","caller":"traceutil/trace.go:171","msg":"trace[1199101370] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25003; }","duration":"184.110032ms","start":"2026-06-23T19:31:57.353428Z","end":"2026-06-23T19:31:57.537538Z","steps":["trace[1199101370] 'agreement among raft nodes before linearized reading' (duration: 183.876485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:31:57.561105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.080205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:31:57.561157Z","caller":"traceutil/trace.go:171","msg":"trace[311794933] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:25004; }","duration":"180.167228ms","start":"2026-06-23T19:31:57.380976Z","end":"2026-06-23T19:31:57.561143Z","steps":["trace[311794933] 'agreement among raft nodes before linearized reading' (duration: 180.089616ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:32:02.975964Z","caller":"traceutil/trace.go:171","msg":"trace[1055232626] transaction","detail":"{read_only:false; response_revision:25038; number_of_response:1; }","duration":"109.009134ms","start":"2026-06-23T19:32:02.866917Z","end":"2026-06-23T19:32:02.975926Z","steps":["trace[1055232626] 'process raft request' (duration: 108.659824ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:32:08.265522Z","caller":"traceutil/trace.go:171","msg":"trace[814179922] transaction","detail":"{read_only:false; response_revision:25088; number_of_response:1; }","duration":"110.413923ms","start":"2026-06-23T19:32:08.155077Z","end":"2026-06-23T19:32:08.265491Z","steps":["trace[814179922] 'process raft request' (duration: 37.543099ms)","trace[814179922] 'compare' (duration: 72.750641ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:32:09.063128Z","caller":"traceutil/trace.go:171","msg":"trace[755200393] transaction","detail":"{read_only:false; response_revision:25089; number_of_response:1; }","duration":"112.749841ms","start":"2026-06-23T19:32:08.950337Z","end":"2026-06-23T19:32:09.063086Z","steps":["trace[755200393] 'process raft request' (duration: 112.578766ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:32:09.341493Z","caller":"traceutil/trace.go:171","msg":"trace[939781521] transaction","detail":"{read_only:false; response_revision:25091; number_of_response:1; }","duration":"345.660665ms","start":"2026-06-23T19:32:08.995805Z","end":"2026-06-23T19:32:09.341466Z","steps":["trace[939781521] 'process raft request' (duration: 345.579903ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:32:09.341498Z","caller":"traceutil/trace.go:171","msg":"trace[480720245] transaction","detail":"{read_only:false; response_revision:25090; number_of_response:1; }","duration":"349.641649ms","start":"2026-06-23T19:32:08.991824Z","end":"2026-06-23T19:32:09.341465Z","steps":["trace[480720245] 'process raft request' (duration: 312.361087ms)","trace[480720245] 'compare' (duration: 37.060245ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T19:32:09.341642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:32:08.99578Z","time spent":"345.784369ms","remote":"127.0.0.1:46152","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-06-23T19:32:09.341676Z","caller":"traceutil/trace.go:171","msg":"trace[34153876] transaction","detail":"{read_only:false; response_revision:25092; number_of_response:1; }","duration":"343.968937ms","start":"2026-06-23T19:32:08.99769Z","end":"2026-06-23T19:32:09.341659Z","steps":["trace[34153876] 'process raft request' (duration: 343.73933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:32:09.341824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:32:08.997677Z","time spent":"344.09161ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:32:09.341817Z","caller":"traceutil/trace.go:171","msg":"trace[89371527] transaction","detail":"{read_only:false; response_revision:25093; number_of_response:1; }","duration":"343.731719ms","start":"2026-06-23T19:32:08.998057Z","end":"2026-06-23T19:32:09.341788Z","steps":["trace[89371527] 'process raft request' (duration: 343.526784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:32:09.341843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:32:08.991798Z","time spent":"349.783134ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:32:09.341973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:32:08.998048Z","time spent":"343.834463ms","remote":"127.0.0.1:46152","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-06-23T19:32:09.355811Z","caller":"traceutil/trace.go:171","msg":"trace[1290178453] transaction","detail":"{read_only:false; response_revision:25094; number_of_response:1; }","duration":"273.43349ms","start":"2026-06-23T19:32:09.082357Z","end":"2026-06-23T19:32:09.35579Z","steps":["trace[1290178453] 'process raft request' (duration: 273.267715ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:32:09.356216Z","caller":"traceutil/trace.go:171","msg":"trace[1682060640] transaction","detail":"{read_only:false; response_revision:25095; number_of_response:1; }","duration":"267.998443ms","start":"2026-06-23T19:32:09.088187Z","end":"2026-06-23T19:32:09.356186Z","steps":["trace[1682060640] 'process raft request' (duration: 267.564761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:32:09.356483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.793816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-23T19:32:09.356568Z","caller":"traceutil/trace.go:171","msg":"trace[1385545159] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25095; }","duration":"205.903639ms","start":"2026-06-23T19:32:09.150632Z","end":"2026-06-23T19:32:09.356535Z","steps":["trace[1385545159] 'agreement among raft nodes before linearized reading' (duration: 205.710354ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:32:09.35629Z","caller":"traceutil/trace.go:171","msg":"trace[1414486730] linearizableReadLoop","detail":"{readStateIndex:25906; appliedIndex:25900; }","duration":"205.442316ms","start":"2026-06-23T19:32:09.150678Z","end":"2026-06-23T19:32:09.356121Z","steps":["trace[1414486730] 'read index received' (duration: 153.522103ms)","trace[1414486730] 'applied index is now lower than readState.Index' (duration: 51.917993ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:32:09.574332Z","caller":"traceutil/trace.go:171","msg":"trace[1748987293] transaction","detail":"{read_only:false; response_revision:25096; number_of_response:1; }","duration":"214.383052ms","start":"2026-06-23T19:32:09.359909Z","end":"2026-06-23T19:32:09.574292Z","steps":["trace[1748987293] 'process raft request' (duration: 122.075989ms)","trace[1748987293] 'compare' (duration: 91.996654ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:32:09.663242Z","caller":"traceutil/trace.go:171","msg":"trace[2117655198] linearizableReadLoop","detail":"{readStateIndex:25909; appliedIndex:25907; }","duration":"105.09238ms","start":"2026-06-23T19:32:09.55813Z","end":"2026-06-23T19:32:09.663222Z","steps":["trace[2117655198] 'read index received' (duration: 104.890184ms)","trace[2117655198] 'applied index is now lower than readState.Index' (duration: 200.876µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:32:09.663292Z","caller":"traceutil/trace.go:171","msg":"trace[623204730] transaction","detail":"{read_only:false; response_revision:25097; number_of_response:1; }","duration":"302.04208ms","start":"2026-06-23T19:32:09.361207Z","end":"2026-06-23T19:32:09.663249Z","steps":["trace[623204730] 'process raft request' (duration: 301.837595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:32:09.663396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.242564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:32:09.663427Z","caller":"traceutil/trace.go:171","msg":"trace[1559683772] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:25098; }","duration":"105.351697ms","start":"2026-06-23T19:32:09.558066Z","end":"2026-06-23T19:32:09.663418Z","steps":["trace[1559683772] 'agreement among raft nodes before linearized reading' (duration: 105.261765ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:32:09.663516Z","caller":"traceutil/trace.go:171","msg":"trace[1638051551] transaction","detail":"{read_only:false; response_revision:25098; number_of_response:1; }","duration":"302.243296ms","start":"2026-06-23T19:32:09.361245Z","end":"2026-06-23T19:32:09.663488Z","steps":["trace[1638051551] 'process raft request' (duration: 301.907547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:32:09.663539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:32:09.361186Z","time spent":"302.195415ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:32:09.663631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:32:09.361219Z","time spent":"302.360051ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:32:41.538846Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000066d2.wal"} {"level":"warn","ts":"2026-06-23T19:33:14.28866Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912728132530400,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-23T19:33:14.577319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.281418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5082"} {"level":"info","ts":"2026-06-23T19:33:14.57739Z","caller":"traceutil/trace.go:171","msg":"trace[1652118669] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:25738; }","duration":"804.411772ms","start":"2026-06-23T19:33:13.772963Z","end":"2026-06-23T19:33:14.577374Z","steps":["trace[1652118669] 'range keys from in-memory index tree' (duration: 804.128033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.577423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:13.772943Z","time spent":"804.473353ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5105,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"info","ts":"2026-06-23T19:33:14.578306Z","caller":"traceutil/trace.go:171","msg":"trace[888956138] transaction","detail":"{read_only:false; response_revision:25739; number_of_response:1; }","duration":"804.824953ms","start":"2026-06-23T19:33:13.773453Z","end":"2026-06-23T19:33:14.578278Z","steps":["trace[888956138] 'process raft request' (duration: 803.554126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.578495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:13.773432Z","time spent":"804.982698ms","remote":"127.0.0.1:46152","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-06-23T19:33:14.594795Z","caller":"traceutil/trace.go:171","msg":"trace[1836319109] transaction","detail":"{read_only:false; response_revision:25740; number_of_response:1; }","duration":"819.891876ms","start":"2026-06-23T19:33:13.774831Z","end":"2026-06-23T19:33:14.594722Z","steps":["trace[1836319109] 'process raft request' (duration: 819.699471ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:33:14.595092Z","caller":"traceutil/trace.go:171","msg":"trace[1467587836] transaction","detail":"{read_only:false; response_revision:25742; number_of_response:1; }","duration":"800.491159ms","start":"2026-06-23T19:33:13.794566Z","end":"2026-06-23T19:33:14.595057Z","steps":["trace[1467587836] 'process raft request' (duration: 800.143909ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:33:14.595128Z","caller":"traceutil/trace.go:171","msg":"trace[1924932072] linearizableReadLoop","detail":"{readStateIndex:26569; appliedIndex:26564; }","duration":"806.523621ms","start":"2026-06-23T19:33:13.788579Z","end":"2026-06-23T19:33:14.595103Z","steps":["trace[1924932072] 'read index received' (duration: 788.437441ms)","trace[1924932072] 'applied index is now lower than readState.Index' (duration: 18.08541ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:33:14.59512Z","caller":"traceutil/trace.go:171","msg":"trace[411873259] transaction","detail":"{read_only:false; response_revision:25741; number_of_response:1; }","duration":"806.641464ms","start":"2026-06-23T19:33:13.788442Z","end":"2026-06-23T19:33:14.595084Z","steps":["trace[411873259] 'process raft request' (duration: 806.218172ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:33:14.595242Z","caller":"traceutil/trace.go:171","msg":"trace[2125669915] transaction","detail":"{read_only:false; response_revision:25743; number_of_response:1; }","duration":"799.955583ms","start":"2026-06-23T19:33:13.795279Z","end":"2026-06-23T19:33:14.595235Z","steps":["trace[2125669915] 'process raft request' (duration: 799.732336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.595244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:13.794514Z","time spent":"800.650473ms","remote":"127.0.0.1:46152","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-06-23T19:33:14.595277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:13.788424Z","time spent":"806.773299ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:33:14.595346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:13.795254Z","time spent":"800.032095ms","remote":"127.0.0.1:46152","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-06-23T19:33:14.595386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.013217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:33:14.59544Z","caller":"traceutil/trace.go:171","msg":"trace[725973238] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25743; }","duration":"655.101489ms","start":"2026-06-23T19:33:13.94032Z","end":"2026-06-23T19:33:14.595422Z","steps":["trace[725973238] 'agreement among raft nodes before linearized reading' (duration: 655.021547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.595482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:13.940298Z","time spent":"655.175051ms","remote":"127.0.0.1:45874","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-06-23T19:33:14.595503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.445283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-23T19:33:14.595529Z","caller":"traceutil/trace.go:171","msg":"trace[928630670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25743; }","duration":"429.498375ms","start":"2026-06-23T19:33:14.166023Z","end":"2026-06-23T19:33:14.595522Z","steps":["trace[928630670] 'agreement among raft nodes before linearized reading' (duration: 429.387862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.595553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:14.166005Z","time spent":"429.543406ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T19:33:14.595688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.117968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5082"} {"level":"info","ts":"2026-06-23T19:33:14.59572Z","caller":"traceutil/trace.go:171","msg":"trace[1943787791] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:25743; }","duration":"807.19793ms","start":"2026-06-23T19:33:13.788515Z","end":"2026-06-23T19:33:14.595713Z","steps":["trace[1943787791] 'agreement among raft nodes before linearized reading' (duration: 807.125078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.595721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.120272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-06-23T19:33:14.595742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:13.788491Z","time spent":"807.247112ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5105,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"info","ts":"2026-06-23T19:33:14.595754Z","caller":"traceutil/trace.go:171","msg":"trace[800617388] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25743; }","duration":"239.189654ms","start":"2026-06-23T19:33:14.356557Z","end":"2026-06-23T19:33:14.595746Z","steps":["trace[800617388] 'agreement among raft nodes before linearized reading' (duration: 239.102802ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.595132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:13.774789Z","time spent":"820.203865ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T19:33:14.595855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.674778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-06-23T19:33:14.59585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.346497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"} {"level":"warn","ts":"2026-06-23T19:33:14.595774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.717533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-23T19:33:14.5959Z","caller":"traceutil/trace.go:171","msg":"trace[1695446717] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25743; }","duration":"486.75026ms","start":"2026-06-23T19:33:14.109138Z","end":"2026-06-23T19:33:14.595888Z","steps":["trace[1695446717] 'agreement among raft nodes before linearized reading' (duration: 486.659508ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:33:14.595924Z","caller":"traceutil/trace.go:171","msg":"trace[2092429127] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:25743; }","duration":"320.45351ms","start":"2026-06-23T19:33:14.275449Z","end":"2026-06-23T19:33:14.595903Z","steps":["trace[2092429127] 'agreement among raft nodes before linearized reading' (duration: 320.231083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.595933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:14.109122Z","time spent":"486.805072ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-23T19:33:14.595931Z","caller":"traceutil/trace.go:171","msg":"trace[1612076190] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25743; }","duration":"451.907589ms","start":"2026-06-23T19:33:14.144002Z","end":"2026-06-23T19:33:14.59591Z","steps":["trace[1612076190] 'agreement among raft nodes before linearized reading' (duration: 451.673112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.595964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:14.27543Z","time spent":"320.525212ms","remote":"127.0.0.1:46024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":1873,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" "} {"level":"warn","ts":"2026-06-23T19:33:14.595985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:14.143971Z","time spent":"451.997391ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-23T19:33:14.596096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.373654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-23T19:33:14.596097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.158223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-23T19:33:14.596128Z","caller":"traceutil/trace.go:171","msg":"trace[768752386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25743; }","duration":"506.432546ms","start":"2026-06-23T19:33:14.089689Z","end":"2026-06-23T19:33:14.596121Z","steps":["trace[768752386] 'agreement among raft nodes before linearized reading' (duration: 506.357574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.596147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:14.089672Z","time spent":"506.470627ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-23T19:33:14.596144Z","caller":"traceutil/trace.go:171","msg":"trace[1133597013] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25743; }","duration":"574.241935ms","start":"2026-06-23T19:33:14.021894Z","end":"2026-06-23T19:33:14.596136Z","steps":["trace[1133597013] 'agreement among raft nodes before linearized reading' (duration: 574.149933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:33:14.596195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:33:14.021874Z","time spent":"574.314537ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T19:34:02.873773Z","caller":"traceutil/trace.go:171","msg":"trace[1553778299] transaction","detail":"{read_only:false; response_revision:26191; number_of_response:1; }","duration":"106.070336ms","start":"2026-06-23T19:34:02.767682Z","end":"2026-06-23T19:34:02.873752Z","steps":["trace[1553778299] 'process raft request' (duration: 104.736857ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T19:34:32.522923Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23611} {"level":"info","ts":"2026-06-23T19:34:32.66964Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23611,"took":"143.333106ms","hash":3685254629,"current-db-size-bytes":59076608,"current-db-size":"59 MB","current-db-size-in-use-bytes":37015552,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-06-23T19:34:32.669703Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3685254629,"revision":23611,"compact-revision":20450} {"level":"info","ts":"2026-06-23T19:39:32.530562Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26438} {"level":"info","ts":"2026-06-23T19:39:32.694333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26438,"took":"159.189121ms","hash":3327217593,"current-db-size-bytes":59076608,"current-db-size":"59 MB","current-db-size-in-use-bytes":33030144,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-23T19:39:32.694414Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3327217593,"revision":26438,"compact-revision":23611} {"level":"info","ts":"2026-06-23T19:39:42.761145Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e892d50a3a4fc0f4","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T19:39:42.766025Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-23T19:39:42.766168Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-23T19:44:32.53743Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29004} {"level":"info","ts":"2026-06-23T19:44:32.694639Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29004,"took":"152.45592ms","hash":1842302821,"current-db-size-bytes":59076608,"current-db-size":"59 MB","current-db-size-in-use-bytes":30208000,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-23T19:44:32.69474Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1842302821,"revision":29004,"compact-revision":26438} {"level":"info","ts":"2026-06-23T19:49:32.543348Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31228} {"level":"info","ts":"2026-06-23T19:49:32.668614Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31228,"took":"120.301778ms","hash":3934039482,"current-db-size-bytes":59076608,"current-db-size":"59 MB","current-db-size-in-use-bytes":30355456,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-23T19:49:32.668714Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3934039482,"revision":31228,"compact-revision":29004} {"level":"info","ts":"2026-06-23T19:54:32.549259Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33492} {"level":"info","ts":"2026-06-23T19:54:32.695003Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33492,"took":"141.768952ms","hash":927977893,"current-db-size-bytes":60116992,"current-db-size":"60 MB","current-db-size-in-use-bytes":32112640,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-23T19:54:32.695075Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":927977893,"revision":33492,"compact-revision":31228} {"level":"warn","ts":"2026-06-23T19:56:56.527427Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13903912728132557778,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-23T19:56:56.632152Z","caller":"traceutil/trace.go:171","msg":"trace[873183621] transaction","detail":"{read_only:false; response_revision:36870; number_of_response:1; }","duration":"612.784441ms","start":"2026-06-23T19:56:56.019346Z","end":"2026-06-23T19:56:56.63213Z","steps":["trace[873183621] 'process raft request' (duration: 612.623716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.632287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:56:56.019336Z","time spent":"612.879273ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":538,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:56:56.635018Z","caller":"traceutil/trace.go:171","msg":"trace[1597075557] linearizableReadLoop","detail":"{readStateIndex:38013; appliedIndex:38008; }","duration":"608.471037ms","start":"2026-06-23T19:56:56.026517Z","end":"2026-06-23T19:56:56.634988Z","steps":["trace[1597075557] 'read index received' (duration: 605.575354ms)","trace[1597075557] 'applied index is now lower than readState.Index' (duration: 2.894733ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T19:56:56.635318Z","caller":"traceutil/trace.go:171","msg":"trace[1761046558] transaction","detail":"{read_only:false; response_revision:36871; number_of_response:1; }","duration":"604.318408ms","start":"2026-06-23T19:56:56.030987Z","end":"2026-06-23T19:56:56.635306Z","steps":["trace[1761046558] 'process raft request' (duration: 603.720001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.635427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:56:56.030974Z","time spent":"604.380549ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:56:56.635633Z","caller":"traceutil/trace.go:171","msg":"trace[259264769] transaction","detail":"{read_only:false; response_revision:36872; number_of_response:1; }","duration":"599.181521ms","start":"2026-06-23T19:56:56.03644Z","end":"2026-06-23T19:56:56.635621Z","steps":["trace[259264769] 'process raft request' (duration: 598.415028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.635701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:56:56.036427Z","time spent":"599.239452ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:56:56.635887Z","caller":"traceutil/trace.go:171","msg":"trace[973641377] transaction","detail":"{read_only:false; response_revision:36873; number_of_response:1; }","duration":"595.640429ms","start":"2026-06-23T19:56:56.040235Z","end":"2026-06-23T19:56:56.635876Z","steps":["trace[973641377] 'process raft request' (duration: 594.6603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.635948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:56:56.040219Z","time spent":"595.697771ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T19:56:56.636141Z","caller":"traceutil/trace.go:171","msg":"trace[260833887] transaction","detail":"{read_only:false; response_revision:36874; number_of_response:1; }","duration":"279.91216ms","start":"2026-06-23T19:56:56.356214Z","end":"2026-06-23T19:56:56.636126Z","steps":["trace[260833887] 'process raft request' (duration: 278.736566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.636324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.814886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-23T19:56:56.636363Z","caller":"traceutil/trace.go:171","msg":"trace[535856370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:36874; }","duration":"609.898848ms","start":"2026-06-23T19:56:56.026455Z","end":"2026-06-23T19:56:56.636354Z","steps":["trace[535856370] 'agreement among raft nodes before linearized reading' (duration: 609.767625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.636391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:56:56.026424Z","time spent":"609.95869ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-23T19:56:56.636502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.249835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:56:56.63654Z","caller":"traceutil/trace.go:171","msg":"trace[308305604] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:36874; }","duration":"581.325258ms","start":"2026-06-23T19:56:56.055204Z","end":"2026-06-23T19:56:56.636529Z","steps":["trace[308305604] 'agreement among raft nodes before linearized reading' (duration: 581.265687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.63657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:56:56.055185Z","time spent":"581.376159ms","remote":"127.0.0.1:58718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-06-23T19:56:56.636783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.270066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-23T19:56:56.636931Z","caller":"traceutil/trace.go:171","msg":"trace[1239326253] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:36874; }","duration":"283.343648ms","start":"2026-06-23T19:56:56.353468Z","end":"2026-06-23T19:56:56.636812Z","steps":["trace[1239326253] 'agreement among raft nodes before linearized reading' (duration: 283.281737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.637201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.108914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-06-23T19:56:56.63724Z","caller":"traceutil/trace.go:171","msg":"trace[1722526778] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:36874; }","duration":"312.150435ms","start":"2026-06-23T19:56:56.32508Z","end":"2026-06-23T19:56:56.637231Z","steps":["trace[1722526778] 'agreement among raft nodes before linearized reading' (duration: 312.081733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.637605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:56:56.325022Z","time spent":"312.566027ms","remote":"127.0.0.1:46152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-23T19:56:56.637852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.76838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-06-23T19:56:56.637887Z","caller":"traceutil/trace.go:171","msg":"trace[189892021] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:36874; }","duration":"401.836062ms","start":"2026-06-23T19:56:56.236041Z","end":"2026-06-23T19:56:56.637877Z","steps":["trace[189892021] 'agreement among raft nodes before linearized reading' (duration: 401.717828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T19:56:56.637907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T19:56:56.236021Z","time spent":"401.881812ms","remote":"127.0.0.1:46024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" "} {"level":"info","ts":"2026-06-23T19:59:32.555179Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35784} {"level":"info","ts":"2026-06-23T19:59:32.694795Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35784,"took":"136.15176ms","hash":622170388,"current-db-size-bytes":61005824,"current-db-size":"61 MB","current-db-size-in-use-bytes":31088640,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-23T19:59:32.694862Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":622170388,"revision":35784,"compact-revision":33492} {"level":"info","ts":"2026-06-23T20:01:00.169473Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e892d50a3a4fc0f4","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-23T20:01:00.17323Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-23T20:01:00.173485Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}