{"level":"warn","ts":"2026-06-30T22:18:46.844708Z","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-30T22:18:46.844839Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.204.45.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-30T22:18:46.84493Z","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-30T22:18:46.844945Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-06-30T22:18:46.844971Z","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-30T22:18:46.845852Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-06-30T22:18:46.845951Z","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.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-30T22:18:46.851506Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.11139ms"} {"level":"info","ts":"2026-06-30T22:18:46.86081Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-06-30T22:18:46.860911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T22:18:46.860945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-06-30T22:18:46.860961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T22:18:46.860978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-06-30T22:18:46.861031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-06-30T22:18:46.866166Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T22:18:46.869337Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T22:18:46.870911Z","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-30T22:18:46.873974Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T22:18:46.874156Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T22:18:46.874229Z","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-30T22:18:46.874319Z","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-30T22:18:46.874335Z","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-30T22:18:46.875293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-06-30T22:18:46.875581Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-06-30T22:18:46.877055Z","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-30T22:18:46.877157Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-06-30T22:18:46.877241Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-06-30T22:18:46.877373Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T22:18:46.877415Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T22:18:47.061623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T22:18:47.061716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T22:18:47.061753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-06-30T22:18:47.061776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-06-30T22:18:47.061788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-06-30T22:18:47.061806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-06-30T22:18:47.061822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-06-30T22:18:47.063188Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:18:47.064389Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T22:18:47.0644Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T22:18:47.064504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T22:18:47.064839Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T22:18:47.064969Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T22:18:47.065527Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:18:47.065733Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:18:47.065844Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:18:47.067878Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T22:18:47.068723Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"warn","ts":"2026-06-30T22:19:30.683433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.916779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:19:30.683636Z","caller":"traceutil/trace.go:171","msg":"trace[1049292181] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"215.895595ms","start":"2026-06-30T22:19:30.467698Z","end":"2026-06-30T22:19:30.683594Z","steps":["trace[1049292181] 'process raft request' (duration: 85.151817ms)","trace[1049292181] 'compare' (duration: 129.61683ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:19:31.089854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.419195ms","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-30T22:19:31.089933Z","caller":"traceutil/trace.go:171","msg":"trace[273357894] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"116.560569ms","start":"2026-06-30T22:19:30.973354Z","end":"2026-06-30T22:19:31.089915Z","steps":["trace[273357894] 'range keys from in-memory index tree' (duration: 116.255922ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:31.264271Z","caller":"traceutil/trace.go:171","msg":"trace[836176394] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"170.580361ms","start":"2026-06-30T22:19:31.093659Z","end":"2026-06-30T22:19:31.26424Z","steps":["trace[836176394] 'process raft request' (duration: 170.393527ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:31.279056Z","caller":"traceutil/trace.go:171","msg":"trace[775405959] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:617; }","duration":"114.901059ms","start":"2026-06-30T22:19:31.164119Z","end":"2026-06-30T22:19:31.27902Z","steps":["trace[775405959] 'read index received' (duration: 99.987342ms)","trace[775405959] 'applied index is now lower than readState.Index' (duration: 14.912397ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:19:31.279111Z","caller":"traceutil/trace.go:171","msg":"trace[463369090] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"160.750885ms","start":"2026-06-30T22:19:31.118332Z","end":"2026-06-30T22:19:31.279082Z","steps":["trace[463369090] 'process raft request' (duration: 160.161401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:31.279245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.110373ms","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-30T22:19:31.279297Z","caller":"traceutil/trace.go:171","msg":"trace[385545813] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"115.218736ms","start":"2026-06-30T22:19:31.164064Z","end":"2026-06-30T22:19:31.279283Z","steps":["trace[385545813] 'agreement among raft nodes before linearized reading' (duration: 115.056842ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:20:14.239444Z","caller":"traceutil/trace.go:171","msg":"trace[1145545809] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"145.320146ms","start":"2026-06-30T22:20:14.094096Z","end":"2026-06-30T22:20:14.239417Z","steps":["trace[1145545809] 'process raft request' (duration: 145.113101ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:20:33.620197Z","caller":"traceutil/trace.go:171","msg":"trace[2006300559] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"106.200571ms","start":"2026-06-30T22:20:33.513921Z","end":"2026-06-30T22:20:33.620122Z","steps":["trace[2006300559] 'process raft request' (duration: 105.843012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:57.52072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.819352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad7300f9-12be-4e69-9b99-dee7ca1534d8\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-30T22:20:57.520829Z","caller":"traceutil/trace.go:171","msg":"trace[196472405] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ad7300f9-12be-4e69-9b99-dee7ca1534d8; range_end:; response_count:1; response_revision:1803; }","duration":"254.991356ms","start":"2026-06-30T22:20:57.265815Z","end":"2026-06-30T22:20:57.520807Z","steps":["trace[196472405] 'range keys from in-memory index tree' (duration: 254.585997ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:20:57.931985Z","caller":"traceutil/trace.go:171","msg":"trace[598596048] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"124.695202ms","start":"2026-06-30T22:20:57.807209Z","end":"2026-06-30T22:20:57.931904Z","steps":["trace[598596048] 'process raft request' (duration: 67.826886ms)","trace[598596048] 'compare' (duration: 56.471466ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:20:57.93201Z","caller":"traceutil/trace.go:171","msg":"trace[949570584] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"122.691534ms","start":"2026-06-30T22:20:57.809259Z","end":"2026-06-30T22:20:57.931951Z","steps":["trace[949570584] 'process raft request' (duration: 122.454759ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:21:10.102023Z","caller":"traceutil/trace.go:171","msg":"trace[1441384315] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"113.559627ms","start":"2026-06-30T22:21:09.988438Z","end":"2026-06-30T22:21:10.101997Z","steps":["trace[1441384315] 'process raft request' (duration: 98.097948ms)","trace[1441384315] 'compare' (duration: 15.346796ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:21:46.635314Z","caller":"traceutil/trace.go:171","msg":"trace[1785320672] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"104.559645ms","start":"2026-06-30T22:21:46.530722Z","end":"2026-06-30T22:21:46.635282Z","steps":["trace[1785320672] 'process raft request' (duration: 104.312219ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:21:46.790883Z","caller":"traceutil/trace.go:171","msg":"trace[1713309218] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2200; }","duration":"110.987739ms","start":"2026-06-30T22:21:46.679867Z","end":"2026-06-30T22:21:46.790855Z","steps":["trace[1713309218] 'read index received' (duration: 70.471465ms)","trace[1713309218] 'applied index is now lower than readState.Index' (duration: 40.515264ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:21:46.790985Z","caller":"traceutil/trace.go:171","msg":"trace[1047133924] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"142.981469ms","start":"2026-06-30T22:21:46.647966Z","end":"2026-06-30T22:21:46.790948Z","steps":["trace[1047133924] 'process raft request' (duration: 102.480665ms)","trace[1047133924] 'compare' (duration: 40.288479ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:21:46.791129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.235445ms","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-30T22:21:46.791166Z","caller":"traceutil/trace.go:171","msg":"trace[1988201983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2119; }","duration":"111.314476ms","start":"2026-06-30T22:21:46.679842Z","end":"2026-06-30T22:21:46.791157Z","steps":["trace[1988201983] 'agreement among raft nodes before linearized reading' (duration: 111.153932ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:21:47.008033Z","caller":"traceutil/trace.go:171","msg":"trace[234249787] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"211.817905ms","start":"2026-06-30T22:21:46.796175Z","end":"2026-06-30T22:21:47.007993Z","steps":["trace[234249787] 'process raft request' (duration: 132.786717ms)","trace[234249787] 'compare' (duration: 78.69879ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:21:47.008074Z","caller":"traceutil/trace.go:171","msg":"trace[306651304] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"152.928366ms","start":"2026-06-30T22:21:46.85512Z","end":"2026-06-30T22:21:47.008048Z","steps":["trace[306651304] 'process raft request' (duration: 152.723281ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:21:47.008268Z","caller":"traceutil/trace.go:171","msg":"trace[1958969781] linearizableReadLoop","detail":"{readStateIndex:2204; appliedIndex:2202; }","duration":"127.162993ms","start":"2026-06-30T22:21:46.881032Z","end":"2026-06-30T22:21:47.008195Z","steps":["trace[1958969781] 'read index received' (duration: 47.94579ms)","trace[1958969781] 'applied index is now lower than readState.Index' (duration: 79.205373ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:21:47.008497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.438209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-30T22:21:47.008628Z","caller":"traceutil/trace.go:171","msg":"trace[1537176013] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2122; }","duration":"127.616643ms","start":"2026-06-30T22:21:46.880984Z","end":"2026-06-30T22:21:47.0086Z","steps":["trace[1537176013] 'agreement among raft nodes before linearized reading' (duration: 127.308366ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:22:23.280443Z","caller":"traceutil/trace.go:171","msg":"trace[1777420503] transaction","detail":"{read_only:false; response_revision:2368; number_of_response:1; }","duration":"143.537342ms","start":"2026-06-30T22:22:23.136882Z","end":"2026-06-30T22:22:23.280419Z","steps":["trace[1777420503] 'process raft request' (duration: 143.217965ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:22:59.505059Z","caller":"traceutil/trace.go:171","msg":"trace[1192861945] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"102.447717ms","start":"2026-06-30T22:22:59.402591Z","end":"2026-06-30T22:22:59.505038Z","steps":["trace[1192861945] 'process raft request' (duration: 101.792221ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:22:59.697935Z","caller":"traceutil/trace.go:171","msg":"trace[783987844] linearizableReadLoop","detail":"{readStateIndex:2664; appliedIndex:2662; }","duration":"264.676521ms","start":"2026-06-30T22:22:59.433229Z","end":"2026-06-30T22:22:59.697906Z","steps":["trace[783987844] 'read index received' (duration: 71.16927ms)","trace[783987844] 'applied index is now lower than readState.Index' (duration: 193.506141ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:22:59.698057Z","caller":"traceutil/trace.go:171","msg":"trace[521166270] transaction","detail":"{read_only:false; response_revision:2566; number_of_response:1; }","duration":"292.27265ms","start":"2026-06-30T22:22:59.405764Z","end":"2026-06-30T22:22:59.698036Z","steps":["trace[521166270] 'process raft request' (duration: 282.057437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:22:59.698583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.317537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-06-30T22:22:59.698681Z","caller":"traceutil/trace.go:171","msg":"trace[1296858631] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2566; }","duration":"265.487691ms","start":"2026-06-30T22:22:59.433166Z","end":"2026-06-30T22:22:59.698653Z","steps":["trace[1296858631] 'agreement among raft nodes before linearized reading' (duration: 264.897717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:16.016868Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104109391212837,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T22:26:16.754446Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104109391212837,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T22:26:16.755209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.391445115s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:26:16.755274Z","caller":"traceutil/trace.go:171","msg":"trace[304153841] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:3853; }","duration":"1.391565778s","start":"2026-06-30T22:26:15.363694Z","end":"2026-06-30T22:26:16.75526Z","steps":["trace[304153841] 'count revisions from in-memory index tree' (duration: 1.391296932s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:16.755299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:15.363671Z","time spent":"1.391621689s","remote":"127.0.0.1:48392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-30T22:26:17.254041Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.862103531s","expected-duration":"1s"} {"level":"info","ts":"2026-06-30T22:26:17.257275Z","caller":"traceutil/trace.go:171","msg":"trace[734272528] linearizableReadLoop","detail":"{readStateIndex:4002; appliedIndex:4001; }","duration":"1.740734206s","start":"2026-06-30T22:26:15.516485Z","end":"2026-06-30T22:26:17.257219Z","steps":["trace[734272528] 'read index received' (duration: 1.738086133s)","trace[734272528] 'applied index is now lower than readState.Index' (duration: 2.644423ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:26:17.257523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.741034543s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-30T22:26:17.257647Z","caller":"traceutil/trace.go:171","msg":"trace[447355529] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3853; }","duration":"1.741203278s","start":"2026-06-30T22:26:15.516423Z","end":"2026-06-30T22:26:17.257626Z","steps":["trace[447355529] 'agreement among raft nodes before linearized reading' (duration: 1.74092188s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.257699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:15.516405Z","time spent":"1.74128353s","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T22:26:17.258883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.735214594s","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-30T22:26:17.258958Z","caller":"traceutil/trace.go:171","msg":"trace[2104944736] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3855; }","duration":"1.735314086s","start":"2026-06-30T22:26:15.523627Z","end":"2026-06-30T22:26:17.258941Z","steps":["trace[2104944736] 'agreement among raft nodes before linearized reading' (duration: 1.735115941s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.259008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:15.523618Z","time spent":"1.735378338s","remote":"127.0.0.1:34588","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-30T22:26:17.259404Z","caller":"traceutil/trace.go:171","msg":"trace[1691740586] transaction","detail":"{read_only:false; response_revision:3854; number_of_response:1; }","duration":"501.535267ms","start":"2026-06-30T22:26:16.757856Z","end":"2026-06-30T22:26:17.259391Z","steps":["trace[1691740586] 'process raft request' (duration: 500.700747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.259701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:16.757846Z","time spent":"501.598288ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:26:17.259767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.449734ms","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-30T22:26:17.259812Z","caller":"traceutil/trace.go:171","msg":"trace[1103164022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3855; }","duration":"382.537316ms","start":"2026-06-30T22:26:16.877262Z","end":"2026-06-30T22:26:17.259799Z","steps":["trace[1103164022] 'agreement among raft nodes before linearized reading' (duration: 382.392493ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.259857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:16.877242Z","time spent":"382.606787ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-30T22:26:17.259729Z","caller":"traceutil/trace.go:171","msg":"trace[1302015156] transaction","detail":"{read_only:false; response_revision:3855; number_of_response:1; }","duration":"240.488927ms","start":"2026-06-30T22:26:17.01921Z","end":"2026-06-30T22:26:17.259699Z","steps":["trace[1302015156] 'process raft request' (duration: 239.480643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.259896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.692434ms","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":"warn","ts":"2026-06-30T22:26:17.259991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.262797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:26:17.260042Z","caller":"traceutil/trace.go:171","msg":"trace[2051412339] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3855; }","duration":"502.871868ms","start":"2026-06-30T22:26:16.757136Z","end":"2026-06-30T22:26:17.260008Z","steps":["trace[2051412339] 'agreement among raft nodes before linearized reading' (duration: 502.462358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.260076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.220536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"warn","ts":"2026-06-30T22:26:17.260112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:16.757122Z","time spent":"502.97787ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-30T22:26:17.260155Z","caller":"traceutil/trace.go:171","msg":"trace[1626068010] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:3855; }","duration":"379.34955ms","start":"2026-06-30T22:26:16.880783Z","end":"2026-06-30T22:26:17.260133Z","steps":["trace[1626068010] 'agreement among raft nodes before linearized reading' (duration: 379.222337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.260209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:16.880756Z","time spent":"379.440452ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"info","ts":"2026-06-30T22:26:17.260048Z","caller":"traceutil/trace.go:171","msg":"trace[1693728718] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:3855; }","duration":"503.320289ms","start":"2026-06-30T22:26:16.75671Z","end":"2026-06-30T22:26:17.260031Z","steps":["trace[1693728718] 'agreement among raft nodes before linearized reading' (duration: 503.192976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.260289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.407768757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8ngxm\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-06-30T22:26:17.260165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.245264427s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-30T22:26:17.260331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:16.756681Z","time spent":"503.629765ms","remote":"127.0.0.1:34838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":41,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"info","ts":"2026-06-30T22:26:17.260384Z","caller":"traceutil/trace.go:171","msg":"trace[1198601055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3855; }","duration":"1.245472291s","start":"2026-06-30T22:26:16.014886Z","end":"2026-06-30T22:26:17.260359Z","steps":["trace[1198601055] 'agreement among raft nodes before linearized reading' (duration: 1.245188375s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.260417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.115873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:26:17.26046Z","caller":"traceutil/trace.go:171","msg":"trace[1881933970] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:3855; }","duration":"503.190316ms","start":"2026-06-30T22:26:16.757256Z","end":"2026-06-30T22:26:17.260447Z","steps":["trace[1881933970] 'agreement among raft nodes before linearized reading' (duration: 503.119764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.260478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:16.014806Z","time spent":"1.245650927s","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T22:26:17.260515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:16.757243Z","time spent":"503.256928ms","remote":"127.0.0.1:48450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-06-30T22:26:17.260331Z","caller":"traceutil/trace.go:171","msg":"trace[557886424] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8ngxm; range_end:; response_count:1; response_revision:3855; }","duration":"1.407847298s","start":"2026-06-30T22:26:15.852471Z","end":"2026-06-30T22:26:17.260319Z","steps":["trace[557886424] 'agreement among raft nodes before linearized reading' (duration: 1.407718255s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.260611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:15.852449Z","time spent":"1.408146506s","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-8ngxm\" "} {"level":"warn","ts":"2026-06-30T22:26:17.260645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.421902ms","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-30T22:26:17.260802Z","caller":"traceutil/trace.go:171","msg":"trace[677896757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3855; }","duration":"503.611406ms","start":"2026-06-30T22:26:16.757172Z","end":"2026-06-30T22:26:17.260783Z","steps":["trace[677896757] 'agreement among raft nodes before linearized reading' (duration: 503.085453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.260944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:16.757151Z","time spent":"503.77394ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T22:26:17.260874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.633173582s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:26:17.267826Z","caller":"traceutil/trace.go:171","msg":"trace[931915753] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3855; }","duration":"1.640151869s","start":"2026-06-30T22:26:15.627648Z","end":"2026-06-30T22:26:17.267799Z","steps":["trace[931915753] 'agreement among raft nodes before linearized reading' (duration: 1.63267633s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:26:17.267962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:26:15.627627Z","time spent":"1.640266291s","remote":"127.0.0.1:34356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T22:27:06.002108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.069666ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-30T22:27:06.002261Z","caller":"traceutil/trace.go:171","msg":"trace[796938183] linearizableReadLoop","detail":"{readStateIndex:4966; appliedIndex:4965; }","duration":"180.466124ms","start":"2026-06-30T22:27:05.821771Z","end":"2026-06-30T22:27:06.002237Z","steps":["trace[796938183] 'read index received' (duration: 442.31µs)","trace[796938183] 'applied index is now lower than readState.Index' (duration: 180.021694ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:27:06.002505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.70377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-753d2354-00c0-4d40-8277-0507ae76e77d\" ","response":"range_response_count:1 size:3600"} {"level":"warn","ts":"2026-06-30T22:27:06.002567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.207564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/monitoring\" ","response":"range_response_count:1 size:372"} {"level":"info","ts":"2026-06-30T22:27:06.00261Z","caller":"traceutil/trace.go:171","msg":"trace[743234910] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-753d2354-00c0-4d40-8277-0507ae76e77d; range_end:; response_count:1; response_revision:4783; }","duration":"180.837973ms","start":"2026-06-30T22:27:05.821746Z","end":"2026-06-30T22:27:06.002584Z","steps":["trace[743234910] 'agreement among raft nodes before linearized reading' (duration: 180.544996ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:06.002622Z","caller":"traceutil/trace.go:171","msg":"trace[2034547476] range","detail":"{range_begin:/registry/namespaces/monitoring; range_end:; response_count:1; response_revision:4783; }","duration":"179.310356ms","start":"2026-06-30T22:27:05.823294Z","end":"2026-06-30T22:27:06.002605Z","steps":["trace[2034547476] 'agreement among raft nodes before linearized reading' (duration: 179.084251ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:08.54427Z","caller":"traceutil/trace.go:171","msg":"trace[879614368] linearizableReadLoop","detail":"{readStateIndex:5019; appliedIndex:5016; }","duration":"188.776258ms","start":"2026-06-30T22:27:08.35547Z","end":"2026-06-30T22:27:08.544246Z","steps":["trace[879614368] 'read index received' (duration: 22.926289ms)","trace[879614368] 'applied index is now lower than readState.Index' (duration: 165.848579ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:27:08.544409Z","caller":"traceutil/trace.go:171","msg":"trace[1325361673] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"194.711818ms","start":"2026-06-30T22:27:08.349663Z","end":"2026-06-30T22:27:08.544375Z","steps":["trace[1325361673] 'process raft request' (duration: 183.092695ms)","trace[1325361673] 'compare' (duration: 11.259725ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:27:08.544478Z","caller":"traceutil/trace.go:171","msg":"trace[1175241173] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"194.351801ms","start":"2026-06-30T22:27:08.350116Z","end":"2026-06-30T22:27:08.544468Z","steps":["trace[1175241173] 'process raft request' (duration: 194.080364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:27:08.544437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.943233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:27:08.544632Z","caller":"traceutil/trace.go:171","msg":"trace[1227198340] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:4834; }","duration":"189.166218ms","start":"2026-06-30T22:27:08.35543Z","end":"2026-06-30T22:27:08.544597Z","steps":["trace[1227198340] 'agreement among raft nodes before linearized reading' (duration: 188.918582ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:19.732994Z","caller":"traceutil/trace.go:171","msg":"trace[1173290229] transaction","detail":"{read_only:false; response_revision:5043; number_of_response:1; }","duration":"170.351056ms","start":"2026-06-30T22:27:19.562591Z","end":"2026-06-30T22:27:19.732942Z","steps":["trace[1173290229] 'process raft request' (duration: 170.166811ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:19.732976Z","caller":"traceutil/trace.go:171","msg":"trace[501373555] linearizableReadLoop","detail":"{readStateIndex:5234; appliedIndex:5233; }","duration":"161.63473ms","start":"2026-06-30T22:27:19.571305Z","end":"2026-06-30T22:27:19.732939Z","steps":["trace[501373555] 'read index received' (duration: 161.383934ms)","trace[501373555] 'applied index is now lower than readState.Index' (duration: 249.866µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:27:19.733285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.460124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-06-30T22:27:19.733373Z","caller":"traceutil/trace.go:171","msg":"trace[1224989661] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5043; }","duration":"141.604787ms","start":"2026-06-30T22:27:19.591748Z","end":"2026-06-30T22:27:19.733353Z","steps":["trace[1224989661] 'agreement among raft nodes before linearized reading' (duration: 141.379512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:27:19.733398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.621631ms","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-30T22:27:19.733405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.483826ms","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-30T22:27:19.733441Z","caller":"traceutil/trace.go:171","msg":"trace[2041606753] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5043; }","duration":"150.546548ms","start":"2026-06-30T22:27:19.582882Z","end":"2026-06-30T22:27:19.733428Z","steps":["trace[2041606753] 'agreement among raft nodes before linearized reading' (duration: 150.401815ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:19.73344Z","caller":"traceutil/trace.go:171","msg":"trace[1107950772] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5043; }","duration":"156.685063ms","start":"2026-06-30T22:27:19.576739Z","end":"2026-06-30T22:27:19.733425Z","steps":["trace[1107950772] 'agreement among raft nodes before linearized reading' (duration: 156.607291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:27:19.733295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.926257ms","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-30T22:27:19.733528Z","caller":"traceutil/trace.go:171","msg":"trace[356744676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5043; }","duration":"162.251584ms","start":"2026-06-30T22:27:19.571267Z","end":"2026-06-30T22:27:19.733518Z","steps":["trace[356744676] 'agreement among raft nodes before linearized reading' (duration: 161.781013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:27:19.733678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.86274ms","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":"warn","ts":"2026-06-30T22:27:19.73366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.646536ms","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-30T22:27:19.733704Z","caller":"traceutil/trace.go:171","msg":"trace[105721251] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5043; }","duration":"137.90969ms","start":"2026-06-30T22:27:19.595787Z","end":"2026-06-30T22:27:19.733697Z","steps":["trace[105721251] 'agreement among raft nodes before linearized reading' (duration: 137.838089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:27:19.733685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.32392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8ngxm\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-06-30T22:27:19.733735Z","caller":"traceutil/trace.go:171","msg":"trace[1097737457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5043; }","duration":"157.780829ms","start":"2026-06-30T22:27:19.575937Z","end":"2026-06-30T22:27:19.733717Z","steps":["trace[1097737457] 'agreement among raft nodes before linearized reading' (duration: 157.354069ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:19.733774Z","caller":"traceutil/trace.go:171","msg":"trace[413253573] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8ngxm; range_end:; response_count:1; response_revision:5043; }","duration":"141.439954ms","start":"2026-06-30T22:27:19.592315Z","end":"2026-06-30T22:27:19.733754Z","steps":["trace[413253573] 'agreement among raft nodes before linearized reading' (duration: 141.189238ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:26.054718Z","caller":"traceutil/trace.go:171","msg":"trace[109979916] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"216.876052ms","start":"2026-06-30T22:27:25.837814Z","end":"2026-06-30T22:27:26.05469Z","steps":["trace[109979916] 'process raft request' (duration: 170.291424ms)","trace[109979916] 'compare' (duration: 46.171199ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:27:26.055048Z","caller":"traceutil/trace.go:171","msg":"trace[1677662960] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"217.128218ms","start":"2026-06-30T22:27:25.837909Z","end":"2026-06-30T22:27:26.055037Z","steps":["trace[1677662960] 'process raft request' (duration: 216.728769ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:26.05512Z","caller":"traceutil/trace.go:171","msg":"trace[832504123] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"216.849031ms","start":"2026-06-30T22:27:25.838242Z","end":"2026-06-30T22:27:26.055091Z","steps":["trace[832504123] 'process raft request' (duration: 216.749128ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:26.055186Z","caller":"traceutil/trace.go:171","msg":"trace[748749712] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"216.965083ms","start":"2026-06-30T22:27:25.838181Z","end":"2026-06-30T22:27:26.055146Z","steps":["trace[748749712] 'process raft request' (duration: 216.699107ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:26.055385Z","caller":"traceutil/trace.go:171","msg":"trace[1381351470] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"217.076716ms","start":"2026-06-30T22:27:25.838297Z","end":"2026-06-30T22:27:26.055374Z","steps":["trace[1381351470] 'process raft request' (duration: 216.959514ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:27:26.055385Z","caller":"traceutil/trace.go:171","msg":"trace[360395120] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"217.122617ms","start":"2026-06-30T22:27:25.838246Z","end":"2026-06-30T22:27:26.055368Z","steps":["trace[360395120] 'process raft request' (duration: 216.79582ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:26.551664Z","caller":"traceutil/trace.go:171","msg":"trace[179510787] transaction","detail":"{read_only:false; response_revision:5785; number_of_response:1; }","duration":"125.629045ms","start":"2026-06-30T22:28:26.426005Z","end":"2026-06-30T22:28:26.551634Z","steps":["trace[179510787] 'process raft request' (duration: 122.999173ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:26.559199Z","caller":"traceutil/trace.go:171","msg":"trace[1710227660] transaction","detail":"{read_only:false; response_revision:5786; number_of_response:1; }","duration":"133.132584ms","start":"2026-06-30T22:28:26.426046Z","end":"2026-06-30T22:28:26.559179Z","steps":["trace[1710227660] 'process raft request' (duration: 133.034722ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:47.209328Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2815} {"level":"info","ts":"2026-06-30T22:28:47.280881Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2815,"took":"70.185398ms","hash":2785814949,"current-db-size-bytes":58437632,"current-db-size":"58 MB","current-db-size-in-use-bytes":33476608,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-30T22:28:47.280954Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2785814949,"revision":2815,"compact-revision":-1} {"level":"info","ts":"2026-06-30T22:33:11.190732Z","caller":"traceutil/trace.go:171","msg":"trace[1483233437] linearizableReadLoop","detail":"{readStateIndex:8207; appliedIndex:8206; }","duration":"269.030762ms","start":"2026-06-30T22:33:10.921676Z","end":"2026-06-30T22:33:11.190706Z","steps":["trace[1483233437] 'read index received' (duration: 268.852878ms)","trace[1483233437] 'applied index is now lower than readState.Index' (duration: 176.234µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:33:11.190774Z","caller":"traceutil/trace.go:171","msg":"trace[739561375] transaction","detail":"{read_only:false; response_revision:7926; number_of_response:1; }","duration":"311.459004ms","start":"2026-06-30T22:33:10.879281Z","end":"2026-06-30T22:33:11.19074Z","steps":["trace[739561375] 'process raft request' (duration: 311.26196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:33:11.190939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:33:10.879253Z","time spent":"311.599268ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:33:11.191397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.700278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414394"} {"level":"info","ts":"2026-06-30T22:33:11.191492Z","caller":"traceutil/trace.go:171","msg":"trace[89865222] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:7926; }","duration":"269.812701ms","start":"2026-06-30T22:33:10.92166Z","end":"2026-06-30T22:33:11.191473Z","steps":["trace[89865222] 'agreement among raft nodes before linearized reading' (duration: 269.182126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:33:23.991157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.198884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8ngxm\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-06-30T22:33:23.991291Z","caller":"traceutil/trace.go:171","msg":"trace[473965767] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8ngxm; range_end:; response_count:1; response_revision:7990; }","duration":"183.375558ms","start":"2026-06-30T22:33:23.807894Z","end":"2026-06-30T22:33:23.99127Z","steps":["trace[473965767] 'range keys from in-memory index tree' (duration: 183.01837ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:24.155203Z","caller":"traceutil/trace.go:171","msg":"trace[1547905888] transaction","detail":"{read_only:false; response_revision:7992; number_of_response:1; }","duration":"159.278578ms","start":"2026-06-30T22:33:23.995899Z","end":"2026-06-30T22:33:24.155178Z","steps":["trace[1547905888] 'process raft request' (duration: 115.114864ms)","trace[1547905888] 'compare' (duration: 43.643102ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:33:24.155453Z","caller":"traceutil/trace.go:171","msg":"trace[603227688] linearizableReadLoop","detail":"{readStateIndex:8277; appliedIndex:8274; }","duration":"114.590571ms","start":"2026-06-30T22:33:24.040835Z","end":"2026-06-30T22:33:24.155426Z","steps":["trace[603227688] 'read index received' (duration: 70.093159ms)","trace[603227688] 'applied index is now lower than readState.Index' (duration: 44.496122ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:33:24.155493Z","caller":"traceutil/trace.go:171","msg":"trace[505979668] transaction","detail":"{read_only:false; response_revision:7994; number_of_response:1; }","duration":"156.784548ms","start":"2026-06-30T22:33:23.998672Z","end":"2026-06-30T22:33:24.155457Z","steps":["trace[505979668] 'process raft request' (duration: 156.639064ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:24.155498Z","caller":"traceutil/trace.go:171","msg":"trace[54953921] transaction","detail":"{read_only:false; response_revision:7993; number_of_response:1; }","duration":"159.529604ms","start":"2026-06-30T22:33:23.995902Z","end":"2026-06-30T22:33:24.155432Z","steps":["trace[54953921] 'process raft request' (duration: 159.225887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:33:24.155683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.819649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"warn","ts":"2026-06-30T22:33:24.155708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.862988ms","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-30T22:33:24.155731Z","caller":"traceutil/trace.go:171","msg":"trace[288227356] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:7994; }","duration":"112.90336ms","start":"2026-06-30T22:33:24.042809Z","end":"2026-06-30T22:33:24.155712Z","steps":["trace[288227356] 'agreement among raft nodes before linearized reading' (duration: 112.767377ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:24.155751Z","caller":"traceutil/trace.go:171","msg":"trace[1671306101] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7994; }","duration":"114.95668ms","start":"2026-06-30T22:33:24.040779Z","end":"2026-06-30T22:33:24.155735Z","steps":["trace[1671306101] 'agreement among raft nodes before linearized reading' (duration: 114.795676ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:33:47.214966Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5946} {"level":"info","ts":"2026-06-30T22:33:47.39096Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5946,"took":"174.400681ms","hash":2730377060,"current-db-size-bytes":58437632,"current-db-size":"58 MB","current-db-size-in-use-bytes":22736896,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-30T22:33:47.391036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2730377060,"revision":5946,"compact-revision":2815} {"level":"info","ts":"2026-06-30T22:34:03.666885Z","caller":"traceutil/trace.go:171","msg":"trace[2117598653] transaction","detail":"{read_only:false; response_revision:8299; number_of_response:1; }","duration":"178.402208ms","start":"2026-06-30T22:34:03.488441Z","end":"2026-06-30T22:34:03.666843Z","steps":["trace[2117598653] 'process raft request' (duration: 178.087321ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:34:03.900685Z","caller":"traceutil/trace.go:171","msg":"trace[382512716] transaction","detail":"{read_only:false; response_revision:8300; number_of_response:1; }","duration":"135.772081ms","start":"2026-06-30T22:34:03.764859Z","end":"2026-06-30T22:34:03.900631Z","steps":["trace[382512716] 'process raft request' (duration: 135.519925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:04.740315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.034875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:34:04.740446Z","caller":"traceutil/trace.go:171","msg":"trace[1096622227] linearizableReadLoop","detail":"{readStateIndex:8600; appliedIndex:8598; }","duration":"375.377345ms","start":"2026-06-30T22:34:04.365047Z","end":"2026-06-30T22:34:04.740424Z","steps":["trace[1096622227] 'read index received' (duration: 78.815729ms)","trace[1096622227] 'applied index is now lower than readState.Index' (duration: 296.559976ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:34:04.740556Z","caller":"traceutil/trace.go:171","msg":"trace[2142737617] transaction","detail":"{read_only:false; response_revision:8304; number_of_response:1; }","duration":"376.332419ms","start":"2026-06-30T22:34:04.364205Z","end":"2026-06-30T22:34:04.740538Z","steps":["trace[2142737617] 'process raft request' (duration: 103.940705ms)","trace[2142737617] 'compare' (duration: 271.87163ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:34:04.740868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:34:04.364195Z","time spent":"376.620875ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:34:04.740906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.770554ms","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-30T22:34:04.741079Z","caller":"traceutil/trace.go:171","msg":"trace[165085575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8304; }","duration":"376.085811ms","start":"2026-06-30T22:34:04.364973Z","end":"2026-06-30T22:34:04.741059Z","steps":["trace[165085575] 'agreement among raft nodes before linearized reading' (duration: 375.671821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:04.741197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:34:04.36484Z","time spent":"376.344068ms","remote":"127.0.0.1:34588","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-30T22:34:04.778001Z","caller":"traceutil/trace.go:171","msg":"trace[1527664878] transaction","detail":"{read_only:false; response_revision:8305; number_of_response:1; }","duration":"287.967749ms","start":"2026-06-30T22:34:04.49001Z","end":"2026-06-30T22:34:04.777978Z","steps":["trace[1527664878] 'process raft request' (duration: 287.732043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:04.778075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.554941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"info","ts":"2026-06-30T22:34:04.778117Z","caller":"traceutil/trace.go:171","msg":"trace[1836963548] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8305; }","duration":"229.630303ms","start":"2026-06-30T22:34:04.548475Z","end":"2026-06-30T22:34:04.778105Z","steps":["trace[1836963548] 'agreement among raft nodes before linearized reading' (duration: 229.456498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:04.778129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.739417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T22:34:04.778196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.800748ms","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-30T22:34:04.778242Z","caller":"traceutil/trace.go:171","msg":"trace[96211743] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8305; }","duration":"378.874399ms","start":"2026-06-30T22:34:04.399356Z","end":"2026-06-30T22:34:04.77823Z","steps":["trace[96211743] 'agreement among raft nodes before linearized reading' (duration: 378.756266ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:34:04.778236Z","caller":"traceutil/trace.go:171","msg":"trace[1642224515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8305; }","duration":"149.907161ms","start":"2026-06-30T22:34:04.628305Z","end":"2026-06-30T22:34:04.778212Z","steps":["trace[1642224515] 'agreement among raft nodes before linearized reading' (duration: 149.734227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:04.778267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:34:04.399342Z","time spent":"378.91787ms","remote":"127.0.0.1:34588","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-30T22:34:04.778134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.032548ms","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-30T22:34:04.778319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.671406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6k9rr\" ","response":"range_response_count:1 size:4649"} {"level":"info","ts":"2026-06-30T22:34:04.778355Z","caller":"traceutil/trace.go:171","msg":"trace[526575729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8305; }","duration":"412.309584ms","start":"2026-06-30T22:34:04.366026Z","end":"2026-06-30T22:34:04.778336Z","steps":["trace[526575729] 'agreement among raft nodes before linearized reading' (duration: 411.879264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:34:04.778437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:34:04.366008Z","time spent":"412.390847ms","remote":"127.0.0.1:34588","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":"info","ts":"2026-06-30T22:34:04.77845Z","caller":"traceutil/trace.go:171","msg":"trace[750905107] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-6k9rr; range_end:; response_count:1; response_revision:8305; }","duration":"288.828649ms","start":"2026-06-30T22:34:04.489565Z","end":"2026-06-30T22:34:04.778394Z","steps":["trace[750905107] 'agreement among raft nodes before linearized reading' (duration: 288.510862ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:35:00.35563Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023e4.wal"} {"level":"info","ts":"2026-06-30T22:35:01.114445Z","caller":"traceutil/trace.go:171","msg":"trace[1572966833] transaction","detail":"{read_only:false; response_revision:8878; number_of_response:1; }","duration":"101.692261ms","start":"2026-06-30T22:35:01.012733Z","end":"2026-06-30T22:35:01.114425Z","steps":["trace[1572966833] 'process raft request' (duration: 101.511736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:35:11.404052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.583078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:35:11.404278Z","caller":"traceutil/trace.go:171","msg":"trace[1800606857] transaction","detail":"{read_only:false; response_revision:8939; number_of_response:1; }","duration":"152.582636ms","start":"2026-06-30T22:35:11.25168Z","end":"2026-06-30T22:35:11.404262Z","steps":["trace[1800606857] 'process raft request' (duration: 152.544345ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:35:11.404287Z","caller":"traceutil/trace.go:171","msg":"trace[1536879884] transaction","detail":"{read_only:false; response_revision:8937; number_of_response:1; }","duration":"153.317554ms","start":"2026-06-30T22:35:11.250933Z","end":"2026-06-30T22:35:11.404251Z","steps":["trace[1536879884] 'process raft request' (duration: 29.440689ms)","trace[1536879884] 'compare' (duration: 123.458225ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:35:11.404435Z","caller":"traceutil/trace.go:171","msg":"trace[1583384781] transaction","detail":"{read_only:false; response_revision:8938; number_of_response:1; }","duration":"153.022227ms","start":"2026-06-30T22:35:11.251404Z","end":"2026-06-30T22:35:11.404426Z","steps":["trace[1583384781] 'process raft request' (duration: 152.765021ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:35:11.431702Z","caller":"traceutil/trace.go:171","msg":"trace[873486965] transaction","detail":"{read_only:false; response_revision:8940; number_of_response:1; }","duration":"116.878765ms","start":"2026-06-30T22:35:11.314803Z","end":"2026-06-30T22:35:11.431682Z","steps":["trace[873486965] 'process raft request' (duration: 116.536227ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:35:11.432073Z","caller":"traceutil/trace.go:171","msg":"trace[471464526] transaction","detail":"{read_only:false; response_revision:8941; number_of_response:1; }","duration":"102.228773ms","start":"2026-06-30T22:35:11.329798Z","end":"2026-06-30T22:35:11.432027Z","steps":["trace[471464526] 'process raft request' (duration: 101.821864ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:36:38.005189Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b6478f0ac5aeb8e1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-30T22:36:38.011601Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-30T22:36:38.011683Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-30T22:38:47.221312Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8168} {"level":"info","ts":"2026-06-30T22:38:47.299843Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8168,"took":"76.130829ms","hash":894913581,"current-db-size-bytes":58437632,"current-db-size":"58 MB","current-db-size-in-use-bytes":26169344,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-30T22:38:47.299916Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":894913581,"revision":8168,"compact-revision":5946} {"level":"info","ts":"2026-06-30T22:38:47.823057Z","caller":"traceutil/trace.go:171","msg":"trace[1557170824] transaction","detail":"{read_only:false; response_revision:10842; number_of_response:1; }","duration":"120.097819ms","start":"2026-06-30T22:38:47.702908Z","end":"2026-06-30T22:38:47.823006Z","steps":["trace[1557170824] 'process raft request' (duration: 119.903774ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:38:47.957168Z","caller":"traceutil/trace.go:171","msg":"trace[1562496036] linearizableReadLoop","detail":"{readStateIndex:11213; appliedIndex:11212; }","duration":"107.482984ms","start":"2026-06-30T22:38:47.849654Z","end":"2026-06-30T22:38:47.957137Z","steps":["trace[1562496036] 'read index received' (duration: 8.931887ms)","trace[1562496036] 'applied index is now lower than readState.Index' (duration: 98.549897ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:38:47.958118Z","caller":"traceutil/trace.go:171","msg":"trace[164940982] transaction","detail":"{read_only:false; response_revision:10843; number_of_response:1; }","duration":"110.146178ms","start":"2026-06-30T22:38:47.847947Z","end":"2026-06-30T22:38:47.958093Z","steps":["trace[164940982] 'process raft request' (duration: 10.690129ms)","trace[164940982] 'compare' (duration: 98.354943ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:38:47.959426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.740089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-30T22:38:47.959574Z","caller":"traceutil/trace.go:171","msg":"trace[1923033186] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:10843; }","duration":"109.915254ms","start":"2026-06-30T22:38:47.849639Z","end":"2026-06-30T22:38:47.959554Z","steps":["trace[1923033186] 'agreement among raft nodes before linearized reading' (duration: 107.629158ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:43:47.227936Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10840} {"level":"info","ts":"2026-06-30T22:43:47.311067Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10840,"took":"80.695186ms","hash":4233638936,"current-db-size-bytes":58437632,"current-db-size":"58 MB","current-db-size-in-use-bytes":27455488,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-30T22:43:47.311138Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4233638936,"revision":10840,"compact-revision":8168} {"level":"info","ts":"2026-06-30T22:45:10.476354Z","caller":"traceutil/trace.go:171","msg":"trace[290129852] linearizableReadLoop","detail":"{readStateIndex:13884; appliedIndex:13883; }","duration":"199.934727ms","start":"2026-06-30T22:45:10.276396Z","end":"2026-06-30T22:45:10.47633Z","steps":["trace[290129852] 'read index received' (duration: 199.763063ms)","trace[290129852] 'applied index is now lower than readState.Index' (duration: 170.494µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:45:10.476422Z","caller":"traceutil/trace.go:171","msg":"trace[635234571] transaction","detail":"{read_only:false; response_revision:13424; number_of_response:1; }","duration":"202.167211ms","start":"2026-06-30T22:45:10.274219Z","end":"2026-06-30T22:45:10.476386Z","steps":["trace[635234571] 'process raft request' (duration: 201.971046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:45:10.476672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.245054ms","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-30T22:45:10.476764Z","caller":"traceutil/trace.go:171","msg":"trace[1562627240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13424; }","duration":"200.390958ms","start":"2026-06-30T22:45:10.27635Z","end":"2026-06-30T22:45:10.476741Z","steps":["trace[1562627240] 'agreement among raft nodes before linearized reading' (duration: 200.125951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:45:10.476736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.672163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-30T22:45:10.476817Z","caller":"traceutil/trace.go:171","msg":"trace[888190981] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:13424; }","duration":"103.807486ms","start":"2026-06-30T22:45:10.372997Z","end":"2026-06-30T22:45:10.476805Z","steps":["trace[888190981] 'agreement among raft nodes before linearized reading' (duration: 103.606751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:45:10.476983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.397638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-30T22:45:10.476998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.629767ms","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-30T22:45:10.477073Z","caller":"traceutil/trace.go:171","msg":"trace[927194872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13424; }","duration":"200.580172ms","start":"2026-06-30T22:45:10.276478Z","end":"2026-06-30T22:45:10.477058Z","steps":["trace[927194872] 'agreement among raft nodes before linearized reading' (duration: 200.004598ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:45:10.477099Z","caller":"traceutil/trace.go:171","msg":"trace[1094917447] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:13424; }","duration":"156.791761ms","start":"2026-06-30T22:45:10.320283Z","end":"2026-06-30T22:45:10.477075Z","steps":["trace[1094917447] 'agreement among raft nodes before linearized reading' (duration: 156.480323ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:45:10.671444Z","caller":"traceutil/trace.go:171","msg":"trace[89614645] transaction","detail":"{read_only:false; response_revision:13426; number_of_response:1; }","duration":"187.185668ms","start":"2026-06-30T22:45:10.48423Z","end":"2026-06-30T22:45:10.671415Z","steps":["trace[89614645] 'process raft request' (duration: 187.116486ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:45:10.671445Z","caller":"traceutil/trace.go:171","msg":"trace[1807060895] transaction","detail":"{read_only:false; response_revision:13425; number_of_response:1; }","duration":"189.829942ms","start":"2026-06-30T22:45:10.481583Z","end":"2026-06-30T22:45:10.671412Z","steps":["trace[1807060895] 'process raft request' (duration: 189.616827ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:45:10.67162Z","caller":"traceutil/trace.go:171","msg":"trace[1973610494] transaction","detail":"{read_only:false; response_revision:13427; number_of_response:1; }","duration":"187.264109ms","start":"2026-06-30T22:45:10.484325Z","end":"2026-06-30T22:45:10.67159Z","steps":["trace[1973610494] 'process raft request' (duration: 187.056474ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:45:18.8418Z","caller":"traceutil/trace.go:171","msg":"trace[913543847] transaction","detail":"{read_only:false; response_revision:13581; number_of_response:1; }","duration":"130.149075ms","start":"2026-06-30T22:45:18.711602Z","end":"2026-06-30T22:45:18.841752Z","steps":["trace[913543847] 'process raft request' (duration: 129.972961ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:45:18.841885Z","caller":"traceutil/trace.go:171","msg":"trace[980980394] transaction","detail":"{read_only:false; response_revision:13582; number_of_response:1; }","duration":"129.409566ms","start":"2026-06-30T22:45:18.712441Z","end":"2026-06-30T22:45:18.84185Z","steps":["trace[980980394] 'process raft request' (duration: 129.238452ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:45:19.003956Z","caller":"traceutil/trace.go:171","msg":"trace[1131382399] transaction","detail":"{read_only:false; response_revision:13583; number_of_response:1; }","duration":"154.792803ms","start":"2026-06-30T22:45:18.849131Z","end":"2026-06-30T22:45:19.003924Z","steps":["trace[1131382399] 'process raft request' (duration: 154.594648ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:45:19.168883Z","caller":"traceutil/trace.go:171","msg":"trace[688710813] linearizableReadLoop","detail":"{readStateIndex:14048; appliedIndex:14047; }","duration":"120.03779ms","start":"2026-06-30T22:45:19.048823Z","end":"2026-06-30T22:45:19.168861Z","steps":["trace[688710813] 'read index received' (duration: 119.826964ms)","trace[688710813] 'applied index is now lower than readState.Index' (duration: 209.896µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:45:19.169039Z","caller":"traceutil/trace.go:171","msg":"trace[843318803] transaction","detail":"{read_only:false; response_revision:13584; number_of_response:1; }","duration":"155.034029ms","start":"2026-06-30T22:45:19.013991Z","end":"2026-06-30T22:45:19.169025Z","steps":["trace[843318803] 'process raft request' (duration: 154.719231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:45:19.169204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.366048ms","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-30T22:45:19.170323Z","caller":"traceutil/trace.go:171","msg":"trace[1340463375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13584; }","duration":"121.481584ms","start":"2026-06-30T22:45:19.048767Z","end":"2026-06-30T22:45:19.170249Z","steps":["trace[1340463375] 'agreement among raft nodes before linearized reading' (duration: 120.293496ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:46:56.398039Z","caller":"traceutil/trace.go:171","msg":"trace[2096682206] transaction","detail":"{read_only:false; response_revision:14655; number_of_response:1; }","duration":"129.767705ms","start":"2026-06-30T22:46:56.268253Z","end":"2026-06-30T22:46:56.398021Z","steps":["trace[2096682206] 'process raft request' (duration: 129.652622ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:46:56.602449Z","caller":"traceutil/trace.go:171","msg":"trace[440471768] transaction","detail":"{read_only:false; response_revision:14656; number_of_response:1; }","duration":"189.510674ms","start":"2026-06-30T22:46:56.412881Z","end":"2026-06-30T22:46:56.602392Z","steps":["trace[440471768] 'process raft request' (duration: 189.305959ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:48:47.235848Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12876} {"level":"info","ts":"2026-06-30T22:48:47.314096Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12876,"took":"75.644433ms","hash":1289189393,"current-db-size-bytes":58437632,"current-db-size":"58 MB","current-db-size-in-use-bytes":31424512,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-30T22:48:47.314156Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1289189393,"revision":12876,"compact-revision":10840} {"level":"info","ts":"2026-06-30T22:50:38.590628Z","caller":"traceutil/trace.go:171","msg":"trace[605380357] transaction","detail":"{read_only:false; response_revision:16378; number_of_response:1; }","duration":"129.005586ms","start":"2026-06-30T22:50:38.461598Z","end":"2026-06-30T22:50:38.590604Z","steps":["trace[605380357] 'process raft request' (duration: 128.876973ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:50:38.601025Z","caller":"traceutil/trace.go:171","msg":"trace[346752619] transaction","detail":"{read_only:false; response_revision:16379; number_of_response:1; }","duration":"130.815ms","start":"2026-06-30T22:50:38.470193Z","end":"2026-06-30T22:50:38.601008Z","steps":["trace[346752619] 'process raft request' (duration: 130.705837ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:50:38.601236Z","caller":"traceutil/trace.go:171","msg":"trace[756586075] transaction","detail":"{read_only:false; response_revision:16380; number_of_response:1; }","duration":"130.994224ms","start":"2026-06-30T22:50:38.470228Z","end":"2026-06-30T22:50:38.601222Z","steps":["trace[756586075] 'process raft request' (duration: 130.752508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:50:38.803381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.754465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:50:38.803549Z","caller":"traceutil/trace.go:171","msg":"trace[35685221] transaction","detail":"{read_only:false; response_revision:16383; number_of_response:1; }","duration":"137.77971ms","start":"2026-06-30T22:50:38.665753Z","end":"2026-06-30T22:50:38.803532Z","steps":["trace[35685221] 'process raft request' (duration: 137.719508ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:50:38.803604Z","caller":"traceutil/trace.go:171","msg":"trace[1410527336] transaction","detail":"{read_only:false; response_revision:16382; number_of_response:1; }","duration":"175.308189ms","start":"2026-06-30T22:50:38.628268Z","end":"2026-06-30T22:50:38.803576Z","steps":["trace[1410527336] 'process raft request' (duration: 31.265457ms)","trace[1410527336] 'compare' (duration: 143.652493ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:50:38.830626Z","caller":"traceutil/trace.go:171","msg":"trace[1489984349] linearizableReadLoop","detail":"{readStateIndex:16935; appliedIndex:16932; }","duration":"100.775272ms","start":"2026-06-30T22:50:38.729829Z","end":"2026-06-30T22:50:38.830604Z","steps":["trace[1489984349] 'read index received' (duration: 6.5929ms)","trace[1489984349] 'applied index is now lower than readState.Index' (duration: 94.181282ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:50:38.830762Z","caller":"traceutil/trace.go:171","msg":"trace[1138098958] transaction","detail":"{read_only:false; response_revision:16384; number_of_response:1; }","duration":"164.375303ms","start":"2026-06-30T22:50:38.666339Z","end":"2026-06-30T22:50:38.830714Z","steps":["trace[1138098958] 'process raft request' (duration: 164.130167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:50:38.8308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.952617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T22:50:38.830934Z","caller":"traceutil/trace.go:171","msg":"trace[1950678306] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:16384; }","duration":"101.133811ms","start":"2026-06-30T22:50:38.729773Z","end":"2026-06-30T22:50:38.830906Z","steps":["trace[1950678306] 'agreement among raft nodes before linearized reading' (duration: 100.967357ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:50:39.023919Z","caller":"traceutil/trace.go:171","msg":"trace[1332434789] transaction","detail":"{read_only:false; response_revision:16385; number_of_response:1; }","duration":"159.815983ms","start":"2026-06-30T22:50:38.864061Z","end":"2026-06-30T22:50:39.023877Z","steps":["trace[1332434789] 'process raft request' (duration: 96.448958ms)","trace[1332434789] 'compare' (duration: 63.15131ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:53:47.242576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15472} {"level":"info","ts":"2026-06-30T22:53:47.338478Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15472,"took":"92.736598ms","hash":3170116484,"current-db-size-bytes":58437632,"current-db-size":"58 MB","current-db-size-in-use-bytes":33280000,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-30T22:53:47.338534Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3170116484,"revision":15472,"compact-revision":12876} {"level":"info","ts":"2026-06-30T22:56:20.332114Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b6478f0ac5aeb8e1","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-30T22:56:20.337357Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-30T22:56:20.337457Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-30T22:58:47.248869Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18014} {"level":"info","ts":"2026-06-30T22:58:47.361504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18014,"took":"109.521515ms","hash":3414201418,"current-db-size-bytes":58437632,"current-db-size":"58 MB","current-db-size-in-use-bytes":31068160,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-30T22:58:47.361583Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3414201418,"revision":18014,"compact-revision":15472} {"level":"warn","ts":"2026-06-30T22:59:07.471732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.938414ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T22:59:07.472016Z","caller":"traceutil/trace.go:171","msg":"trace[1209530912] transaction","detail":"{read_only:false; response_revision:20540; number_of_response:1; }","duration":"285.182105ms","start":"2026-06-30T22:59:07.186745Z","end":"2026-06-30T22:59:07.471927Z","steps":["trace[1209530912] 'process raft request' (duration: 285.078172ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:59:07.47204Z","caller":"traceutil/trace.go:171","msg":"trace[1542106964] transaction","detail":"{read_only:false; response_revision:20539; number_of_response:1; }","duration":"285.228196ms","start":"2026-06-30T22:59:07.186745Z","end":"2026-06-30T22:59:07.471973Z","steps":["trace[1542106964] 'process raft request' (duration: 172.952034ms)","trace[1542106964] 'compare' (duration: 111.81193ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:59:07.472256Z","caller":"traceutil/trace.go:171","msg":"trace[1043202622] transaction","detail":"{read_only:false; response_revision:20541; number_of_response:1; }","duration":"284.967169ms","start":"2026-06-30T22:59:07.187248Z","end":"2026-06-30T22:59:07.472215Z","steps":["trace[1043202622] 'process raft request' (duration: 284.636902ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:59:07.739762Z","caller":"traceutil/trace.go:171","msg":"trace[1028059922] linearizableReadLoop","detail":"{readStateIndex:21225; appliedIndex:21224; }","duration":"111.991636ms","start":"2026-06-30T22:59:07.62775Z","end":"2026-06-30T22:59:07.739742Z","steps":["trace[1028059922] 'read index received' (duration: 111.845982ms)","trace[1028059922] 'applied index is now lower than readState.Index' (duration: 144.753µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:59:07.739899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.138259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T22:59:07.739918Z","caller":"traceutil/trace.go:171","msg":"trace[418537687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20542; }","duration":"112.214031ms","start":"2026-06-30T22:59:07.627698Z","end":"2026-06-30T22:59:07.739912Z","steps":["trace[418537687] 'agreement among raft nodes before linearized reading' (duration: 112.154689ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:59:07.740013Z","caller":"traceutil/trace.go:171","msg":"trace[2036621879] transaction","detail":"{read_only:false; response_revision:20542; number_of_response:1; }","duration":"262.71783ms","start":"2026-06-30T22:59:07.477072Z","end":"2026-06-30T22:59:07.73979Z","steps":["trace[2036621879] 'process raft request' (duration: 262.533165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:59:07.740069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.224736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-30T22:59:07.740931Z","caller":"traceutil/trace.go:171","msg":"trace[1950137771] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20542; }","duration":"107.167189ms","start":"2026-06-30T22:59:07.633747Z","end":"2026-06-30T22:59:07.740914Z","steps":["trace[1950137771] 'agreement among raft nodes before linearized reading' (duration: 106.146524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:59:08.045268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.873961ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T22:59:08.045349Z","caller":"traceutil/trace.go:171","msg":"trace[679265491] linearizableReadLoop","detail":"{readStateIndex:21226; appliedIndex:21225; }","duration":"182.648168ms","start":"2026-06-30T22:59:07.862686Z","end":"2026-06-30T22:59:08.045334Z","steps":["trace[679265491] 'read index received' (duration: 30.642583ms)","trace[679265491] 'applied index is now lower than readState.Index' (duration: 152.004185ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:59:08.045405Z","caller":"traceutil/trace.go:171","msg":"trace[406543509] transaction","detail":"{read_only:false; response_revision:20543; number_of_response:1; }","duration":"295.34604ms","start":"2026-06-30T22:59:07.750053Z","end":"2026-06-30T22:59:08.045399Z","steps":["trace[406543509] 'process raft request' (duration: 143.247833ms)","trace[406543509] 'compare' (duration: 151.621756ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:59:08.045563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.878364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-30T22:59:08.045584Z","caller":"traceutil/trace.go:171","msg":"trace[1922693204] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:20543; }","duration":"182.939825ms","start":"2026-06-30T22:59:07.862639Z","end":"2026-06-30T22:59:08.045579Z","steps":["trace[1922693204] 'agreement among raft nodes before linearized reading' (duration: 182.838023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:59:08.04574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.176602ms","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-30T22:59:08.045838Z","caller":"traceutil/trace.go:171","msg":"trace[1848155405] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20543; }","duration":"127.295346ms","start":"2026-06-30T22:59:07.918507Z","end":"2026-06-30T22:59:08.045803Z","steps":["trace[1848155405] 'agreement among raft nodes before linearized reading' (duration: 127.06587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:59:08.282744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.472888ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T22:59:08.282931Z","caller":"traceutil/trace.go:171","msg":"trace[509166773] transaction","detail":"{read_only:false; response_revision:20544; number_of_response:1; }","duration":"232.515158ms","start":"2026-06-30T22:59:08.050378Z","end":"2026-06-30T22:59:08.282894Z","steps":["trace[509166773] 'process raft request' (duration: 100.805324ms)","trace[509166773] 'compare' (duration: 131.174471ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:59:08.57473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.277546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T22:59:08.574988Z","caller":"traceutil/trace.go:171","msg":"trace[1497748755] transaction","detail":"{read_only:false; response_revision:20546; number_of_response:1; }","duration":"216.12013ms","start":"2026-06-30T22:59:08.358845Z","end":"2026-06-30T22:59:08.574965Z","steps":["trace[1497748755] 'process raft request' (duration: 216.040988ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:59:08.57503Z","caller":"traceutil/trace.go:171","msg":"trace[2078087077] transaction","detail":"{read_only:false; response_revision:20545; number_of_response:1; }","duration":"288.012792ms","start":"2026-06-30T22:59:08.286972Z","end":"2026-06-30T22:59:08.574985Z","steps":["trace[2078087077] 'process raft request' (duration: 134.344307ms)","trace[2078087077] 'compare' (duration: 152.998149ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:59:08.742601Z","caller":"traceutil/trace.go:171","msg":"trace[1159910369] linearizableReadLoop","detail":"{readStateIndex:21230; appliedIndex:21229; }","duration":"114.724851ms","start":"2026-06-30T22:59:08.62785Z","end":"2026-06-30T22:59:08.742575Z","steps":["trace[1159910369] 'read index received' (duration: 64.35493ms)","trace[1159910369] 'applied index is now lower than readState.Index' (duration: 50.368701ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:59:08.742714Z","caller":"traceutil/trace.go:171","msg":"trace[1654742509] transaction","detail":"{read_only:false; response_revision:20547; number_of_response:1; }","duration":"136.863768ms","start":"2026-06-30T22:59:08.605834Z","end":"2026-06-30T22:59:08.742698Z","steps":["trace[1654742509] 'process raft request' (duration: 86.341263ms)","trace[1654742509] 'compare' (duration: 50.248228ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:59:08.742893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.034159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T22:59:08.742962Z","caller":"traceutil/trace.go:171","msg":"trace[55460372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20547; }","duration":"115.168642ms","start":"2026-06-30T22:59:08.627779Z","end":"2026-06-30T22:59:08.742948Z","steps":["trace[55460372] 'agreement among raft nodes before linearized reading' (duration: 115.051989ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:59:08.744429Z","caller":"traceutil/trace.go:171","msg":"trace[405696653] transaction","detail":"{read_only:false; response_revision:20548; number_of_response:1; }","duration":"115.943182ms","start":"2026-06-30T22:59:08.628452Z","end":"2026-06-30T22:59:08.744396Z","steps":["trace[405696653] 'process raft request' (duration: 115.818029ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:03:47.254435Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20441} {"level":"info","ts":"2026-06-30T23:03:47.37199Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20441,"took":"113.094862ms","hash":2224165088,"current-db-size-bytes":58437632,"current-db-size":"58 MB","current-db-size-in-use-bytes":43692032,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-06-30T23:03:47.372048Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2224165088,"revision":20441,"compact-revision":18014} {"level":"warn","ts":"2026-06-30T23:06:08.186103Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104109391274026,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T23:06:08.643115Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.159243325s","expected-duration":"1s"} {"level":"info","ts":"2026-06-30T23:06:08.64349Z","caller":"traceutil/trace.go:171","msg":"trace[1352611705] transaction","detail":"{read_only:false; response_revision:25125; number_of_response:1; }","duration":"1.159728886s","start":"2026-06-30T23:06:07.483736Z","end":"2026-06-30T23:06:08.643465Z","steps":["trace[1352611705] 'process raft request' (duration: 1.159567412s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.64364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:07.48371Z","time spent":"1.159849789s","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T23:06:08.646803Z","caller":"traceutil/trace.go:171","msg":"trace[1393565229] transaction","detail":"{read_only:false; response_revision:25128; number_of_response:1; }","duration":"166.287513ms","start":"2026-06-30T23:06:08.480494Z","end":"2026-06-30T23:06:08.646782Z","steps":["trace[1393565229] 'process raft request' (duration: 166.235732ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:08.646952Z","caller":"traceutil/trace.go:171","msg":"trace[871670344] transaction","detail":"{read_only:false; response_revision:25127; number_of_response:1; }","duration":"167.670578ms","start":"2026-06-30T23:06:08.479262Z","end":"2026-06-30T23:06:08.646933Z","steps":["trace[871670344] 'process raft request' (duration: 167.439552ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:08.64704Z","caller":"traceutil/trace.go:171","msg":"trace[1376507614] transaction","detail":"{read_only:false; response_revision:25129; number_of_response:1; }","duration":"164.325806ms","start":"2026-06-30T23:06:08.482701Z","end":"2026-06-30T23:06:08.647027Z","steps":["trace[1376507614] 'process raft request' (duration: 164.05327ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:08.647389Z","caller":"traceutil/trace.go:171","msg":"trace[838749231] transaction","detail":"{read_only:false; response_revision:25130; number_of_response:1; }","duration":"164.019479ms","start":"2026-06-30T23:06:08.483358Z","end":"2026-06-30T23:06:08.647377Z","steps":["trace[838749231] 'process raft request' (duration: 163.623039ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:08.647413Z","caller":"traceutil/trace.go:171","msg":"trace[253211237] linearizableReadLoop","detail":"{readStateIndex:25934; appliedIndex:25932; }","duration":"1.106491523s","start":"2026-06-30T23:06:07.540907Z","end":"2026-06-30T23:06:08.647399Z","steps":["trace[253211237] 'read index received' (duration: 1.102434455s)","trace[253211237] 'applied index is now lower than readState.Index' (duration: 4.056418ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:08.64742Z","caller":"traceutil/trace.go:171","msg":"trace[6963981] transaction","detail":"{read_only:false; response_revision:25131; number_of_response:1; }","duration":"163.808444ms","start":"2026-06-30T23:06:08.483598Z","end":"2026-06-30T23:06:08.647406Z","steps":["trace[6963981] 'process raft request' (duration: 163.702611ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:08.647458Z","caller":"traceutil/trace.go:171","msg":"trace[1844511307] transaction","detail":"{read_only:false; response_revision:25132; number_of_response:1; }","duration":"156.691761ms","start":"2026-06-30T23:06:08.490755Z","end":"2026-06-30T23:06:08.647447Z","steps":["trace[1844511307] 'process raft request' (duration: 156.611068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.647531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.019219287s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-30T23:06:08.647549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106649449s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"} {"level":"info","ts":"2026-06-30T23:06:08.647555Z","caller":"traceutil/trace.go:171","msg":"trace[864214088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25132; }","duration":"1.01930853s","start":"2026-06-30T23:06:07.628239Z","end":"2026-06-30T23:06:08.647548Z","steps":["trace[864214088] 'agreement among raft nodes before linearized reading' (duration: 1.019258658s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.64756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.167445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-30T23:06:08.647564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.080033ms","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-30T23:06:08.647572Z","caller":"traceutil/trace.go:171","msg":"trace[293669970] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25132; }","duration":"1.106717061s","start":"2026-06-30T23:06:07.540846Z","end":"2026-06-30T23:06:08.647563Z","steps":["trace[293669970] 'agreement among raft nodes before linearized reading' (duration: 1.106611109s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.647577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:07.628214Z","time spent":"1.01935813s","remote":"127.0.0.1:34356","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-30T23:06:08.647585Z","caller":"traceutil/trace.go:171","msg":"trace[1494171525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25132; }","duration":"155.220476ms","start":"2026-06-30T23:06:08.492356Z","end":"2026-06-30T23:06:08.647577Z","steps":["trace[1494171525] 'agreement among raft nodes before linearized reading' (duration: 155.142915ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:08.647594Z","caller":"traceutil/trace.go:171","msg":"trace[1720059342] 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:25132; }","duration":"162.136044ms","start":"2026-06-30T23:06:08.485447Z","end":"2026-06-30T23:06:08.647583Z","steps":["trace[1720059342] 'agreement among raft nodes before linearized reading' (duration: 162.079752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.647593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:07.540813Z","time spent":"1.106774982s","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":597,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-06-30T23:06:08.647594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.218538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-30T23:06:08.647624Z","caller":"traceutil/trace.go:171","msg":"trace[442616676] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:25132; }","duration":"179.289729ms","start":"2026-06-30T23:06:08.468325Z","end":"2026-06-30T23:06:08.647615Z","steps":["trace[442616676] 'agreement among raft nodes before linearized reading' (duration: 179.214297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.647681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.903579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-30T23:06:08.647698Z","caller":"traceutil/trace.go:171","msg":"trace[1577906237] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25132; }","duration":"154.935049ms","start":"2026-06-30T23:06:08.492758Z","end":"2026-06-30T23:06:08.647693Z","steps":["trace[1577906237] 'agreement among raft nodes before linearized reading' (duration: 154.883608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.647714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.66711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-30T23:06:08.647749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.168274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T23:06:08.647778Z","caller":"traceutil/trace.go:171","msg":"trace[1558671500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25132; }","duration":"162.212105ms","start":"2026-06-30T23:06:08.485559Z","end":"2026-06-30T23:06:08.647771Z","steps":["trace[1558671500] 'agreement among raft nodes before linearized reading' (duration: 162.144013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.647785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.017041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-30T23:06:08.647785Z","caller":"traceutil/trace.go:171","msg":"trace[1937786645] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25132; }","duration":"158.758882ms","start":"2026-06-30T23:06:08.489007Z","end":"2026-06-30T23:06:08.647766Z","steps":["trace[1937786645] 'agreement among raft nodes before linearized reading' (duration: 158.530526ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:08.647807Z","caller":"traceutil/trace.go:171","msg":"trace[1476551212] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25132; }","duration":"155.054793ms","start":"2026-06-30T23:06:08.492746Z","end":"2026-06-30T23:06:08.647801Z","steps":["trace[1476551212] 'agreement among raft nodes before linearized reading' (duration: 154.996811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.64781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.104725ms","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-30T23:06:08.647838Z","caller":"traceutil/trace.go:171","msg":"trace[2104030205] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25132; }","duration":"146.176926ms","start":"2026-06-30T23:06:08.501653Z","end":"2026-06-30T23:06:08.64783Z","steps":["trace[2104030205] 'agreement among raft nodes before linearized reading' (duration: 146.091984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.647755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.007943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"info","ts":"2026-06-30T23:06:08.64787Z","caller":"traceutil/trace.go:171","msg":"trace[1205875077] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25132; }","duration":"613.123355ms","start":"2026-06-30T23:06:08.034738Z","end":"2026-06-30T23:06:08.647861Z","steps":["trace[1205875077] 'agreement among raft nodes before linearized reading' (duration: 612.966771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.647893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:08.034679Z","time spent":"613.207307ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":584,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-06-30T23:06:08.648413Z","caller":"traceutil/trace.go:171","msg":"trace[438404836] transaction","detail":"{read_only:false; response_revision:25126; number_of_response:1; }","duration":"579.464558ms","start":"2026-06-30T23:06:08.068934Z","end":"2026-06-30T23:06:08.648399Z","steps":["trace[438404836] 'process raft request' (duration: 577.663394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:08.64849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:08.068909Z","time spent":"579.53738ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T23:06:11.788547Z","caller":"traceutil/trace.go:171","msg":"trace[2059365406] transaction","detail":"{read_only:false; response_revision:25158; number_of_response:1; }","duration":"120.209977ms","start":"2026-06-30T23:06:11.668302Z","end":"2026-06-30T23:06:11.788512Z","steps":["trace[2059365406] 'process raft request' (duration: 119.971721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:16.101273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.307513ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-30T23:06:16.101394Z","caller":"traceutil/trace.go:171","msg":"trace[845448372] linearizableReadLoop","detail":"{readStateIndex:25994; appliedIndex:25993; }","duration":"116.631578ms","start":"2026-06-30T23:06:15.984743Z","end":"2026-06-30T23:06:16.101374Z","steps":["trace[845448372] 'read index received' (duration: 49.261µs)","trace[845448372] 'applied index is now lower than readState.Index' (duration: 116.579967ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:16.101489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.722961ms","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-30T23:06:16.101537Z","caller":"traceutil/trace.go:171","msg":"trace[1103690274] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:25184; }","duration":"116.787053ms","start":"2026-06-30T23:06:15.984736Z","end":"2026-06-30T23:06:16.101523Z","steps":["trace[1103690274] 'agreement among raft nodes before linearized reading' (duration: 116.688711ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:16.941216Z","caller":"traceutil/trace.go:171","msg":"trace[1871720337] linearizableReadLoop","detail":"{readStateIndex:26000; appliedIndex:25994; }","duration":"256.689068ms","start":"2026-06-30T23:06:16.684503Z","end":"2026-06-30T23:06:16.941192Z","steps":["trace[1871720337] 'read index received' (duration: 60.696423ms)","trace[1871720337] 'applied index is now lower than readState.Index' (duration: 195.991225ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:16.941386Z","caller":"traceutil/trace.go:171","msg":"trace[845775536] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"262.56812ms","start":"2026-06-30T23:06:16.678795Z","end":"2026-06-30T23:06:16.941363Z","steps":["trace[845775536] 'process raft request' (duration: 262.280953ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:16.941597Z","caller":"traceutil/trace.go:171","msg":"trace[1765673889] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"262.488087ms","start":"2026-06-30T23:06:16.679096Z","end":"2026-06-30T23:06:16.941584Z","steps":["trace[1765673889] 'process raft request' (duration: 262.017316ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:16.941722Z","caller":"traceutil/trace.go:171","msg":"trace[2076576943] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"262.540558ms","start":"2026-06-30T23:06:16.679172Z","end":"2026-06-30T23:06:16.941713Z","steps":["trace[2076576943] 'process raft request' (duration: 261.975515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:16.941855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.336393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T23:06:16.941882Z","caller":"traceutil/trace.go:171","msg":"trace[1772302245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25190; }","duration":"257.397935ms","start":"2026-06-30T23:06:16.684476Z","end":"2026-06-30T23:06:16.941874Z","steps":["trace[1772302245] 'agreement among raft nodes before linearized reading' (duration: 257.296833ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:16.941889Z","caller":"traceutil/trace.go:171","msg":"trace[914405350] transaction","detail":"{read_only:false; response_revision:25186; number_of_response:1; }","duration":"266.030284ms","start":"2026-06-30T23:06:16.675845Z","end":"2026-06-30T23:06:16.941875Z","steps":["trace[914405350] 'process raft request' (duration: 264.987669ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:16.942028Z","caller":"traceutil/trace.go:171","msg":"trace[347881007] transaction","detail":"{read_only:false; response_revision:25187; number_of_response:1; }","duration":"265.04858ms","start":"2026-06-30T23:06:16.676966Z","end":"2026-06-30T23:06:16.942014Z","steps":["trace[347881007] 'process raft request' (duration: 264.065326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.333533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.700243ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T23:06:17.333774Z","caller":"traceutil/trace.go:171","msg":"trace[1863565476] transaction","detail":"{read_only:false; response_revision:25192; number_of_response:1; }","duration":"388.563267ms","start":"2026-06-30T23:06:16.945192Z","end":"2026-06-30T23:06:17.333755Z","steps":["trace[1863565476] 'process raft request' (duration: 388.457984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.333856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:16.945161Z","time spent":"388.654298ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T23:06:17.333862Z","caller":"traceutil/trace.go:171","msg":"trace[945131348] linearizableReadLoop","detail":"{readStateIndex:26001; appliedIndex:26000; }","duration":"392.468671ms","start":"2026-06-30T23:06:16.94132Z","end":"2026-06-30T23:06:17.333789Z","steps":["trace[945131348] 'read index received' (duration: 136.41255ms)","trace[945131348] 'applied index is now lower than readState.Index' (duration: 256.054271ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:17.33409Z","caller":"traceutil/trace.go:171","msg":"trace[1969607520] transaction","detail":"{read_only:false; response_revision:25191; number_of_response:1; }","duration":"540.582514ms","start":"2026-06-30T23:06:16.793494Z","end":"2026-06-30T23:06:17.334077Z","steps":["trace[1969607520] 'process raft request' (duration: 284.230916ms)","trace[1969607520] 'compare' (duration: 255.233062ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:17.334244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:16.793472Z","time spent":"540.675847ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T23:06:17.33455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.857391ms","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-30T23:06:17.3346Z","caller":"traceutil/trace.go:171","msg":"trace[464587437] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25192; }","duration":"636.928653ms","start":"2026-06-30T23:06:16.697659Z","end":"2026-06-30T23:06:17.334588Z","steps":["trace[464587437] 'agreement among raft nodes before linearized reading' (duration: 636.739647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.33464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:16.69765Z","time spent":"636.982955ms","remote":"127.0.0.1:34588","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-30T23:06:17.334734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.402653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-30T23:06:17.334807Z","caller":"traceutil/trace.go:171","msg":"trace[272504851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25192; }","duration":"639.475965ms","start":"2026-06-30T23:06:16.695322Z","end":"2026-06-30T23:06:17.334797Z","steps":["trace[272504851] 'agreement among raft nodes before linearized reading' (duration: 639.200718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.33486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:16.695297Z","time spent":"639.554647ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T23:06:17.334926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.437611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"} {"level":"info","ts":"2026-06-30T23:06:17.334971Z","caller":"traceutil/trace.go:171","msg":"trace[64740636] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25192; }","duration":"636.493742ms","start":"2026-06-30T23:06:16.698465Z","end":"2026-06-30T23:06:17.334959Z","steps":["trace[64740636] 'agreement among raft nodes before linearized reading' (duration: 636.41086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.335014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:16.698456Z","time spent":"636.544993ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":597,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-06-30T23:06:17.335145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.700638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-30T23:06:17.335178Z","caller":"traceutil/trace.go:171","msg":"trace[1623942277] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25192; }","duration":"636.780139ms","start":"2026-06-30T23:06:16.698389Z","end":"2026-06-30T23:06:17.335169Z","steps":["trace[1623942277] 'agreement among raft nodes before linearized reading' (duration: 636.699988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.33521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:16.698379Z","time spent":"636.82609ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T23:06:17.335207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.85248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-30T23:06:17.335268Z","caller":"traceutil/trace.go:171","msg":"trace[860728313] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25192; }","duration":"643.931502ms","start":"2026-06-30T23:06:16.691321Z","end":"2026-06-30T23:06:17.335253Z","steps":["trace[860728313] 'agreement among raft nodes before linearized reading' (duration: 643.769509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.335297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:16.691315Z","time spent":"643.977653ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-30T23:06:17.334855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.661282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-30T23:06:17.335452Z","caller":"traceutil/trace.go:171","msg":"trace[652920768] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25192; }","duration":"636.260536ms","start":"2026-06-30T23:06:16.699186Z","end":"2026-06-30T23:06:17.335446Z","steps":["trace[652920768] 'agreement among raft nodes before linearized reading' (duration: 635.60305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.335471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:16.69912Z","time spent":"636.344388ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T23:06:17.335857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.782499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-30T23:06:17.335905Z","caller":"traceutil/trace.go:171","msg":"trace[1854843415] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25192; }","duration":"115.864301ms","start":"2026-06-30T23:06:17.220028Z","end":"2026-06-30T23:06:17.335893Z","steps":["trace[1854843415] 'agreement among raft nodes before linearized reading' (duration: 115.751378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.33544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.026493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-06-30T23:06:17.341642Z","caller":"traceutil/trace.go:171","msg":"trace[629475820] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:25192; }","duration":"288.253094ms","start":"2026-06-30T23:06:17.053363Z","end":"2026-06-30T23:06:17.341616Z","steps":["trace[629475820] 'agreement among raft nodes before linearized reading' (duration: 281.998372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.680075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.651497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T23:06:17.680207Z","caller":"traceutil/trace.go:171","msg":"trace[1114340455] transaction","detail":"{read_only:false; response_revision:25194; number_of_response:1; }","duration":"338.890131ms","start":"2026-06-30T23:06:17.341283Z","end":"2026-06-30T23:06:17.680173Z","steps":["trace[1114340455] 'process raft request' (duration: 211.07535ms)","trace[1114340455] 'compare' (duration: 127.552655ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:17.680364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:17.341262Z","time spent":"339.013435ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T23:06:17.680383Z","caller":"traceutil/trace.go:171","msg":"trace[1476779537] transaction","detail":"{read_only:false; response_revision:25199; number_of_response:1; }","duration":"273.25714ms","start":"2026-06-30T23:06:17.407112Z","end":"2026-06-30T23:06:17.680369Z","steps":["trace[1476779537] 'process raft request' (duration: 273.227449ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:17.680538Z","caller":"traceutil/trace.go:171","msg":"trace[272014327] transaction","detail":"{read_only:false; response_revision:25197; number_of_response:1; }","duration":"337.659733ms","start":"2026-06-30T23:06:17.342867Z","end":"2026-06-30T23:06:17.680527Z","steps":["trace[272014327] 'process raft request' (duration: 337.421257ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:17.680586Z","caller":"traceutil/trace.go:171","msg":"trace[1926278537] transaction","detail":"{read_only:false; response_revision:25198; number_of_response:1; }","duration":"337.659451ms","start":"2026-06-30T23:06:17.342919Z","end":"2026-06-30T23:06:17.680579Z","steps":["trace[1926278537] 'process raft request' (duration: 337.394104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.680595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:17.342846Z","time spent":"337.715403ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T23:06:17.680627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:17.342914Z","time spent":"337.689361ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T23:06:17.680869Z","caller":"traceutil/trace.go:171","msg":"trace[172574108] transaction","detail":"{read_only:false; response_revision:25195; number_of_response:1; }","duration":"339.512736ms","start":"2026-06-30T23:06:17.341344Z","end":"2026-06-30T23:06:17.680857Z","steps":["trace[172574108] 'process raft request' (duration: 338.80567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.680924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:17.341332Z","time spent":"339.566157ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T23:06:17.680984Z","caller":"traceutil/trace.go:171","msg":"trace[1746693219] transaction","detail":"{read_only:false; response_revision:25196; number_of_response:1; }","duration":"339.588828ms","start":"2026-06-30T23:06:17.341364Z","end":"2026-06-30T23:06:17.680953Z","steps":["trace[1746693219] 'process raft request' (duration: 338.901241ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:17.681068Z","caller":"traceutil/trace.go:171","msg":"trace[1352554307] linearizableReadLoop","detail":"{readStateIndex:26008; appliedIndex:26002; }","duration":"336.960035ms","start":"2026-06-30T23:06:17.344073Z","end":"2026-06-30T23:06:17.681033Z","steps":["trace[1352554307] 'read index received' (duration: 13.060687ms)","trace[1352554307] 'applied index is now lower than readState.Index' (duration: 323.893668ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:17.681161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:17.341356Z","time spent":"339.705071ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T23:06:17.681364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.267462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2e7e9e12-0c4e-42df-863e-497bccbf2649\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-06-30T23:06:17.681404Z","caller":"traceutil/trace.go:171","msg":"trace[1597132231] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2e7e9e12-0c4e-42df-863e-497bccbf2649; range_end:; response_count:1; response_revision:25199; }","duration":"337.339093ms","start":"2026-06-30T23:06:17.344051Z","end":"2026-06-30T23:06:17.68139Z","steps":["trace[1597132231] 'agreement among raft nodes before linearized reading' (duration: 337.150029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:17.681443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:17.344043Z","time spent":"337.390784ms","remote":"127.0.0.1:34470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1474,"request content":"key:\"/registry/persistentvolumes/pvc-2e7e9e12-0c4e-42df-863e-497bccbf2649\" "} {"level":"info","ts":"2026-06-30T23:06:18.969297Z","caller":"traceutil/trace.go:171","msg":"trace[1046313915] transaction","detail":"{read_only:false; response_revision:25200; number_of_response:1; }","duration":"219.053174ms","start":"2026-06-30T23:06:18.750214Z","end":"2026-06-30T23:06:18.969267Z","steps":["trace[1046313915] 'process raft request' (duration: 218.899761ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:19.079438Z","caller":"traceutil/trace.go:171","msg":"trace[255631408] transaction","detail":"{read_only:false; response_revision:25202; number_of_response:1; }","duration":"132.645318ms","start":"2026-06-30T23:06:18.946771Z","end":"2026-06-30T23:06:19.079416Z","steps":["trace[255631408] 'process raft request' (duration: 132.586917ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:19.079498Z","caller":"traceutil/trace.go:171","msg":"trace[127017492] transaction","detail":"{read_only:false; response_revision:25201; number_of_response:1; }","duration":"202.204435ms","start":"2026-06-30T23:06:18.877257Z","end":"2026-06-30T23:06:19.079462Z","steps":["trace[127017492] 'process raft request' (duration: 201.9809ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:19.079757Z","caller":"traceutil/trace.go:171","msg":"trace[343088810] transaction","detail":"{read_only:false; response_revision:25203; number_of_response:1; }","duration":"132.413912ms","start":"2026-06-30T23:06:18.947303Z","end":"2026-06-30T23:06:19.079717Z","steps":["trace[343088810] 'process raft request' (duration: 132.083864ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:19.079826Z","caller":"traceutil/trace.go:171","msg":"trace[1019334149] transaction","detail":"{read_only:false; response_revision:25204; number_of_response:1; }","duration":"132.226479ms","start":"2026-06-30T23:06:18.947587Z","end":"2026-06-30T23:06:19.079814Z","steps":["trace[1019334149] 'process raft request' (duration: 132.039053ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:19.079868Z","caller":"traceutil/trace.go:171","msg":"trace[1842952724] transaction","detail":"{read_only:false; response_revision:25206; number_of_response:1; }","duration":"131.134331ms","start":"2026-06-30T23:06:18.948707Z","end":"2026-06-30T23:06:19.079842Z","steps":["trace[1842952724] 'process raft request' (duration: 131.08849ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:19.079983Z","caller":"traceutil/trace.go:171","msg":"trace[1937756176] transaction","detail":"{read_only:false; response_revision:25205; number_of_response:1; }","duration":"132.309361ms","start":"2026-06-30T23:06:18.947653Z","end":"2026-06-30T23:06:19.079962Z","steps":["trace[1937756176] 'process raft request' (duration: 132.100756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:19.381754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.087952ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T23:06:19.381863Z","caller":"traceutil/trace.go:171","msg":"trace[245120773] linearizableReadLoop","detail":"{readStateIndex:26017; appliedIndex:26010; }","duration":"350.554905ms","start":"2026-06-30T23:06:19.031287Z","end":"2026-06-30T23:06:19.381842Z","steps":["trace[245120773] 'read index received' (duration: 48.039796ms)","trace[245120773] 'applied index is now lower than readState.Index' (duration: 302.513589ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:19.3819Z","caller":"traceutil/trace.go:171","msg":"trace[785273449] transaction","detail":"{read_only:false; response_revision:25207; number_of_response:1; }","duration":"368.189352ms","start":"2026-06-30T23:06:19.013686Z","end":"2026-06-30T23:06:19.381875Z","steps":["trace[785273449] 'process raft request' (duration: 184.903786ms)","trace[785273449] 'compare' (duration: 182.743943ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:19.382007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.718549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-30T23:06:19.382024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:19.013659Z","time spent":"368.296495ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T23:06:19.382064Z","caller":"traceutil/trace.go:171","msg":"trace[773443134] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:25207; }","duration":"350.816231ms","start":"2026-06-30T23:06:19.03123Z","end":"2026-06-30T23:06:19.382046Z","steps":["trace[773443134] 'agreement among raft nodes before linearized reading' (duration: 350.724519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:19.38211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:19.031211Z","time spent":"350.885512ms","remote":"127.0.0.1:49694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":5,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"info","ts":"2026-06-30T23:06:19.524884Z","caller":"traceutil/trace.go:171","msg":"trace[928462940] transaction","detail":"{read_only:false; response_revision:25208; number_of_response:1; }","duration":"138.415348ms","start":"2026-06-30T23:06:19.386436Z","end":"2026-06-30T23:06:19.524851Z","steps":["trace[928462940] 'process raft request' (duration: 134.79036ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:19.52494Z","caller":"traceutil/trace.go:171","msg":"trace[1721284548] linearizableReadLoop","detail":"{readStateIndex:26018; appliedIndex:26017; }","duration":"138.1175ms","start":"2026-06-30T23:06:19.386795Z","end":"2026-06-30T23:06:19.524913Z","steps":["trace[1721284548] 'read index received' (duration: 134.444071ms)","trace[1721284548] 'applied index is now lower than readState.Index' (duration: 3.672279ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:19.524979Z","caller":"traceutil/trace.go:171","msg":"trace[1387028861] transaction","detail":"{read_only:false; response_revision:25209; number_of_response:1; }","duration":"137.894985ms","start":"2026-06-30T23:06:19.387029Z","end":"2026-06-30T23:06:19.524924Z","steps":["trace[1387028861] 'process raft request' (duration: 137.795233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:19.525224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.408069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18143"} {"level":"info","ts":"2026-06-30T23:06:19.525271Z","caller":"traceutil/trace.go:171","msg":"trace[1026880246] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25209; }","duration":"138.4868ms","start":"2026-06-30T23:06:19.38677Z","end":"2026-06-30T23:06:19.525257Z","steps":["trace[1026880246] 'agreement among raft nodes before linearized reading' (duration: 138.303285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:19.525361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.398411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-06-30T23:06:19.525404Z","caller":"traceutil/trace.go:171","msg":"trace[1193422650] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25209; }","duration":"134.501273ms","start":"2026-06-30T23:06:19.39089Z","end":"2026-06-30T23:06:19.525391Z","steps":["trace[1193422650] 'agreement among raft nodes before linearized reading' (duration: 134.317789ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:22.474915Z","caller":"traceutil/trace.go:171","msg":"trace[1369482815] transaction","detail":"{read_only:false; response_revision:25229; number_of_response:1; }","duration":"130.518236ms","start":"2026-06-30T23:06:22.34437Z","end":"2026-06-30T23:06:22.474888Z","steps":["trace[1369482815] 'process raft request' (duration: 130.344852ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:33.906921Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000661b.wal"} {"level":"warn","ts":"2026-06-30T23:06:35.080559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.922097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-30T23:06:35.080624Z","caller":"traceutil/trace.go:171","msg":"trace[1043621346] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25373; }","duration":"124.032619ms","start":"2026-06-30T23:06:34.956576Z","end":"2026-06-30T23:06:35.080609Z","steps":["trace[1043621346] 'range keys from in-memory index tree' (duration: 123.716131ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:35.212692Z","caller":"traceutil/trace.go:171","msg":"trace[1703980602] transaction","detail":"{read_only:false; response_revision:25374; number_of_response:1; }","duration":"191.69368ms","start":"2026-06-30T23:06:35.020962Z","end":"2026-06-30T23:06:35.212655Z","steps":["trace[1703980602] 'process raft request' (duration: 191.449734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:35.212875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.2205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-06-30T23:06:35.212934Z","caller":"traceutil/trace.go:171","msg":"trace[1455802994] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6; range_end:; response_count:1; response_revision:25374; }","duration":"189.331094ms","start":"2026-06-30T23:06:35.023589Z","end":"2026-06-30T23:06:35.21292Z","steps":["trace[1455802994] 'agreement among raft nodes before linearized reading' (duration: 189.138698ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:35.212619Z","caller":"traceutil/trace.go:171","msg":"trace[1638704237] linearizableReadLoop","detail":"{readStateIndex:26187; appliedIndex:26186; }","duration":"188.964284ms","start":"2026-06-30T23:06:35.023624Z","end":"2026-06-30T23:06:35.212588Z","steps":["trace[1638704237] 'read index received' (duration: 188.830961ms)","trace[1638704237] 'applied index is now lower than readState.Index' (duration: 131.993µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:35.352264Z","caller":"traceutil/trace.go:171","msg":"trace[342857672] transaction","detail":"{read_only:false; response_revision:25377; number_of_response:1; }","duration":"208.747743ms","start":"2026-06-30T23:06:35.143496Z","end":"2026-06-30T23:06:35.352243Z","steps":["trace[342857672] 'process raft request' (duration: 208.687902ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:35.352311Z","caller":"traceutil/trace.go:171","msg":"trace[1114891886] transaction","detail":"{read_only:false; response_revision:25376; number_of_response:1; }","duration":"210.138168ms","start":"2026-06-30T23:06:35.142134Z","end":"2026-06-30T23:06:35.352272Z","steps":["trace[1114891886] 'process raft request' (duration: 210.017525ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:35.352269Z","caller":"traceutil/trace.go:171","msg":"trace[557498951] transaction","detail":"{read_only:false; response_revision:25375; number_of_response:1; }","duration":"212.26109ms","start":"2026-06-30T23:06:35.139983Z","end":"2026-06-30T23:06:35.352244Z","steps":["trace[557498951] 'process raft request' (duration: 212.044115ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:35.353107Z","caller":"traceutil/trace.go:171","msg":"trace[318982935] linearizableReadLoop","detail":"{readStateIndex:26192; appliedIndex:26187; }","duration":"139.788272ms","start":"2026-06-30T23:06:35.213301Z","end":"2026-06-30T23:06:35.353089Z","steps":["trace[318982935] 'read index received' (duration: 138.693134ms)","trace[318982935] 'applied index is now lower than readState.Index' (duration: 1.093958ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:35.353242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.109509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:06:35.353265Z","caller":"traceutil/trace.go:171","msg":"trace[372622108] transaction","detail":"{read_only:false; response_revision:25379; number_of_response:1; }","duration":"206.849408ms","start":"2026-06-30T23:06:35.146397Z","end":"2026-06-30T23:06:35.353247Z","steps":["trace[372622108] 'process raft request' (duration: 206.582082ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:35.353283Z","caller":"traceutil/trace.go:171","msg":"trace[28427001] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:25379; }","duration":"297.20551ms","start":"2026-06-30T23:06:35.056066Z","end":"2026-06-30T23:06:35.353271Z","steps":["trace[28427001] 'agreement among raft nodes before linearized reading' (duration: 297.090697ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:35.353287Z","caller":"traceutil/trace.go:171","msg":"trace[1380576005] transaction","detail":"{read_only:false; response_revision:25378; number_of_response:1; }","duration":"208.273744ms","start":"2026-06-30T23:06:35.14499Z","end":"2026-06-30T23:06:35.353264Z","steps":["trace[1380576005] 'process raft request' (duration: 207.225628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:35.353556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.201207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-06-30T23:06:35.353601Z","caller":"traceutil/trace.go:171","msg":"trace[297762291] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6; range_end:; response_count:1; response_revision:25379; }","duration":"275.282389ms","start":"2026-06-30T23:06:35.078308Z","end":"2026-06-30T23:06:35.35359Z","steps":["trace[297762291] 'agreement among raft nodes before linearized reading' (duration: 275.126615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:35.353558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.547891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-30T23:06:35.353688Z","caller":"traceutil/trace.go:171","msg":"trace[352255450] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25379; }","duration":"269.668333ms","start":"2026-06-30T23:06:35.083984Z","end":"2026-06-30T23:06:35.353652Z","steps":["trace[352255450] 'agreement among raft nodes before linearized reading' (duration: 269.484369ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:35.653671Z","caller":"traceutil/trace.go:171","msg":"trace[1172171989] linearizableReadLoop","detail":"{readStateIndex:26193; appliedIndex:26192; }","duration":"298.573724ms","start":"2026-06-30T23:06:35.355057Z","end":"2026-06-30T23:06:35.653631Z","steps":["trace[1172171989] 'read index received' (duration: 278.898546ms)","trace[1172171989] 'applied index is now lower than readState.Index' (duration: 19.673798ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:35.653791Z","caller":"traceutil/trace.go:171","msg":"trace[978835626] transaction","detail":"{read_only:false; response_revision:25380; number_of_response:1; }","duration":"434.644054ms","start":"2026-06-30T23:06:35.219133Z","end":"2026-06-30T23:06:35.653777Z","steps":["trace[978835626] 'process raft request' (duration: 414.811343ms)","trace[978835626] 'compare' (duration: 19.581685ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:35.654128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:35.219114Z","time spent":"434.701096ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T23:06:35.654197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.115526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18143"} {"level":"info","ts":"2026-06-30T23:06:35.654288Z","caller":"traceutil/trace.go:171","msg":"trace[640883579] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25380; }","duration":"299.24566ms","start":"2026-06-30T23:06:35.355014Z","end":"2026-06-30T23:06:35.654259Z","steps":["trace[640883579] 'agreement among raft nodes before linearized reading' (duration: 298.978223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:35.794869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.184331ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-30T23:06:35.794949Z","caller":"traceutil/trace.go:171","msg":"trace[1830048481] linearizableReadLoop","detail":"{readStateIndex:26194; appliedIndex:26193; }","duration":"141.193145ms","start":"2026-06-30T23:06:35.653742Z","end":"2026-06-30T23:06:35.794935Z","steps":["trace[1830048481] 'read index received' (duration: 922.762µs)","trace[1830048481] 'applied index is now lower than readState.Index' (duration: 140.269173ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:35.795135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.358303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterctl.cluster.x-k8s.io/providers/\" range_end:\"/registry/clusterctl.cluster.x-k8s.io/providers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-30T23:06:35.79516Z","caller":"traceutil/trace.go:171","msg":"trace[1345380419] range","detail":"{range_begin:/registry/clusterctl.cluster.x-k8s.io/providers/; range_end:/registry/clusterctl.cluster.x-k8s.io/providers0; response_count:0; response_revision:25380; }","duration":"264.394113ms","start":"2026-06-30T23:06:35.530757Z","end":"2026-06-30T23:06:35.795152Z","steps":["trace[1345380419] 'agreement among raft nodes before linearized reading' (duration: 264.327312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:35.795149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.464592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:06:35.795244Z","caller":"traceutil/trace.go:171","msg":"trace[1449860825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25380; }","duration":"167.581025ms","start":"2026-06-30T23:06:35.627638Z","end":"2026-06-30T23:06:35.795219Z","steps":["trace[1449860825] 'agreement among raft nodes before linearized reading' (duration: 167.401341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:35.795279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.257122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"} {"level":"warn","ts":"2026-06-30T23:06:35.795165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.059125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T23:06:35.795568Z","caller":"traceutil/trace.go:171","msg":"trace[679752741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25380; }","duration":"191.511856ms","start":"2026-06-30T23:06:35.604033Z","end":"2026-06-30T23:06:35.795545Z","steps":["trace[679752741] 'agreement among raft nodes before linearized reading' (duration: 191.026294ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:35.795706Z","caller":"traceutil/trace.go:171","msg":"trace[245276191] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25380; }","duration":"189.396644ms","start":"2026-06-30T23:06:35.605947Z","end":"2026-06-30T23:06:35.795343Z","steps":["trace[245276191] 'agreement among raft nodes before linearized reading' (duration: 189.117367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:36.051986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.771339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T23:06:36.05215Z","caller":"traceutil/trace.go:171","msg":"trace[803169865] transaction","detail":"{read_only:false; response_revision:25382; number_of_response:1; }","duration":"251.484651ms","start":"2026-06-30T23:06:35.800646Z","end":"2026-06-30T23:06:36.05213Z","steps":["trace[803169865] 'process raft request' (duration: 128.465697ms)","trace[803169865] 'compare' (duration: 122.623995ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:36.052477Z","caller":"traceutil/trace.go:171","msg":"trace[1730914731] transaction","detail":"{read_only:false; response_revision:25383; number_of_response:1; }","duration":"251.799368ms","start":"2026-06-30T23:06:35.800644Z","end":"2026-06-30T23:06:36.052443Z","steps":["trace[1730914731] 'process raft request' (duration: 251.43427ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:36.05256Z","caller":"traceutil/trace.go:171","msg":"trace[1266523229] transaction","detail":"{read_only:false; response_revision:25385; number_of_response:1; }","duration":"251.567093ms","start":"2026-06-30T23:06:35.800984Z","end":"2026-06-30T23:06:36.052551Z","steps":["trace[1266523229] 'process raft request' (duration: 251.480731ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:36.052611Z","caller":"traceutil/trace.go:171","msg":"trace[462024078] linearizableReadLoop","detail":"{readStateIndex:26201; appliedIndex:26194; }","duration":"251.037099ms","start":"2026-06-30T23:06:35.801557Z","end":"2026-06-30T23:06:36.052594Z","steps":["trace[462024078] 'read index received' (duration: 20.380594ms)","trace[462024078] 'applied index is now lower than readState.Index' (duration: 230.655225ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:36.052654Z","caller":"traceutil/trace.go:171","msg":"trace[686046440] transaction","detail":"{read_only:false; response_revision:25386; number_of_response:1; }","duration":"251.492271ms","start":"2026-06-30T23:06:35.801119Z","end":"2026-06-30T23:06:36.052611Z","steps":["trace[686046440] 'process raft request' (duration: 251.388689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:36.052787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.242063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-30T23:06:36.052818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.255375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-30T23:06:36.052734Z","caller":"traceutil/trace.go:171","msg":"trace[713079310] transaction","detail":"{read_only:false; response_revision:25387; number_of_response:1; }","duration":"251.263895ms","start":"2026-06-30T23:06:35.801414Z","end":"2026-06-30T23:06:36.052678Z","steps":["trace[713079310] 'process raft request' (duration: 251.134882ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:36.052853Z","caller":"traceutil/trace.go:171","msg":"trace[1521160017] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25387; }","duration":"251.308816ms","start":"2026-06-30T23:06:35.801533Z","end":"2026-06-30T23:06:36.052842Z","steps":["trace[1521160017] 'agreement among raft nodes before linearized reading' (duration: 251.114791ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:36.052844Z","caller":"traceutil/trace.go:171","msg":"trace[816562877] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:25387; }","duration":"173.353856ms","start":"2026-06-30T23:06:35.879477Z","end":"2026-06-30T23:06:36.05283Z","steps":["trace[816562877] 'agreement among raft nodes before linearized reading' (duration: 173.237483ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:36.053099Z","caller":"traceutil/trace.go:171","msg":"trace[1209867225] transaction","detail":"{read_only:false; response_revision:25384; number_of_response:1; }","duration":"251.86119ms","start":"2026-06-30T23:06:35.80065Z","end":"2026-06-30T23:06:36.052512Z","steps":["trace[1209867225] 'process raft request' (duration: 251.717777ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:37.106569Z","caller":"traceutil/trace.go:171","msg":"trace[1885363214] transaction","detail":"{read_only:false; response_revision:25388; number_of_response:1; }","duration":"314.428318ms","start":"2026-06-30T23:06:36.792118Z","end":"2026-06-30T23:06:37.106547Z","steps":["trace[1885363214] 'process raft request' (duration: 314.225803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:37.106732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:36.7921Z","time spent":"314.544592ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T23:06:37.374173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.326486ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T23:06:37.37436Z","caller":"traceutil/trace.go:171","msg":"trace[1725402308] transaction","detail":"{read_only:false; response_revision:25390; number_of_response:1; }","duration":"155.969604ms","start":"2026-06-30T23:06:37.218314Z","end":"2026-06-30T23:06:37.374284Z","steps":["trace[1725402308] 'process raft request' (duration: 155.929263ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:37.374376Z","caller":"traceutil/trace.go:171","msg":"trace[1469552894] linearizableReadLoop","detail":"{readStateIndex:26203; appliedIndex:26201; }","duration":"315.513645ms","start":"2026-06-30T23:06:37.058839Z","end":"2026-06-30T23:06:37.374353Z","steps":["trace[1469552894] 'read index received' (duration: 47.464041ms)","trace[1469552894] 'applied index is now lower than readState.Index' (duration: 268.044944ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:37.374484Z","caller":"traceutil/trace.go:171","msg":"trace[1766733849] transaction","detail":"{read_only:false; response_revision:25389; number_of_response:1; }","duration":"582.149444ms","start":"2026-06-30T23:06:36.792248Z","end":"2026-06-30T23:06:37.374397Z","steps":["trace[1766733849] 'process raft request' (duration: 370.548211ms)","trace[1766733849] 'compare' (duration: 211.259905ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:37.3746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.74227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-30T23:06:37.374629Z","caller":"traceutil/trace.go:171","msg":"trace[1168606846] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:25390; }","duration":"315.824772ms","start":"2026-06-30T23:06:37.058797Z","end":"2026-06-30T23:06:37.374622Z","steps":["trace[1168606846] 'agreement among raft nodes before linearized reading' (duration: 315.668468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:37.374653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:37.058774Z","time spent":"315.871984ms","remote":"127.0.0.1:34516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":92,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-06-30T23:06:37.374707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:36.792228Z","time spent":"582.354488ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":865,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T23:06:37.617507Z","caller":"traceutil/trace.go:171","msg":"trace[2021859445] transaction","detail":"{read_only:false; response_revision:25392; number_of_response:1; }","duration":"260.382087ms","start":"2026-06-30T23:06:37.357096Z","end":"2026-06-30T23:06:37.617479Z","steps":["trace[2021859445] 'process raft request' (duration: 260.137172ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:37.617779Z","caller":"traceutil/trace.go:171","msg":"trace[224158718] transaction","detail":"{read_only:false; response_revision:25393; number_of_response:1; }","duration":"259.972328ms","start":"2026-06-30T23:06:37.357769Z","end":"2026-06-30T23:06:37.617741Z","steps":["trace[224158718] 'process raft request' (duration: 259.65466ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:37.617835Z","caller":"traceutil/trace.go:171","msg":"trace[1907678447] transaction","detail":"{read_only:false; response_revision:25394; number_of_response:1; }","duration":"259.727671ms","start":"2026-06-30T23:06:37.358086Z","end":"2026-06-30T23:06:37.617813Z","steps":["trace[1907678447] 'process raft request' (duration: 259.547397ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:37.617829Z","caller":"traceutil/trace.go:171","msg":"trace[1313094907] linearizableReadLoop","detail":"{readStateIndex:26209; appliedIndex:26205; }","duration":"243.359404ms","start":"2026-06-30T23:06:37.374446Z","end":"2026-06-30T23:06:37.617805Z","steps":["trace[1313094907] 'read index received' (duration: 22.031865ms)","trace[1313094907] 'applied index is now lower than readState.Index' (duration: 221.326699ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:37.618021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.657791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/container-infra-registry.18bdfe6a77fea369\" ","response":"range_response_count:1 size:722"} {"level":"info","ts":"2026-06-30T23:06:37.618039Z","caller":"traceutil/trace.go:171","msg":"trace[423449031] transaction","detail":"{read_only:false; response_revision:25395; number_of_response:1; }","duration":"259.912646ms","start":"2026-06-30T23:06:37.358114Z","end":"2026-06-30T23:06:37.618027Z","steps":["trace[423449031] 'process raft request' (duration: 259.631089ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:37.618077Z","caller":"traceutil/trace.go:171","msg":"trace[560458921] range","detail":"{range_begin:/registry/events/openstack/container-infra-registry.18bdfe6a77fea369; range_end:; response_count:1; response_revision:25395; }","duration":"508.755263ms","start":"2026-06-30T23:06:37.109307Z","end":"2026-06-30T23:06:37.618062Z","steps":["trace[560458921] 'agreement among raft nodes before linearized reading' (duration: 508.575089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:37.618111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:37.109287Z","time spent":"508.815494ms","remote":"127.0.0.1:34404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":745,"request content":"key:\"/registry/events/openstack/container-infra-registry.18bdfe6a77fea369\" "} {"level":"warn","ts":"2026-06-30T23:06:37.618184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.570294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-06-30T23:06:37.618237Z","caller":"traceutil/trace.go:171","msg":"trace[853995054] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6; range_end:; response_count:1; response_revision:25395; }","duration":"256.652596ms","start":"2026-06-30T23:06:37.361571Z","end":"2026-06-30T23:06:37.618224Z","steps":["trace[853995054] 'agreement among raft nodes before linearized reading' (duration: 256.455812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:37.811168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.657884ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T23:06:37.811359Z","caller":"traceutil/trace.go:171","msg":"trace[1225680618] linearizableReadLoop","detail":"{readStateIndex:26211; appliedIndex:26209; }","duration":"184.357752ms","start":"2026-06-30T23:06:37.626984Z","end":"2026-06-30T23:06:37.811342Z","steps":["trace[1225680618] 'read index received' (duration: 52.396551ms)","trace[1225680618] 'applied index is now lower than readState.Index' (duration: 131.960371ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:06:37.811448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.467306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:06:37.81148Z","caller":"traceutil/trace.go:171","msg":"trace[563127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25397; }","duration":"184.534467ms","start":"2026-06-30T23:06:37.626937Z","end":"2026-06-30T23:06:37.811471Z","steps":["trace[563127] 'agreement among raft nodes before linearized reading' (duration: 184.458035ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:37.811583Z","caller":"traceutil/trace.go:171","msg":"trace[1392750372] transaction","detail":"{read_only:false; response_revision:25396; number_of_response:1; }","duration":"316.900168ms","start":"2026-06-30T23:06:37.494653Z","end":"2026-06-30T23:06:37.811553Z","steps":["trace[1392750372] 'process raft request' (duration: 184.746602ms)","trace[1392750372] 'compare' (duration: 131.543871ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:37.811681Z","caller":"traceutil/trace.go:171","msg":"trace[1198654183] transaction","detail":"{read_only:false; response_revision:25397; number_of_response:1; }","duration":"190.897911ms","start":"2026-06-30T23:06:37.620772Z","end":"2026-06-30T23:06:37.81167Z","steps":["trace[1198654183] 'process raft request' (duration: 190.498672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:37.811754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:37.494624Z","time spent":"317.033101ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T23:06:38.089901Z","caller":"traceutil/trace.go:171","msg":"trace[1822930346] linearizableReadLoop","detail":"{readStateIndex:26212; appliedIndex:26211; }","duration":"264.684552ms","start":"2026-06-30T23:06:37.825196Z","end":"2026-06-30T23:06:38.08988Z","steps":["trace[1822930346] 'read index received' (duration: 264.488416ms)","trace[1822930346] 'applied index is now lower than readState.Index' (duration: 195.296µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:38.09Z","caller":"traceutil/trace.go:171","msg":"trace[1885035415] transaction","detail":"{read_only:false; response_revision:25398; number_of_response:1; }","duration":"272.196165ms","start":"2026-06-30T23:06:37.817774Z","end":"2026-06-30T23:06:38.08997Z","steps":["trace[1885035415] 'process raft request' (duration: 271.982019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:38.090237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.01173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-30T23:06:38.09033Z","caller":"traceutil/trace.go:171","msg":"trace[1989612077] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25398; }","duration":"265.130473ms","start":"2026-06-30T23:06:37.825177Z","end":"2026-06-30T23:06:38.090308Z","steps":["trace[1989612077] 'agreement among raft nodes before linearized reading' (duration: 264.822485ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:38.213738Z","caller":"traceutil/trace.go:171","msg":"trace[742032531] transaction","detail":"{read_only:false; response_revision:25400; number_of_response:1; }","duration":"119.07659ms","start":"2026-06-30T23:06:38.094637Z","end":"2026-06-30T23:06:38.213713Z","steps":["trace[742032531] 'process raft request' (duration: 118.589468ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:38.214008Z","caller":"traceutil/trace.go:171","msg":"trace[1636816967] transaction","detail":"{read_only:false; response_revision:25401; number_of_response:1; }","duration":"118.283139ms","start":"2026-06-30T23:06:38.0957Z","end":"2026-06-30T23:06:38.213983Z","steps":["trace[1636816967] 'process raft request' (duration: 117.950361ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:38.214152Z","caller":"traceutil/trace.go:171","msg":"trace[714772900] transaction","detail":"{read_only:false; response_revision:25406; number_of_response:1; }","duration":"116.23894ms","start":"2026-06-30T23:06:38.097888Z","end":"2026-06-30T23:06:38.214127Z","steps":["trace[714772900] 'process raft request' (duration: 116.193569ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:38.214299Z","caller":"traceutil/trace.go:171","msg":"trace[1972956878] transaction","detail":"{read_only:false; response_revision:25404; number_of_response:1; }","duration":"118.254748ms","start":"2026-06-30T23:06:38.096032Z","end":"2026-06-30T23:06:38.214286Z","steps":["trace[1972956878] 'process raft request' (duration: 117.974082ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:38.214301Z","caller":"traceutil/trace.go:171","msg":"trace[112940302] transaction","detail":"{read_only:false; response_revision:25403; number_of_response:1; }","duration":"118.493545ms","start":"2026-06-30T23:06:38.09576Z","end":"2026-06-30T23:06:38.214253Z","steps":["trace[112940302] 'process raft request' (duration: 118.205848ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:38.214336Z","caller":"traceutil/trace.go:171","msg":"trace[1877081354] transaction","detail":"{read_only:false; response_revision:25405; number_of_response:1; }","duration":"116.618429ms","start":"2026-06-30T23:06:38.097707Z","end":"2026-06-30T23:06:38.214325Z","steps":["trace[1877081354] 'process raft request' (duration: 116.338983ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:38.214476Z","caller":"traceutil/trace.go:171","msg":"trace[1519061352] transaction","detail":"{read_only:false; response_revision:25402; number_of_response:1; }","duration":"118.70936ms","start":"2026-06-30T23:06:38.09576Z","end":"2026-06-30T23:06:38.214469Z","steps":["trace[1519061352] 'process raft request' (duration: 118.079745ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:38.832674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.254747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-30T23:06:38.832708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.44142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:06:38.832778Z","caller":"traceutil/trace.go:171","msg":"trace[804318521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25406; }","duration":"204.532442ms","start":"2026-06-30T23:06:38.628229Z","end":"2026-06-30T23:06:38.832762Z","steps":["trace[804318521] 'range keys from in-memory index tree' (duration: 204.395809ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:38.832736Z","caller":"traceutil/trace.go:171","msg":"trace[637826294] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:25406; }","duration":"336.36541ms","start":"2026-06-30T23:06:38.496357Z","end":"2026-06-30T23:06:38.832723Z","steps":["trace[637826294] 'count revisions from in-memory index tree' (duration: 336.165916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:38.832849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:06:38.496337Z","time spent":"336.495274ms","remote":"127.0.0.1:34588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":19,"response size":31,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-06-30T23:06:38.832677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.414282ms","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-30T23:06:38.832903Z","caller":"traceutil/trace.go:171","msg":"trace[708794052] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25406; }","duration":"153.698459ms","start":"2026-06-30T23:06:38.679189Z","end":"2026-06-30T23:06:38.832887Z","steps":["trace[708794052] 'range keys from in-memory index tree' (duration: 153.234238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:38.832836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.994438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-06-30T23:06:38.832966Z","caller":"traceutil/trace.go:171","msg":"trace[1858341358] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6; range_end:; response_count:1; response_revision:25406; }","duration":"206.137731ms","start":"2026-06-30T23:06:38.626803Z","end":"2026-06-30T23:06:38.832941Z","steps":["trace[1858341358] 'range keys from in-memory index tree' (duration: 205.867995ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:39.025743Z","caller":"traceutil/trace.go:171","msg":"trace[841048786] transaction","detail":"{read_only:false; response_revision:25408; number_of_response:1; }","duration":"163.553678ms","start":"2026-06-30T23:06:38.862163Z","end":"2026-06-30T23:06:39.025717Z","steps":["trace[841048786] 'process raft request' (duration: 163.305941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:40.054635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.190369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6\" ","response":"range_response_count:1 size:3949"} {"level":"info","ts":"2026-06-30T23:06:40.054706Z","caller":"traceutil/trace.go:171","msg":"trace[1438258848] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a80e848f-3ca0-4f01-9d86-411dfcc655c6; range_end:; response_count:1; response_revision:25416; }","duration":"217.272801ms","start":"2026-06-30T23:06:39.837419Z","end":"2026-06-30T23:06:40.054692Z","steps":["trace[1438258848] 'range keys from in-memory index tree' (duration: 216.999935ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:40.054813Z","caller":"traceutil/trace.go:171","msg":"trace[779463062] transaction","detail":"{read_only:false; response_revision:25417; number_of_response:1; }","duration":"155.879762ms","start":"2026-06-30T23:06:39.898891Z","end":"2026-06-30T23:06:40.054771Z","steps":["trace[779463062] 'process raft request' (duration: 124.985633ms)","trace[779463062] 'compare' (duration: 30.565771ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:44.388819Z","caller":"traceutil/trace.go:171","msg":"trace[953947407] linearizableReadLoop","detail":"{readStateIndex:26281; appliedIndex:26280; }","duration":"133.910799ms","start":"2026-06-30T23:06:44.254881Z","end":"2026-06-30T23:06:44.388792Z","steps":["trace[953947407] 'read index received' (duration: 133.617142ms)","trace[953947407] 'applied index is now lower than readState.Index' (duration: 292.497µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:44.388869Z","caller":"traceutil/trace.go:171","msg":"trace[951392655] transaction","detail":"{read_only:false; response_revision:25465; number_of_response:1; }","duration":"151.367273ms","start":"2026-06-30T23:06:44.237469Z","end":"2026-06-30T23:06:44.388836Z","steps":["trace[951392655] 'process raft request' (duration: 151.073546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:44.389136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.026826ms","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-30T23:06:44.3892Z","caller":"traceutil/trace.go:171","msg":"trace[758127151] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25465; }","duration":"133.096788ms","start":"2026-06-30T23:06:44.256088Z","end":"2026-06-30T23:06:44.389184Z","steps":["trace[758127151] 'agreement among raft nodes before linearized reading' (duration: 132.927004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:44.389145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.521789ms","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-30T23:06:44.389233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.436077ms","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-30T23:06:44.389231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.690568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-30T23:06:44.389268Z","caller":"traceutil/trace.go:171","msg":"trace[1947563545] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25465; }","duration":"133.669593ms","start":"2026-06-30T23:06:44.255588Z","end":"2026-06-30T23:06:44.389258Z","steps":["trace[1947563545] 'agreement among raft nodes before linearized reading' (duration: 133.380826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:44.389243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.483803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:573"} {"level":"info","ts":"2026-06-30T23:06:44.389281Z","caller":"traceutil/trace.go:171","msg":"trace[1357977511] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25465; }","duration":"133.496428ms","start":"2026-06-30T23:06:44.25577Z","end":"2026-06-30T23:06:44.389266Z","steps":["trace[1357977511] 'agreement among raft nodes before linearized reading' (duration: 133.405656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:44.3893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.945535ms","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-30T23:06:44.389367Z","caller":"traceutil/trace.go:171","msg":"trace[1792484244] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25465; }","duration":"134.626787ms","start":"2026-06-30T23:06:44.254704Z","end":"2026-06-30T23:06:44.389331Z","steps":["trace[1792484244] 'agreement among raft nodes before linearized reading' (duration: 134.254828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:44.389394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.849263ms","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-30T23:06:44.389389Z","caller":"traceutil/trace.go:171","msg":"trace[1199457230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25465; }","duration":"133.064187ms","start":"2026-06-30T23:06:44.256301Z","end":"2026-06-30T23:06:44.389366Z","steps":["trace[1199457230] 'agreement among raft nodes before linearized reading' (duration: 132.77105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:06:44.389408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.646588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-06-30T23:06:44.389424Z","caller":"traceutil/trace.go:171","msg":"trace[2122673396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25465; }","duration":"132.894724ms","start":"2026-06-30T23:06:44.256524Z","end":"2026-06-30T23:06:44.389419Z","steps":["trace[2122673396] 'agreement among raft nodes before linearized reading' (duration: 132.816382ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.389442Z","caller":"traceutil/trace.go:171","msg":"trace[569414743] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25465; }","duration":"132.689019ms","start":"2026-06-30T23:06:44.25674Z","end":"2026-06-30T23:06:44.389429Z","steps":["trace[569414743] 'agreement among raft nodes before linearized reading' (duration: 132.594317ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.389294Z","caller":"traceutil/trace.go:171","msg":"trace[1208972352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25465; }","duration":"132.775531ms","start":"2026-06-30T23:06:44.256501Z","end":"2026-06-30T23:06:44.389277Z","steps":["trace[1208972352] 'agreement among raft nodes before linearized reading' (duration: 132.517125ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.677226Z","caller":"traceutil/trace.go:171","msg":"trace[246789422] transaction","detail":"{read_only:false; response_revision:25468; number_of_response:1; }","duration":"281.12272ms","start":"2026-06-30T23:06:44.396056Z","end":"2026-06-30T23:06:44.677178Z","steps":["trace[246789422] 'process raft request' (duration: 213.347776ms)","trace[246789422] 'compare' (duration: 67.18326ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:06:44.677279Z","caller":"traceutil/trace.go:171","msg":"trace[1601914324] transaction","detail":"{read_only:false; response_revision:25469; number_of_response:1; }","duration":"281.15881ms","start":"2026-06-30T23:06:44.396081Z","end":"2026-06-30T23:06:44.67724Z","steps":["trace[1601914324] 'process raft request' (duration: 280.959766ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.677492Z","caller":"traceutil/trace.go:171","msg":"trace[1064438854] transaction","detail":"{read_only:false; response_revision:25470; number_of_response:1; }","duration":"281.321044ms","start":"2026-06-30T23:06:44.396119Z","end":"2026-06-30T23:06:44.67744Z","steps":["trace[1064438854] 'process raft request' (duration: 281.044738ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.677514Z","caller":"traceutil/trace.go:171","msg":"trace[1345796116] transaction","detail":"{read_only:false; response_revision:25471; number_of_response:1; }","duration":"281.338785ms","start":"2026-06-30T23:06:44.396143Z","end":"2026-06-30T23:06:44.677482Z","steps":["trace[1345796116] 'process raft request' (duration: 281.197762ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.677768Z","caller":"traceutil/trace.go:171","msg":"trace[1493573165] transaction","detail":"{read_only:false; response_revision:25472; number_of_response:1; }","duration":"281.58465ms","start":"2026-06-30T23:06:44.396162Z","end":"2026-06-30T23:06:44.677747Z","steps":["trace[1493573165] 'process raft request' (duration: 281.269403ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.677799Z","caller":"traceutil/trace.go:171","msg":"trace[1716697211] transaction","detail":"{read_only:false; response_revision:25473; number_of_response:1; }","duration":"281.581441ms","start":"2026-06-30T23:06:44.396186Z","end":"2026-06-30T23:06:44.677768Z","steps":["trace[1716697211] 'process raft request' (duration: 281.447018ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.678022Z","caller":"traceutil/trace.go:171","msg":"trace[1664241424] transaction","detail":"{read_only:false; response_revision:25474; number_of_response:1; }","duration":"281.779665ms","start":"2026-06-30T23:06:44.396216Z","end":"2026-06-30T23:06:44.677995Z","steps":["trace[1664241424] 'process raft request' (duration: 281.519109ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.678229Z","caller":"traceutil/trace.go:171","msg":"trace[795644912] transaction","detail":"{read_only:false; response_revision:25475; number_of_response:1; }","duration":"281.97608ms","start":"2026-06-30T23:06:44.396237Z","end":"2026-06-30T23:06:44.678213Z","steps":["trace[795644912] 'process raft request' (duration: 281.668202ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:06:44.678296Z","caller":"traceutil/trace.go:171","msg":"trace[1126483391] transaction","detail":"{read_only:false; response_revision:25476; number_of_response:1; }","duration":"282.015571ms","start":"2026-06-30T23:06:44.396264Z","end":"2026-06-30T23:06:44.67828Z","steps":["trace[1126483391] 'process raft request' (duration: 281.888938ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:13.597089Z","caller":"traceutil/trace.go:171","msg":"trace[734091113] transaction","detail":"{read_only:false; response_revision:25707; number_of_response:1; }","duration":"105.399147ms","start":"2026-06-30T23:07:13.491656Z","end":"2026-06-30T23:07:13.597055Z","steps":["trace[734091113] 'process raft request' (duration: 105.196202ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:13.612054Z","caller":"traceutil/trace.go:171","msg":"trace[513380748] transaction","detail":"{read_only:false; response_revision:25708; number_of_response:1; }","duration":"100.674532ms","start":"2026-06-30T23:07:13.511333Z","end":"2026-06-30T23:07:13.612008Z","steps":["trace[513380748] 'process raft request' (duration: 100.300043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:15.752185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.771592ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-30T23:07:15.752747Z","caller":"traceutil/trace.go:171","msg":"trace[63834196] transaction","detail":"{read_only:false; response_revision:25720; number_of_response:1; }","duration":"150.803779ms","start":"2026-06-30T23:07:15.601926Z","end":"2026-06-30T23:07:15.75273Z","steps":["trace[63834196] 'process raft request' (duration: 150.373509ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:15.752568Z","caller":"traceutil/trace.go:171","msg":"trace[1261865835] linearizableReadLoop","detail":"{readStateIndex:26543; appliedIndex:26542; }","duration":"160.461442ms","start":"2026-06-30T23:07:15.592078Z","end":"2026-06-30T23:07:15.75254Z","steps":["trace[1261865835] 'read index received' (duration: 42.101µs)","trace[1261865835] 'applied index is now lower than readState.Index' (duration: 160.416791ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:07:15.765644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.559901ms","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-30T23:07:15.765683Z","caller":"traceutil/trace.go:171","msg":"trace[587576430] 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:25720; }","duration":"173.643082ms","start":"2026-06-30T23:07:15.592027Z","end":"2026-06-30T23:07:15.76567Z","steps":["trace[587576430] 'agreement among raft nodes before linearized reading' (duration: 160.861812ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:15.765806Z","caller":"traceutil/trace.go:171","msg":"trace[196107225] transaction","detail":"{read_only:false; response_revision:25721; number_of_response:1; }","duration":"147.55078ms","start":"2026-06-30T23:07:15.618233Z","end":"2026-06-30T23:07:15.765784Z","steps":["trace[196107225] 'process raft request' (duration: 134.486523ms)","trace[196107225] 'compare' (duration: 12.871681ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:15.931061Z","caller":"traceutil/trace.go:171","msg":"trace[180847286] transaction","detail":"{read_only:false; response_revision:25722; number_of_response:1; }","duration":"194.034958ms","start":"2026-06-30T23:07:15.73699Z","end":"2026-06-30T23:07:15.931025Z","steps":["trace[180847286] 'process raft request' (duration: 193.707759ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:15.931296Z","caller":"traceutil/trace.go:171","msg":"trace[1347689855] transaction","detail":"{read_only:false; response_revision:25723; number_of_response:1; }","duration":"191.480116ms","start":"2026-06-30T23:07:15.739785Z","end":"2026-06-30T23:07:15.931265Z","steps":["trace[1347689855] 'process raft request' (duration: 191.177819ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:15.93137Z","caller":"traceutil/trace.go:171","msg":"trace[500639219] linearizableReadLoop","detail":"{readStateIndex:26549; appliedIndex:26545; }","duration":"178.283116ms","start":"2026-06-30T23:07:15.753068Z","end":"2026-06-30T23:07:15.931351Z","steps":["trace[500639219] 'read index received' (duration: 177.574428ms)","trace[500639219] 'applied index is now lower than readState.Index' (duration: 707.478µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:07:15.931575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.547577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:07:15.931633Z","caller":"traceutil/trace.go:171","msg":"trace[1411270865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25725; }","duration":"306.65248ms","start":"2026-06-30T23:07:15.624965Z","end":"2026-06-30T23:07:15.931618Z","steps":["trace[1411270865] 'agreement among raft nodes before linearized reading' (duration: 306.545598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:15.931672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T23:07:15.624949Z","time spent":"306.713302ms","remote":"127.0.0.1:34356","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-30T23:07:15.931838Z","caller":"traceutil/trace.go:171","msg":"trace[118999689] transaction","detail":"{read_only:false; response_revision:25725; number_of_response:1; }","duration":"182.693692ms","start":"2026-06-30T23:07:15.749134Z","end":"2026-06-30T23:07:15.931828Z","steps":["trace[118999689] 'process raft request' (duration: 182.17698ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:15.931963Z","caller":"traceutil/trace.go:171","msg":"trace[811064498] transaction","detail":"{read_only:false; response_revision:25724; number_of_response:1; }","duration":"182.832405ms","start":"2026-06-30T23:07:15.749118Z","end":"2026-06-30T23:07:15.931951Z","steps":["trace[811064498] 'process raft request' (duration: 182.080057ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:16.766648Z","caller":"traceutil/trace.go:171","msg":"trace[1992836524] linearizableReadLoop","detail":"{readStateIndex:26551; appliedIndex:26550; }","duration":"139.074015ms","start":"2026-06-30T23:07:16.627546Z","end":"2026-06-30T23:07:16.76662Z","steps":["trace[1992836524] 'read index received' (duration: 123.735272ms)","trace[1992836524] 'applied index is now lower than readState.Index' (duration: 15.337503ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:16.766697Z","caller":"traceutil/trace.go:171","msg":"trace[279521659] transaction","detail":"{read_only:false; response_revision:25727; number_of_response:1; }","duration":"152.665224ms","start":"2026-06-30T23:07:16.61399Z","end":"2026-06-30T23:07:16.766655Z","steps":["trace[279521659] 'process raft request' (duration: 137.315132ms)","trace[279521659] 'compare' (duration: 15.175078ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:07:16.766845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.277049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:07:16.766935Z","caller":"traceutil/trace.go:171","msg":"trace[894165972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25727; }","duration":"139.405543ms","start":"2026-06-30T23:07:16.627509Z","end":"2026-06-30T23:07:16.766914Z","steps":["trace[894165972] 'agreement among raft nodes before linearized reading' (duration: 139.239199ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:16.992279Z","caller":"traceutil/trace.go:171","msg":"trace[983050307] linearizableReadLoop","detail":"{readStateIndex:26552; appliedIndex:26551; }","duration":"142.574639ms","start":"2026-06-30T23:07:16.849677Z","end":"2026-06-30T23:07:16.992251Z","steps":["trace[983050307] 'read index received' (duration: 142.337083ms)","trace[983050307] 'applied index is now lower than readState.Index' (duration: 236.606µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:16.992411Z","caller":"traceutil/trace.go:171","msg":"trace[1763435489] transaction","detail":"{read_only:false; response_revision:25728; number_of_response:1; }","duration":"145.173392ms","start":"2026-06-30T23:07:16.847194Z","end":"2026-06-30T23:07:16.992368Z","steps":["trace[1763435489] 'process raft request' (duration: 144.883415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:16.992567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.869446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-30T23:07:16.992613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.516255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-30T23:07:16.992659Z","caller":"traceutil/trace.go:171","msg":"trace[1016489164] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25728; }","duration":"142.99394ms","start":"2026-06-30T23:07:16.84964Z","end":"2026-06-30T23:07:16.992634Z","steps":["trace[1016489164] 'agreement among raft nodes before linearized reading' (duration: 142.748813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:16.992673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.187311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-30T23:07:16.992706Z","caller":"traceutil/trace.go:171","msg":"trace[519341872] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25728; }","duration":"132.663689ms","start":"2026-06-30T23:07:16.860018Z","end":"2026-06-30T23:07:16.992682Z","steps":["trace[519341872] 'agreement among raft nodes before linearized reading' (duration: 132.426692ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:16.992729Z","caller":"traceutil/trace.go:171","msg":"trace[1698811349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25728; }","duration":"133.284684ms","start":"2026-06-30T23:07:16.85943Z","end":"2026-06-30T23:07:16.992714Z","steps":["trace[1698811349] 'agreement among raft nodes before linearized reading' (duration: 133.115559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:16.992733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.770772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T23:07:16.992822Z","caller":"traceutil/trace.go:171","msg":"trace[1646037542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25728; }","duration":"132.870774ms","start":"2026-06-30T23:07:16.859931Z","end":"2026-06-30T23:07:16.992801Z","steps":["trace[1646037542] 'agreement among raft nodes before linearized reading' (duration: 132.588276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:16.992905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.798494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"} {"level":"info","ts":"2026-06-30T23:07:16.992949Z","caller":"traceutil/trace.go:171","msg":"trace[1518404051] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25728; }","duration":"137.856605ms","start":"2026-06-30T23:07:16.855077Z","end":"2026-06-30T23:07:16.992934Z","steps":["trace[1518404051] 'agreement among raft nodes before linearized reading' (duration: 137.336282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:17.197867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.936295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T23:07:17.198083Z","caller":"traceutil/trace.go:171","msg":"trace[2043432490] linearizableReadLoop","detail":"{readStateIndex:26556; appliedIndex:26552; }","duration":"198.729162ms","start":"2026-06-30T23:07:16.999342Z","end":"2026-06-30T23:07:17.198071Z","steps":["trace[2043432490] 'read index received' (duration: 58.533281ms)","trace[2043432490] 'applied index is now lower than readState.Index' (duration: 140.194921ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:17.19815Z","caller":"traceutil/trace.go:171","msg":"trace[179481230] transaction","detail":"{read_only:false; response_revision:25730; number_of_response:1; }","duration":"200.953645ms","start":"2026-06-30T23:07:16.99719Z","end":"2026-06-30T23:07:17.198144Z","steps":["trace[179481230] 'process raft request' (duration: 200.770361ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:17.198173Z","caller":"traceutil/trace.go:171","msg":"trace[757278775] transaction","detail":"{read_only:false; response_revision:25729; number_of_response:1; }","duration":"201.022368ms","start":"2026-06-30T23:07:16.997132Z","end":"2026-06-30T23:07:17.198154Z","steps":["trace[757278775] 'process raft request' (duration: 60.718954ms)","trace[757278775] 'compare' (duration: 139.752751ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:17.198358Z","caller":"traceutil/trace.go:171","msg":"trace[35509597] transaction","detail":"{read_only:false; response_revision:25732; number_of_response:1; }","duration":"200.464563ms","start":"2026-06-30T23:07:16.997887Z","end":"2026-06-30T23:07:17.198352Z","steps":["trace[35509597] 'process raft request' (duration: 200.158966ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:17.198383Z","caller":"traceutil/trace.go:171","msg":"trace[593687310] transaction","detail":"{read_only:false; response_revision:25731; number_of_response:1; }","duration":"200.526656ms","start":"2026-06-30T23:07:16.997832Z","end":"2026-06-30T23:07:17.198358Z","steps":["trace[593687310] 'process raft request' (duration: 200.193318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:17.198509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.058719ms","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-30T23:07:17.198611Z","caller":"traceutil/trace.go:171","msg":"trace[1784611284] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25732; }","duration":"199.264334ms","start":"2026-06-30T23:07:16.999322Z","end":"2026-06-30T23:07:17.198586Z","steps":["trace[1784611284] 'agreement among raft nodes before linearized reading' (duration: 198.882755ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:17.886449Z","caller":"traceutil/trace.go:171","msg":"trace[1702900423] transaction","detail":"{read_only:false; response_revision:25733; number_of_response:1; }","duration":"129.292668ms","start":"2026-06-30T23:07:17.757139Z","end":"2026-06-30T23:07:17.886431Z","steps":["trace[1702900423] 'process raft request' (duration: 129.165535ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:18.059297Z","caller":"traceutil/trace.go:171","msg":"trace[1904510922] transaction","detail":"{read_only:false; response_revision:25734; number_of_response:1; }","duration":"290.880497ms","start":"2026-06-30T23:07:17.768396Z","end":"2026-06-30T23:07:18.059277Z","steps":["trace[1904510922] 'process raft request' (duration: 267.362307ms)","trace[1904510922] 'compare' (duration: 23.385017ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:18.059632Z","caller":"traceutil/trace.go:171","msg":"trace[1871568415] transaction","detail":"{read_only:false; response_revision:25736; number_of_response:1; }","duration":"198.719771ms","start":"2026-06-30T23:07:17.860848Z","end":"2026-06-30T23:07:18.059568Z","steps":["trace[1871568415] 'process raft request' (duration: 198.560288ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:18.059907Z","caller":"traceutil/trace.go:171","msg":"trace[2072430724] transaction","detail":"{read_only:false; response_revision:25735; number_of_response:1; }","duration":"290.095097ms","start":"2026-06-30T23:07:17.769804Z","end":"2026-06-30T23:07:18.059899Z","steps":["trace[2072430724] 'process raft request' (duration: 289.441862ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:18.087281Z","caller":"traceutil/trace.go:171","msg":"trace[327595253] transaction","detail":"{read_only:false; response_revision:25740; number_of_response:1; }","duration":"148.301357ms","start":"2026-06-30T23:07:17.938955Z","end":"2026-06-30T23:07:18.087256Z","steps":["trace[327595253] 'process raft request' (duration: 148.267016ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:18.087295Z","caller":"traceutil/trace.go:171","msg":"trace[583255765] transaction","detail":"{read_only:false; response_revision:25737; number_of_response:1; }","duration":"150.527172ms","start":"2026-06-30T23:07:17.936739Z","end":"2026-06-30T23:07:18.087266Z","steps":["trace[583255765] 'process raft request' (duration: 150.291966ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:18.087364Z","caller":"traceutil/trace.go:171","msg":"trace[1043834204] transaction","detail":"{read_only:false; response_revision:25739; number_of_response:1; }","duration":"150.07041ms","start":"2026-06-30T23:07:17.937261Z","end":"2026-06-30T23:07:18.087332Z","steps":["trace[1043834204] 'process raft request' (duration: 149.936377ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:18.087319Z","caller":"traceutil/trace.go:171","msg":"trace[1079218264] transaction","detail":"{read_only:false; response_revision:25738; number_of_response:1; }","duration":"150.325266ms","start":"2026-06-30T23:07:17.936969Z","end":"2026-06-30T23:07:18.087294Z","steps":["trace[1079218264] 'process raft request' (duration: 150.198003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:18.919964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.585365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"} {"level":"info","ts":"2026-06-30T23:07:18.920033Z","caller":"traceutil/trace.go:171","msg":"trace[1595828458] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25741; }","duration":"148.692618ms","start":"2026-06-30T23:07:18.77132Z","end":"2026-06-30T23:07:18.920012Z","steps":["trace[1595828458] 'range keys from in-memory index tree' (duration: 148.447222ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:19.189789Z","caller":"traceutil/trace.go:171","msg":"trace[81854019] linearizableReadLoop","detail":"{readStateIndex:26567; appliedIndex:26566; }","duration":"126.587151ms","start":"2026-06-30T23:07:19.063179Z","end":"2026-06-30T23:07:19.189766Z","steps":["trace[81854019] 'read index received' (duration: 52.093244ms)","trace[81854019] 'applied index is now lower than readState.Index' (duration: 74.493077ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:19.189844Z","caller":"traceutil/trace.go:171","msg":"trace[1847765785] transaction","detail":"{read_only:false; response_revision:25743; number_of_response:1; }","duration":"191.25406ms","start":"2026-06-30T23:07:18.998545Z","end":"2026-06-30T23:07:19.189799Z","steps":["trace[1847765785] 'process raft request' (duration: 116.760492ms)","trace[1847765785] 'compare' (duration: 74.312564ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:07:19.189989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.305412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-30T23:07:19.19003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.837947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-30T23:07:19.19006Z","caller":"traceutil/trace.go:171","msg":"trace[186715363] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:25743; }","duration":"123.429365ms","start":"2026-06-30T23:07:19.066611Z","end":"2026-06-30T23:07:19.190041Z","steps":["trace[186715363] 'agreement among raft nodes before linearized reading' (duration: 123.310952ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:19.190072Z","caller":"traceutil/trace.go:171","msg":"trace[2076898082] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25743; }","duration":"126.921749ms","start":"2026-06-30T23:07:19.063137Z","end":"2026-06-30T23:07:19.190059Z","steps":["trace[2076898082] 'agreement among raft nodes before linearized reading' (duration: 126.761985ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:19.342063Z","caller":"traceutil/trace.go:171","msg":"trace[47264929] linearizableReadLoop","detail":"{readStateIndex:26568; appliedIndex:26567; }","duration":"134.707058ms","start":"2026-06-30T23:07:19.207327Z","end":"2026-06-30T23:07:19.342034Z","steps":["trace[47264929] 'read index received' (duration: 91.764186ms)","trace[47264929] 'applied index is now lower than readState.Index' (duration: 42.941472ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:19.342103Z","caller":"traceutil/trace.go:171","msg":"trace[1700550894] transaction","detail":"{read_only:false; response_revision:25744; number_of_response:1; }","duration":"135.805674ms","start":"2026-06-30T23:07:19.20625Z","end":"2026-06-30T23:07:19.342056Z","steps":["trace[1700550894] 'process raft request' (duration: 92.870123ms)","trace[1700550894] 'compare' (duration: 42.619794ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:19.342251Z","caller":"traceutil/trace.go:171","msg":"trace[1562320578] transaction","detail":"{read_only:false; response_revision:25746; number_of_response:1; }","duration":"134.095644ms","start":"2026-06-30T23:07:19.208141Z","end":"2026-06-30T23:07:19.342237Z","steps":["trace[1562320578] 'process raft request' (duration: 134.027472ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:19.342282Z","caller":"traceutil/trace.go:171","msg":"trace[2066369502] transaction","detail":"{read_only:false; response_revision:25745; number_of_response:1; }","duration":"134.296868ms","start":"2026-06-30T23:07:19.207957Z","end":"2026-06-30T23:07:19.342254Z","steps":["trace[2066369502] 'process raft request' (duration: 134.017122ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:19.342446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.058846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T23:07:19.342554Z","caller":"traceutil/trace.go:171","msg":"trace[1806983851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25745; }","duration":"135.228851ms","start":"2026-06-30T23:07:19.207296Z","end":"2026-06-30T23:07:19.342525Z","steps":["trace[1806983851] 'agreement among raft nodes before linearized reading' (duration: 134.817421ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:21.330095Z","caller":"traceutil/trace.go:171","msg":"trace[880817437] transaction","detail":"{read_only:false; response_revision:25759; number_of_response:1; }","duration":"122.981364ms","start":"2026-06-30T23:07:21.207083Z","end":"2026-06-30T23:07:21.330064Z","steps":["trace[880817437] 'process raft request' (duration: 122.779899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:21.565676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.58602ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-30T23:07:21.566089Z","caller":"traceutil/trace.go:171","msg":"trace[1774250279] linearizableReadLoop","detail":"{readStateIndex:26587; appliedIndex:26584; }","duration":"145.021979ms","start":"2026-06-30T23:07:21.421044Z","end":"2026-06-30T23:07:21.566066Z","steps":["trace[1774250279] 'read index received' (duration: 143.992995ms)","trace[1774250279] 'applied index is now lower than readState.Index' (duration: 1.027514ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:21.566132Z","caller":"traceutil/trace.go:171","msg":"trace[851501094] transaction","detail":"{read_only:false; response_revision:25760; number_of_response:1; }","duration":"215.113229ms","start":"2026-06-30T23:07:21.350979Z","end":"2026-06-30T23:07:21.566092Z","steps":["trace[851501094] 'process raft request' (duration: 66.978555ms)","trace[851501094] 'compare' (duration: 147.202561ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:21.566163Z","caller":"traceutil/trace.go:171","msg":"trace[2063484531] transaction","detail":"{read_only:false; response_revision:25761; number_of_response:1; }","duration":"215.038377ms","start":"2026-06-30T23:07:21.351097Z","end":"2026-06-30T23:07:21.566135Z","steps":["trace[2063484531] 'process raft request' (duration: 214.709679ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:21.56617Z","caller":"traceutil/trace.go:171","msg":"trace[1314722513] transaction","detail":"{read_only:false; response_revision:25762; number_of_response:1; }","duration":"214.75276ms","start":"2026-06-30T23:07:21.351396Z","end":"2026-06-30T23:07:21.566149Z","steps":["trace[1314722513] 'process raft request' (duration: 214.622827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:21.56635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.306216ms","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-30T23:07:21.566389Z","caller":"traceutil/trace.go:171","msg":"trace[1811638101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25762; }","duration":"145.386498ms","start":"2026-06-30T23:07:21.420991Z","end":"2026-06-30T23:07:21.566378Z","steps":["trace[1811638101] 'agreement among raft nodes before linearized reading' (duration: 145.141622ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:22.270263Z","caller":"traceutil/trace.go:171","msg":"trace[1804554744] transaction","detail":"{read_only:false; response_revision:25767; number_of_response:1; }","duration":"170.116447ms","start":"2026-06-30T23:07:22.1001Z","end":"2026-06-30T23:07:22.270216Z","steps":["trace[1804554744] 'process raft request' (duration: 105.479499ms)","trace[1804554744] 'compare' (duration: 64.190047ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:22.27038Z","caller":"traceutil/trace.go:171","msg":"trace[1339941655] transaction","detail":"{read_only:false; response_revision:25768; number_of_response:1; }","duration":"168.792845ms","start":"2026-06-30T23:07:22.101552Z","end":"2026-06-30T23:07:22.270345Z","steps":["trace[1339941655] 'process raft request' (duration: 168.548919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:22.270463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.975456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:07:22.27051Z","caller":"traceutil/trace.go:171","msg":"trace[869515768] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25769; }","duration":"161.102898ms","start":"2026-06-30T23:07:22.109392Z","end":"2026-06-30T23:07:22.270495Z","steps":["trace[869515768] 'agreement among raft nodes before linearized reading' (duration: 160.943124ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:22.270303Z","caller":"traceutil/trace.go:171","msg":"trace[1375983437] linearizableReadLoop","detail":"{readStateIndex:26594; appliedIndex:26590; }","duration":"160.851842ms","start":"2026-06-30T23:07:22.109437Z","end":"2026-06-30T23:07:22.270289Z","steps":["trace[1375983437] 'read index received' (duration: 45.285668ms)","trace[1375983437] 'applied index is now lower than readState.Index' (duration: 115.565093ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:22.27059Z","caller":"traceutil/trace.go:171","msg":"trace[1645710978] transaction","detail":"{read_only:false; response_revision:25769; number_of_response:1; }","duration":"168.860167ms","start":"2026-06-30T23:07:22.101703Z","end":"2026-06-30T23:07:22.270563Z","steps":["trace[1645710978] 'process raft request' (duration: 168.534948ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:23.176098Z","caller":"traceutil/trace.go:171","msg":"trace[1482559021] transaction","detail":"{read_only:false; response_revision:25771; number_of_response:1; }","duration":"110.623274ms","start":"2026-06-30T23:07:23.065425Z","end":"2026-06-30T23:07:23.176049Z","steps":["trace[1482559021] 'process raft request' (duration: 110.43041ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:23.296938Z","caller":"traceutil/trace.go:171","msg":"trace[346925475] transaction","detail":"{read_only:false; response_revision:25772; number_of_response:1; }","duration":"115.485231ms","start":"2026-06-30T23:07:23.181423Z","end":"2026-06-30T23:07:23.296908Z","steps":["trace[346925475] 'process raft request' (duration: 26.166984ms)","trace[346925475] 'compare' (duration: 89.099352ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:38.931667Z","caller":"traceutil/trace.go:171","msg":"trace[1187269851] linearizableReadLoop","detail":"{readStateIndex:26725; appliedIndex:26724; }","duration":"109.400764ms","start":"2026-06-30T23:07:38.822243Z","end":"2026-06-30T23:07:38.931644Z","steps":["trace[1187269851] 'read index received' (duration: 109.286541ms)","trace[1187269851] 'applied index is now lower than readState.Index' (duration: 113.193µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:38.932183Z","caller":"traceutil/trace.go:171","msg":"trace[343579771] transaction","detail":"{read_only:false; response_revision:25897; number_of_response:1; }","duration":"122.549093ms","start":"2026-06-30T23:07:38.809617Z","end":"2026-06-30T23:07:38.932166Z","steps":["trace[343579771] 'process raft request' (duration: 121.820896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:38.932416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.161703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:07:38.932449Z","caller":"traceutil/trace.go:171","msg":"trace[1722308743] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumes/; range_end:/registry/openstack.k-orc.cloud/volumes0; response_count:0; response_revision:25897; }","duration":"110.231704ms","start":"2026-06-30T23:07:38.822206Z","end":"2026-06-30T23:07:38.932438Z","steps":["trace[1722308743] 'agreement among raft nodes before linearized reading' (duration: 110.159402ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:39.038098Z","caller":"traceutil/trace.go:171","msg":"trace[2003222719] transaction","detail":"{read_only:false; response_revision:25898; number_of_response:1; }","duration":"101.788519ms","start":"2026-06-30T23:07:38.936275Z","end":"2026-06-30T23:07:39.038064Z","steps":["trace[2003222719] 'process raft request' (duration: 101.544114ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:44.433412Z","caller":"traceutil/trace.go:171","msg":"trace[335986112] linearizableReadLoop","detail":"{readStateIndex:26768; appliedIndex:26766; }","duration":"178.839389ms","start":"2026-06-30T23:07:44.254551Z","end":"2026-06-30T23:07:44.43339Z","steps":["trace[335986112] 'read index received' (duration: 6.238331ms)","trace[335986112] 'applied index is now lower than readState.Index' (duration: 172.600318ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:44.433509Z","caller":"traceutil/trace.go:171","msg":"trace[650820616] transaction","detail":"{read_only:false; response_revision:25939; number_of_response:1; }","duration":"189.095128ms","start":"2026-06-30T23:07:44.244383Z","end":"2026-06-30T23:07:44.433478Z","steps":["trace[650820616] 'process raft request' (duration: 160.501004ms)","trace[650820616] 'compare' (duration: 28.402639ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:07:44.433606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.006442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:07:44.433702Z","caller":"traceutil/trace.go:171","msg":"trace[2070042164] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:25939; }","duration":"179.159036ms","start":"2026-06-30T23:07:44.254517Z","end":"2026-06-30T23:07:44.433676Z","steps":["trace[2070042164] 'agreement among raft nodes before linearized reading' (duration: 178.984092ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:44.519194Z","caller":"traceutil/trace.go:171","msg":"trace[1019611649] transaction","detail":"{read_only:false; response_revision:25940; number_of_response:1; }","duration":"175.946869ms","start":"2026-06-30T23:07:44.343222Z","end":"2026-06-30T23:07:44.519169Z","steps":["trace[1019611649] 'process raft request' (duration: 175.768195ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:44.519461Z","caller":"traceutil/trace.go:171","msg":"trace[1584530218] transaction","detail":"{read_only:false; response_revision:25941; number_of_response:1; }","duration":"172.861004ms","start":"2026-06-30T23:07:44.346566Z","end":"2026-06-30T23:07:44.519427Z","steps":["trace[1584530218] 'process raft request' (duration: 172.557657ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:44.519665Z","caller":"traceutil/trace.go:171","msg":"trace[327265939] transaction","detail":"{read_only:false; response_revision:25942; number_of_response:1; }","duration":"171.799108ms","start":"2026-06-30T23:07:44.347844Z","end":"2026-06-30T23:07:44.519643Z","steps":["trace[327265939] 'process raft request' (duration: 171.477971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:44.519738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.323283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:07:44.519772Z","caller":"traceutil/trace.go:171","msg":"trace[1211051069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25942; }","duration":"264.367234ms","start":"2026-06-30T23:07:44.255395Z","end":"2026-06-30T23:07:44.519763Z","steps":["trace[1211051069] 'agreement among raft nodes before linearized reading' (duration: 264.285732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:44.822609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.423959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112180"} {"level":"info","ts":"2026-06-30T23:07:44.822688Z","caller":"traceutil/trace.go:171","msg":"trace[660445898] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:25943; }","duration":"152.526181ms","start":"2026-06-30T23:07:44.670144Z","end":"2026-06-30T23:07:44.82267Z","steps":["trace[660445898] 'range keys from in-memory index tree' (duration: 152.162242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T23:07:45.272965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.808017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-30T23:07:45.273042Z","caller":"traceutil/trace.go:171","msg":"trace[1252800325] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:25944; }","duration":"246.90394ms","start":"2026-06-30T23:07:45.026119Z","end":"2026-06-30T23:07:45.273023Z","steps":["trace[1252800325] 'range keys from in-memory index tree' (duration: 246.703185ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:45.442101Z","caller":"traceutil/trace.go:171","msg":"trace[1895315918] transaction","detail":"{read_only:false; response_revision:25945; number_of_response:1; }","duration":"134.191526ms","start":"2026-06-30T23:07:45.307868Z","end":"2026-06-30T23:07:45.44206Z","steps":["trace[1895315918] 'process raft request' (duration: 133.915329ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:45.608051Z","caller":"traceutil/trace.go:171","msg":"trace[1274535086] transaction","detail":"{read_only:false; response_revision:25947; number_of_response:1; }","duration":"133.746804ms","start":"2026-06-30T23:07:45.474274Z","end":"2026-06-30T23:07:45.608021Z","steps":["trace[1274535086] 'process raft request' (duration: 75.45184ms)","trace[1274535086] 'compare' (duration: 58.162601ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T23:07:45.766287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.754452ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-06-30T23:07:45.76688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.418883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-30T23:07:45.767035Z","caller":"traceutil/trace.go:171","msg":"trace[833424528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25947; }","duration":"139.599827ms","start":"2026-06-30T23:07:45.627398Z","end":"2026-06-30T23:07:45.766998Z","steps":["trace[833424528] 'agreement among raft nodes before linearized reading' (duration: 139.383791ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:45.766398Z","caller":"traceutil/trace.go:171","msg":"trace[55155503] linearizableReadLoop","detail":"{readStateIndex:26777; appliedIndex:26776; }","duration":"138.943081ms","start":"2026-06-30T23:07:45.627433Z","end":"2026-06-30T23:07:45.766376Z","steps":["trace[55155503] 'read index received' (duration: 40.231µs)","trace[55155503] 'applied index is now lower than readState.Index' (duration: 138.90109ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T23:07:45.889525Z","caller":"traceutil/trace.go:171","msg":"trace[1235531433] transaction","detail":"{read_only:false; response_revision:25948; number_of_response:1; }","duration":"117.859659ms","start":"2026-06-30T23:07:45.771639Z","end":"2026-06-30T23:07:45.889499Z","steps":["trace[1235531433] 'process raft request' (duration: 117.643724ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:45.908616Z","caller":"traceutil/trace.go:171","msg":"trace[582283263] transaction","detail":"{read_only:false; response_revision:25949; number_of_response:1; }","duration":"136.547123ms","start":"2026-06-30T23:07:45.77204Z","end":"2026-06-30T23:07:45.908587Z","steps":["trace[582283263] 'process raft request' (duration: 136.349957ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:45.909037Z","caller":"traceutil/trace.go:171","msg":"trace[666534979] transaction","detail":"{read_only:false; response_revision:25950; number_of_response:1; }","duration":"136.530212ms","start":"2026-06-30T23:07:45.772473Z","end":"2026-06-30T23:07:45.909004Z","steps":["trace[666534979] 'process raft request' (duration: 136.073291ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:07:45.909085Z","caller":"traceutil/trace.go:171","msg":"trace[297510545] transaction","detail":"{read_only:false; response_revision:25951; number_of_response:1; }","duration":"134.79767ms","start":"2026-06-30T23:07:45.774267Z","end":"2026-06-30T23:07:45.909065Z","steps":["trace[297510545] 'process raft request' (duration: 134.667207ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T23:08:47.261326Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23589} {"level":"info","ts":"2026-06-30T23:08:47.396193Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23589,"took":"130.590219ms","hash":1823307511,"current-db-size-bytes":59703296,"current-db-size":"60 MB","current-db-size-in-use-bytes":38617088,"current-db-size-in-use":"39 MB"} {"level":"info","ts":"2026-06-30T23:08:47.396495Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1823307511,"revision":23589,"compact-revision":20441} {"level":"info","ts":"2026-06-30T23:13:17.996427Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b6478f0ac5aeb8e1","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-30T23:13:18.001488Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-30T23:13:18.001691Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-30T23:13:47.270449Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26629} {"level":"info","ts":"2026-06-30T23:13:47.419969Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26629,"took":"144.967477ms","hash":47859135,"current-db-size-bytes":59703296,"current-db-size":"60 MB","current-db-size-in-use-bytes":35352576,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-30T23:13:47.42004Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":47859135,"revision":26629,"compact-revision":23589} {"level":"info","ts":"2026-06-30T23:18:47.278346Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29299} {"level":"info","ts":"2026-06-30T23:18:47.418124Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29299,"took":"135.15232ms","hash":4088561738,"current-db-size-bytes":59703296,"current-db-size":"60 MB","current-db-size-in-use-bytes":31117312,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-30T23:18:47.418202Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4088561738,"revision":29299,"compact-revision":26629} {"level":"info","ts":"2026-06-30T23:23:47.284241Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31564} {"level":"info","ts":"2026-06-30T23:23:47.413087Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31564,"took":"124.443519ms","hash":1530485243,"current-db-size-bytes":59703296,"current-db-size":"60 MB","current-db-size-in-use-bytes":31223808,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-30T23:23:47.413157Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1530485243,"revision":31564,"compact-revision":29299} {"level":"info","ts":"2026-06-30T23:28:47.291554Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33862} {"level":"info","ts":"2026-06-30T23:28:47.441802Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33862,"took":"143.662286ms","hash":3659491562,"current-db-size-bytes":60747776,"current-db-size":"61 MB","current-db-size-in-use-bytes":33636352,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-30T23:28:47.441873Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3659491562,"revision":33862,"compact-revision":31564} {"level":"info","ts":"2026-06-30T23:33:47.300633Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36198} {"level":"info","ts":"2026-06-30T23:33:47.43853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36198,"took":"133.306845ms","hash":3433056933,"current-db-size-bytes":61681664,"current-db-size":"62 MB","current-db-size-in-use-bytes":32702464,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-30T23:33:47.438585Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3433056933,"revision":36198,"compact-revision":33862} {"level":"info","ts":"2026-06-30T23:34:34.103506Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b6478f0ac5aeb8e1","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-30T23:34:34.108239Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-30T23:34:34.108355Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}