{"level":"warn","ts":"2026-09-29T05:25:14.81438Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-29T05:25:14.81449Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.193: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://162.253.55.193:2380","--initial-cluster=instance=https://162.253.55.193:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.193:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.193: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-09-29T05:25:14.814575Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-29T05:25:14.814603Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-09-29T05:25:14.814627Z","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-09-29T05:25:14.815402Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"]} {"level":"info","ts":"2026-09-29T05:25:14.815492Z","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://162.253.55.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.193: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-09-29T05:25:14.820227Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.47751ms"} {"level":"info","ts":"2026-09-29T05:25:14.829025Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6814e3e3d6b4d713","cluster-id":"e5e99c9118b1492a"} {"level":"info","ts":"2026-09-29T05:25:14.829216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=()"} {"level":"info","ts":"2026-09-29T05:25:14.829347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 0"} {"level":"info","ts":"2026-09-29T05:25:14.829368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6814e3e3d6b4d713 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-29T05:25:14.829395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became follower at term 1"} {"level":"info","ts":"2026-09-29T05:25:14.829468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"warn","ts":"2026-09-29T05:25:14.842993Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-29T05:25:14.847468Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-29T05:25:14.849189Z","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-09-29T05:25:14.852202Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6814e3e3d6b4d713","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-29T05:25:14.852871Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6814e3e3d6b4d713","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-29T05:25:14.852907Z","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-09-29T05:25:14.853172Z","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-09-29T05:25:14.853215Z","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-09-29T05:25:14.853754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 switched to configuration voters=(7499869847177975571)"} {"level":"info","ts":"2026-09-29T05:25:14.85397Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","added-peer-id":"6814e3e3d6b4d713","added-peer-peer-urls":["https://162.253.55.193:2380"]} {"level":"info","ts":"2026-09-29T05:25:14.857038Z","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-09-29T05:25:14.857304Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6814e3e3d6b4d713","initial-advertise-peer-urls":["https://162.253.55.193:2380"],"listen-peer-urls":["https://162.253.55.193:2380"],"advertise-client-urls":["https://162.253.55.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-29T05:25:14.85735Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-29T05:25:14.858101Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-09-29T05:25:14.858139Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.193:2380"} {"level":"info","ts":"2026-09-29T05:25:15.830519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 is starting a new election at term 1"} {"level":"info","ts":"2026-09-29T05:25:15.83061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-29T05:25:15.830651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgPreVoteResp from 6814e3e3d6b4d713 at term 1"} {"level":"info","ts":"2026-09-29T05:25:15.830674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became candidate at term 2"} {"level":"info","ts":"2026-09-29T05:25:15.830687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 received MsgVoteResp from 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-09-29T05:25:15.830703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6814e3e3d6b4d713 became leader at term 2"} {"level":"info","ts":"2026-09-29T05:25:15.830722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6814e3e3d6b4d713 elected leader 6814e3e3d6b4d713 at term 2"} {"level":"info","ts":"2026-09-29T05:25:15.831915Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T05:25:15.833183Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T05:25:15.83318Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6814e3e3d6b4d713","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.193:2379]}","request-path":"/0/members/6814e3e3d6b4d713/attributes","cluster-id":"e5e99c9118b1492a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-29T05:25:15.833241Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T05:25:15.833477Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-29T05:25:15.83351Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-29T05:25:15.834111Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e5e99c9118b1492a","local-member-id":"6814e3e3d6b4d713","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T05:25:15.834242Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T05:25:15.834294Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T05:25:15.83629Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-29T05:25:15.836735Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.193:2379"} {"level":"info","ts":"2026-09-29T05:25:31.830518Z","caller":"traceutil/trace.go:171","msg":"trace[1181262419] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"135.200547ms","start":"2026-09-29T05:25:31.69529Z","end":"2026-09-29T05:25:31.830491Z","steps":["trace[1181262419] 'process raft request' (duration: 135.041013ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:25:42.435154Z","caller":"traceutil/trace.go:171","msg":"trace[613451263] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"156.712806ms","start":"2026-09-29T05:25:42.278414Z","end":"2026-09-29T05:25:42.435127Z","steps":["trace[613451263] 'process raft request' (duration: 156.589313ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:25:59.54656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.968201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xjfpq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-29T05:25:59.546673Z","caller":"traceutil/trace.go:171","msg":"trace[1736877786] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xjfpq; range_end:; response_count:1; response_revision:623; }","duration":"108.251868ms","start":"2026-09-29T05:25:59.4384Z","end":"2026-09-29T05:25:59.546652Z","steps":["trace[1736877786] 'range keys from in-memory index tree' (duration: 107.727504ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:25:59.89744Z","caller":"traceutil/trace.go:171","msg":"trace[652127488] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"208.017366ms","start":"2026-09-29T05:25:59.689395Z","end":"2026-09-29T05:25:59.897413Z","steps":["trace[652127488] 'process raft request' (duration: 206.649173ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:26:00.455482Z","caller":"traceutil/trace.go:171","msg":"trace[1309823493] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"283.083312ms","start":"2026-09-29T05:26:00.172367Z","end":"2026-09-29T05:26:00.45545Z","steps":["trace[1309823493] 'process raft request' (duration: 256.8082ms)","trace[1309823493] 'compare' (duration: 25.663007ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:26:00.456042Z","caller":"traceutil/trace.go:171","msg":"trace[1566302087] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"112.559022ms","start":"2026-09-29T05:26:00.343458Z","end":"2026-09-29T05:26:00.456017Z","steps":["trace[1566302087] 'process raft request' (duration: 111.878316ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:26:17.583084Z","caller":"traceutil/trace.go:171","msg":"trace[1995906802] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"154.465417ms","start":"2026-09-29T05:26:17.42859Z","end":"2026-09-29T05:26:17.583056Z","steps":["trace[1995906802] 'process raft request' (duration: 154.229572ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:26:46.925725Z","caller":"traceutil/trace.go:171","msg":"trace[266673453] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1238; }","duration":"176.754303ms","start":"2026-09-29T05:26:46.74895Z","end":"2026-09-29T05:26:46.925704Z","steps":["trace[266673453] 'read index received' (duration: 176.485115ms)","trace[266673453] 'applied index is now lower than readState.Index' (duration: 268.068µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:26:46.925832Z","caller":"traceutil/trace.go:171","msg":"trace[244737018] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"230.042275ms","start":"2026-09-29T05:26:46.695759Z","end":"2026-09-29T05:26:46.925801Z","steps":["trace[244737018] 'process raft request' (duration: 229.806109ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:26:46.925921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.954297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-29T05:26:46.925957Z","caller":"traceutil/trace.go:171","msg":"trace[394107532] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1201; }","duration":"177.04154ms","start":"2026-09-29T05:26:46.748904Z","end":"2026-09-29T05:26:46.925945Z","steps":["trace[394107532] 'agreement among raft nodes before linearized reading' (duration: 176.891746ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:27:32.136619Z","caller":"traceutil/trace.go:171","msg":"trace[1385684909] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1933; }","duration":"200.649846ms","start":"2026-09-29T05:27:31.935937Z","end":"2026-09-29T05:27:32.136587Z","steps":["trace[1385684909] 'read index received' (duration: 200.334908ms)","trace[1385684909] 'applied index is now lower than readState.Index' (duration: 313.338µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:27:32.13675Z","caller":"traceutil/trace.go:171","msg":"trace[1945477330] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"219.258131ms","start":"2026-09-29T05:27:31.917463Z","end":"2026-09-29T05:27:32.136722Z","steps":["trace[1945477330] 'process raft request' (duration: 218.905173ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:27:32.136836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.888641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-29T05:27:32.137092Z","caller":"traceutil/trace.go:171","msg":"trace[89533829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1859; }","duration":"201.180689ms","start":"2026-09-29T05:27:31.935889Z","end":"2026-09-29T05:27:32.13707Z","steps":["trace[89533829] 'agreement among raft nodes before linearized reading' (duration: 200.82662ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:28:15.541132Z","caller":"traceutil/trace.go:171","msg":"trace[1430781952] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"116.320194ms","start":"2026-09-29T05:28:15.424755Z","end":"2026-09-29T05:28:15.541075Z","steps":["trace[1430781952] 'process raft request' (duration: 46.771484ms)","trace[1430781952] 'compare' (duration: 69.419687ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:28:15.612901Z","caller":"traceutil/trace.go:171","msg":"trace[1742774747] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"117.649887ms","start":"2026-09-29T05:28:15.495231Z","end":"2026-09-29T05:28:15.612881Z","steps":["trace[1742774747] 'process raft request' (duration: 117.559265ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:28:15.662727Z","caller":"traceutil/trace.go:171","msg":"trace[476544241] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"165.962497ms","start":"2026-09-29T05:28:15.496742Z","end":"2026-09-29T05:28:15.662704Z","steps":["trace[476544241] 'process raft request' (duration: 165.161488ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:28:21.598764Z","caller":"traceutil/trace.go:171","msg":"trace[267837577] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"130.213394ms","start":"2026-09-29T05:28:21.468506Z","end":"2026-09-29T05:28:21.598719Z","steps":["trace[267837577] 'process raft request' (duration: 112.8648ms)","trace[267837577] 'compare' (duration: 17.130109ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:28:21.799055Z","caller":"traceutil/trace.go:171","msg":"trace[1505597129] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"164.359738ms","start":"2026-09-29T05:28:21.634667Z","end":"2026-09-29T05:28:21.799027Z","steps":["trace[1505597129] 'process raft request' (duration: 162.089563ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:28:21.80295Z","caller":"traceutil/trace.go:171","msg":"trace[1469428946] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"118.459617ms","start":"2026-09-29T05:28:21.684464Z","end":"2026-09-29T05:28:21.802923Z","steps":["trace[1469428946] 'process raft request' (duration: 118.355355ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:29:09.456866Z","caller":"traceutil/trace.go:171","msg":"trace[1348312287] linearizableReadLoop","detail":"{readStateIndex:2587; appliedIndex:2586; }","duration":"103.537952ms","start":"2026-09-29T05:29:09.353267Z","end":"2026-09-29T05:29:09.456805Z","steps":["trace[1348312287] 'read index received' (duration: 102.636049ms)","trace[1348312287] 'applied index is now lower than readState.Index' (duration: 900.583µs)"],"step_count":2} {"level":"warn","ts":"2026-09-29T05:29:09.457481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.134027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-29T05:29:09.457578Z","caller":"traceutil/trace.go:171","msg":"trace[1914604055] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2490; }","duration":"104.367392ms","start":"2026-09-29T05:29:09.353174Z","end":"2026-09-29T05:29:09.457542Z","steps":["trace[1914604055] 'agreement among raft nodes before linearized reading' (duration: 103.919121ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:29:09.458224Z","caller":"traceutil/trace.go:171","msg":"trace[1907926699] transaction","detail":"{read_only:false; response_revision:2490; number_of_response:1; }","duration":"105.805808ms","start":"2026-09-29T05:29:09.352369Z","end":"2026-09-29T05:29:09.458175Z","steps":["trace[1907926699] 'process raft request' (duration: 103.825599ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:29:10.237422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.249764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T05:29:10.237508Z","caller":"traceutil/trace.go:171","msg":"trace[773488764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2494; }","duration":"132.420438ms","start":"2026-09-29T05:29:10.105065Z","end":"2026-09-29T05:29:10.237485Z","steps":["trace[773488764] 'range keys from in-memory index tree' (duration: 132.156752ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:29:44.817605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.296277ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-09-29T05:33:04.137138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.759168ms","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-09-29T05:33:04.137345Z","caller":"traceutil/trace.go:171","msg":"trace[187354585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3909; }","duration":"192.149758ms","start":"2026-09-29T05:33:03.945176Z","end":"2026-09-29T05:33:04.137326Z","steps":["trace[187354585] 'range keys from in-memory index tree' (duration: 191.506761ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:34:29.609445Z","caller":"traceutil/trace.go:171","msg":"trace[412040021] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"118.090441ms","start":"2026-09-29T05:34:29.491322Z","end":"2026-09-29T05:34:29.609413Z","steps":["trace[412040021] 'process raft request' (duration: 57.548927ms)","trace[412040021] 'compare' (duration: 60.36192ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:34:29.609947Z","caller":"traceutil/trace.go:171","msg":"trace[1554900159] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4857; }","duration":"117.611539ms","start":"2026-09-29T05:34:29.492309Z","end":"2026-09-29T05:34:29.60992Z","steps":["trace[1554900159] 'process raft request' (duration: 117.539947ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:34:34.032582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.043417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-405c6bc9-7a3e-4874-a893-9ad37df2dc5f\" ","response":"range_response_count:1 size:4077"} {"level":"info","ts":"2026-09-29T05:34:34.032728Z","caller":"traceutil/trace.go:171","msg":"trace[2036218767] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-405c6bc9-7a3e-4874-a893-9ad37df2dc5f; range_end:; response_count:1; response_revision:5065; }","duration":"129.263892ms","start":"2026-09-29T05:34:33.903439Z","end":"2026-09-29T05:34:34.032703Z","steps":["trace[2036218767] 'range keys from in-memory index tree' (duration: 128.798591ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:34:34.148216Z","caller":"traceutil/trace.go:171","msg":"trace[985211505] transaction","detail":"{read_only:false; response_revision:5067; number_of_response:1; }","duration":"100.3168ms","start":"2026-09-29T05:34:34.047872Z","end":"2026-09-29T05:34:34.148189Z","steps":["trace[985211505] 'process raft request' (duration: 100.075723ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:34:48.367442Z","caller":"traceutil/trace.go:171","msg":"trace[773932957] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"194.244502ms","start":"2026-09-29T05:34:48.173145Z","end":"2026-09-29T05:34:48.36739Z","steps":["trace[773932957] 'process raft request' (duration: 193.953665ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:34:48.368336Z","caller":"traceutil/trace.go:171","msg":"trace[1861265541] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"191.557444ms","start":"2026-09-29T05:34:48.176745Z","end":"2026-09-29T05:34:48.368303Z","steps":["trace[1861265541] 'process raft request' (duration: 191.327758ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:34:48.368314Z","caller":"traceutil/trace.go:171","msg":"trace[1181253559] linearizableReadLoop","detail":"{readStateIndex:5518; appliedIndex:5516; }","duration":"131.337846ms","start":"2026-09-29T05:34:48.236914Z","end":"2026-09-29T05:34:48.368252Z","steps":["trace[1181253559] 'read index received' (duration: 130.308089ms)","trace[1181253559] 'applied index is now lower than readState.Index' (duration: 1.028277ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T05:34:48.368553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.617604ms","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:1935"} {"level":"info","ts":"2026-09-29T05:34:48.368623Z","caller":"traceutil/trace.go:171","msg":"trace[1783808725] 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:5314; }","duration":"131.711076ms","start":"2026-09-29T05:34:48.236893Z","end":"2026-09-29T05:34:48.368604Z","steps":["trace[1783808725] 'agreement among raft nodes before linearized reading' (duration: 131.493561ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:35:13.81895Z","caller":"traceutil/trace.go:171","msg":"trace[1660486706] transaction","detail":"{read_only:false; response_revision:5705; number_of_response:1; }","duration":"106.918972ms","start":"2026-09-29T05:35:13.712004Z","end":"2026-09-29T05:35:13.818923Z","steps":["trace[1660486706] 'process raft request' (duration: 106.710426ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:35:15.861485Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2846} {"level":"info","ts":"2026-09-29T05:35:15.940797Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2846,"took":"77.806634ms","hash":218781695,"current-db-size-bytes":56262656,"current-db-size":"56 MB","current-db-size-in-use-bytes":31358976,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-29T05:35:15.940863Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":218781695,"revision":2846,"compact-revision":-1} {"level":"info","ts":"2026-09-29T05:40:15.8698Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5721} {"level":"info","ts":"2026-09-29T05:40:15.9593Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5721,"took":"86.853915ms","hash":3159537259,"current-db-size-bytes":56262656,"current-db-size":"56 MB","current-db-size-in-use-bytes":24944640,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-09-29T05:40:15.959391Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3159537259,"revision":5721,"compact-revision":2846} {"level":"info","ts":"2026-09-29T05:41:26.234692Z","caller":"traceutil/trace.go:171","msg":"trace[1909360887] transaction","detail":"{read_only:false; response_revision:8486; number_of_response:1; }","duration":"233.243316ms","start":"2026-09-29T05:41:26.001429Z","end":"2026-09-29T05:41:26.234672Z","steps":["trace[1909360887] 'process raft request' (duration: 233.108392ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:41:26.243456Z","caller":"traceutil/trace.go:171","msg":"trace[326509773] linearizableReadLoop","detail":"{readStateIndex:8793; appliedIndex:8791; }","duration":"138.429144ms","start":"2026-09-29T05:41:26.105001Z","end":"2026-09-29T05:41:26.24343Z","steps":["trace[326509773] 'read index received' (duration: 129.541564ms)","trace[326509773] 'applied index is now lower than readState.Index' (duration: 8.88611ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:41:26.243538Z","caller":"traceutil/trace.go:171","msg":"trace[1419201401] transaction","detail":"{read_only:false; response_revision:8487; number_of_response:1; }","duration":"238.527112ms","start":"2026-09-29T05:41:26.004977Z","end":"2026-09-29T05:41:26.243504Z","steps":["trace[1419201401] 'process raft request' (duration: 238.324187ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:41:26.243628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.60903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T05:41:26.243678Z","caller":"traceutil/trace.go:171","msg":"trace[1644098313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8487; }","duration":"138.696991ms","start":"2026-09-29T05:41:26.104967Z","end":"2026-09-29T05:41:26.243664Z","steps":["trace[1644098313] 'agreement among raft nodes before linearized reading' (duration: 138.589089ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:41:26.996969Z","caller":"traceutil/trace.go:171","msg":"trace[1568031814] linearizableReadLoop","detail":"{readStateIndex:8795; appliedIndex:8794; }","duration":"196.395899ms","start":"2026-09-29T05:41:26.800551Z","end":"2026-09-29T05:41:26.996947Z","steps":["trace[1568031814] 'read index received' (duration: 196.320987ms)","trace[1568031814] 'applied index is now lower than readState.Index' (duration: 73.482µs)"],"step_count":2} {"level":"warn","ts":"2026-09-29T05:41:26.997438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.865512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T05:41:26.997488Z","caller":"traceutil/trace.go:171","msg":"trace[403491045] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8489; }","duration":"196.979844ms","start":"2026-09-29T05:41:26.800494Z","end":"2026-09-29T05:41:26.997474Z","steps":["trace[403491045] 'agreement among raft nodes before linearized reading' (duration: 196.880942ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:41:26.997479Z","caller":"traceutil/trace.go:171","msg":"trace[1688774869] transaction","detail":"{read_only:false; response_revision:8489; number_of_response:1; }","duration":"206.998084ms","start":"2026-09-29T05:41:26.790171Z","end":"2026-09-29T05:41:26.997169Z","steps":["trace[1688774869] 'process raft request' (duration: 206.615955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:41:27.018313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.433857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T05:41:27.018369Z","caller":"traceutil/trace.go:171","msg":"trace[340067894] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8490; }","duration":"152.5166ms","start":"2026-09-29T05:41:26.865841Z","end":"2026-09-29T05:41:27.018357Z","steps":["trace[340067894] 'agreement among raft nodes before linearized reading' (duration: 152.424818ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:41:27.018382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.54122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T05:41:27.018435Z","caller":"traceutil/trace.go:171","msg":"trace[545278408] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8490; }","duration":"152.590721ms","start":"2026-09-29T05:41:26.86582Z","end":"2026-09-29T05:41:27.018411Z","steps":["trace[545278408] 'agreement among raft nodes before linearized reading' (duration: 152.53302ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:41:27.018592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.791927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T05:41:27.018632Z","caller":"traceutil/trace.go:171","msg":"trace[632477276] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8490; }","duration":"152.88817ms","start":"2026-09-29T05:41:26.865733Z","end":"2026-09-29T05:41:27.018621Z","steps":["trace[632477276] 'agreement among raft nodes before linearized reading' (duration: 152.820597ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:41:27.018835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.753532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T05:41:27.01887Z","caller":"traceutil/trace.go:171","msg":"trace[1336093822] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8490; }","duration":"215.811663ms","start":"2026-09-29T05:41:26.803048Z","end":"2026-09-29T05:41:27.01886Z","steps":["trace[1336093822] 'agreement among raft nodes before linearized reading' (duration: 215.750391ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:41:27.019021Z","caller":"traceutil/trace.go:171","msg":"trace[499082862] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"133.313112ms","start":"2026-09-29T05:41:26.885648Z","end":"2026-09-29T05:41:27.018961Z","steps":["trace[499082862] 'process raft request' (duration: 132.309815ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T05:41:27.018296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.548117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T05:41:27.019216Z","caller":"traceutil/trace.go:171","msg":"trace[773515467] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8490; }","duration":"218.555654ms","start":"2026-09-29T05:41:26.800625Z","end":"2026-09-29T05:41:27.019181Z","steps":["trace[773515467] 'agreement among raft nodes before linearized reading' (duration: 217.513746ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:41:57.5323Z","caller":"traceutil/trace.go:171","msg":"trace[340861786] transaction","detail":"{read_only:false; response_revision:8708; number_of_response:1; }","duration":"102.45522ms","start":"2026-09-29T05:41:57.429819Z","end":"2026-09-29T05:41:57.532274Z","steps":["trace[340861786] 'process raft request' (duration: 102.282366ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:42:11.454873Z","caller":"traceutil/trace.go:171","msg":"trace[1122719386] transaction","detail":"{read_only:false; response_revision:8821; number_of_response:1; }","duration":"113.923078ms","start":"2026-09-29T05:42:11.340911Z","end":"2026-09-29T05:42:11.454834Z","steps":["trace[1122719386] 'process raft request' (duration: 113.63941ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:42:13.049575Z","caller":"traceutil/trace.go:171","msg":"trace[1068730973] transaction","detail":"{read_only:false; response_revision:8836; number_of_response:1; }","duration":"129.647036ms","start":"2026-09-29T05:42:12.91989Z","end":"2026-09-29T05:42:13.049537Z","steps":["trace[1068730973] 'process raft request' (duration: 129.42185ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:42:32.636827Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024ab.wal"} {"level":"info","ts":"2026-09-29T05:43:28.153604Z","caller":"traceutil/trace.go:171","msg":"trace[1308736032] linearizableReadLoop","detail":"{readStateIndex:9847; appliedIndex:9846; }","duration":"201.199874ms","start":"2026-09-29T05:43:27.952366Z","end":"2026-09-29T05:43:28.153566Z","steps":["trace[1308736032] 'read index received' (duration: 165.929848ms)","trace[1308736032] 'applied index is now lower than readState.Index' (duration: 35.268286ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T05:43:28.1541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.716717ms","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-09-29T05:43:28.154188Z","caller":"traceutil/trace.go:171","msg":"trace[1871701929] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9508; }","duration":"201.83426ms","start":"2026-09-29T05:43:27.952336Z","end":"2026-09-29T05:43:28.15417Z","steps":["trace[1871701929] 'agreement among raft nodes before linearized reading' (duration: 201.588774ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:43:28.154291Z","caller":"traceutil/trace.go:171","msg":"trace[2011754214] transaction","detail":"{read_only:false; response_revision:9508; number_of_response:1; }","duration":"215.662169ms","start":"2026-09-29T05:43:27.93857Z","end":"2026-09-29T05:43:28.154232Z","steps":["trace[2011754214] 'process raft request' (duration: 179.734366ms)","trace[2011754214] 'compare' (duration: 34.977818ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:43:28.314684Z","caller":"traceutil/trace.go:171","msg":"trace[1628975090] linearizableReadLoop","detail":"{readStateIndex:9849; appliedIndex:9847; }","duration":"128.729322ms","start":"2026-09-29T05:43:28.185926Z","end":"2026-09-29T05:43:28.314655Z","steps":["trace[1628975090] 'read index received' (duration: 30.394029ms)","trace[1628975090] 'applied index is now lower than readState.Index' (duration: 98.333222ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:43:28.3147Z","caller":"traceutil/trace.go:171","msg":"trace[1041293564] transaction","detail":"{read_only:false; response_revision:9510; number_of_response:1; }","duration":"154.162832ms","start":"2026-09-29T05:43:28.160508Z","end":"2026-09-29T05:43:28.314671Z","steps":["trace[1041293564] 'process raft request' (duration: 116.059663ms)","trace[1041293564] 'compare' (duration: 37.830782ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T05:43:28.314882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.894957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-29T05:43:28.315001Z","caller":"traceutil/trace.go:171","msg":"trace[1826852880] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:9510; }","duration":"129.101162ms","start":"2026-09-29T05:43:28.185869Z","end":"2026-09-29T05:43:28.31497Z","steps":["trace[1826852880] 'agreement among raft nodes before linearized reading' (duration: 128.897086ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:43:40.003884Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6814e3e3d6b4d713","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-29T05:43:40.011433Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-29T05:43:40.011673Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-29T05:45:15.876844Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7884} {"level":"info","ts":"2026-09-29T05:45:15.951204Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7884,"took":"71.750576ms","hash":2836714180,"current-db-size-bytes":56262656,"current-db-size":"56 MB","current-db-size-in-use-bytes":28160000,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-29T05:45:15.951274Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2836714180,"revision":7884,"compact-revision":5721} {"level":"info","ts":"2026-09-29T05:50:15.89143Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10379} {"level":"info","ts":"2026-09-29T05:50:15.988259Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10379,"took":"93.537185ms","hash":637467869,"current-db-size-bytes":56262656,"current-db-size":"56 MB","current-db-size-in-use-bytes":27566080,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-29T05:50:15.988334Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":637467869,"revision":10379,"compact-revision":7884} {"level":"info","ts":"2026-09-29T05:54:06.483223Z","caller":"traceutil/trace.go:171","msg":"trace[1839019478] transaction","detail":"{read_only:false; response_revision:14204; number_of_response:1; }","duration":"169.491453ms","start":"2026-09-29T05:54:06.313702Z","end":"2026-09-29T05:54:06.483194Z","steps":["trace[1839019478] 'process raft request' (duration: 169.266897ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:54:06.503379Z","caller":"traceutil/trace.go:171","msg":"trace[656573613] transaction","detail":"{read_only:false; response_revision:14205; number_of_response:1; }","duration":"133.171822ms","start":"2026-09-29T05:54:06.370168Z","end":"2026-09-29T05:54:06.503339Z","steps":["trace[656573613] 'process raft request' (duration: 132.914785ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T05:54:24.775804Z","caller":"traceutil/trace.go:171","msg":"trace[274065284] transaction","detail":"{read_only:false; response_revision:14478; number_of_response:1; }","duration":"110.672719ms","start":"2026-09-29T05:54:24.66506Z","end":"2026-09-29T05:54:24.775732Z","steps":["trace[274065284] 'process raft request' (duration: 25.197093ms)","trace[274065284] 'compare' (duration: 85.163458ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T05:55:15.899814Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12664} {"level":"info","ts":"2026-09-29T05:55:15.991196Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12664,"took":"86.308538ms","hash":1182805168,"current-db-size-bytes":56262656,"current-db-size":"56 MB","current-db-size-in-use-bytes":29405184,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-29T05:55:15.991385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1182805168,"revision":12664,"compact-revision":10379} {"level":"info","ts":"2026-09-29T06:00:15.912331Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15102} {"level":"info","ts":"2026-09-29T06:00:16.019101Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15102,"took":"103.666457ms","hash":2962792979,"current-db-size-bytes":56262656,"current-db-size":"56 MB","current-db-size-in-use-bytes":31395840,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-29T06:00:16.019184Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2962792979,"revision":15102,"compact-revision":12664} {"level":"info","ts":"2026-09-29T06:01:32.568665Z","caller":"traceutil/trace.go:171","msg":"trace[591676942] transaction","detail":"{read_only:false; response_revision:17886; number_of_response:1; }","duration":"129.458167ms","start":"2026-09-29T06:01:32.439156Z","end":"2026-09-29T06:01:32.568614Z","steps":["trace[591676942] 'process raft request' (duration: 129.162959ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:01:33.178985Z","caller":"traceutil/trace.go:171","msg":"trace[2111008021] linearizableReadLoop","detail":"{readStateIndex:18505; appliedIndex:18504; }","duration":"375.871264ms","start":"2026-09-29T06:01:32.803076Z","end":"2026-09-29T06:01:33.178947Z","steps":["trace[2111008021] 'read index received' (duration: 375.159715ms)","trace[2111008021] 'applied index is now lower than readState.Index' (duration: 710.189µs)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:01:33.179399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.833434ms","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-09-29T06:01:33.179488Z","caller":"traceutil/trace.go:171","msg":"trace[683771710] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:17889; }","duration":"372.991209ms","start":"2026-09-29T06:01:32.806474Z","end":"2026-09-29T06:01:33.179465Z","steps":["trace[683771710] 'agreement among raft nodes before linearized reading' (duration: 372.740142ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:01:33.179496Z","caller":"traceutil/trace.go:171","msg":"trace[697425820] transaction","detail":"{read_only:false; response_revision:17889; number_of_response:1; }","duration":"457.15043ms","start":"2026-09-29T06:01:32.722323Z","end":"2026-09-29T06:01:33.179473Z","steps":["trace[697425820] 'process raft request' (duration: 456.171184ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:01:33.179398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.285795ms","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":"warn","ts":"2026-09-29T06:01:33.179533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:01:32.80644Z","time spent":"373.084211ms","remote":"127.0.0.1:57830","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":"info","ts":"2026-09-29T06:01:33.179656Z","caller":"traceutil/trace.go:171","msg":"trace[210948737] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17889; }","duration":"376.586412ms","start":"2026-09-29T06:01:32.803017Z","end":"2026-09-29T06:01:33.179603Z","steps":["trace[210948737] 'agreement among raft nodes before linearized reading' (duration: 376.133131ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:01:33.179857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:01:32.802987Z","time spent":"376.811178ms","remote":"127.0.0.1:57830","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-09-29T06:01:33.180108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:01:32.722284Z","time spent":"457.263173ms","remote":"127.0.0.1:58498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417831,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:01:33.316194Z","caller":"traceutil/trace.go:171","msg":"trace[453999978] transaction","detail":"{read_only:false; response_revision:17890; number_of_response:1; }","duration":"130.410731ms","start":"2026-09-29T06:01:33.185751Z","end":"2026-09-29T06:01:33.316162Z","steps":["trace[453999978] 'process raft request' (duration: 130.214045ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:01:33.326928Z","caller":"traceutil/trace.go:171","msg":"trace[320073601] transaction","detail":"{read_only:false; response_revision:17891; number_of_response:1; }","duration":"141.448636ms","start":"2026-09-29T06:01:33.18546Z","end":"2026-09-29T06:01:33.326909Z","steps":["trace[320073601] 'process raft request' (duration: 141.076196ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:04:04.290432Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6814e3e3d6b4d713","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-29T06:04:04.298274Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-29T06:04:04.298441Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-29T06:05:15.923905Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17338} {"level":"info","ts":"2026-09-29T06:05:16.03209Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17338,"took":"104.234832ms","hash":2834871219,"current-db-size-bytes":56262656,"current-db-size":"56 MB","current-db-size-in-use-bytes":35041280,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-09-29T06:05:16.032177Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2834871219,"revision":17338,"compact-revision":15102} {"level":"warn","ts":"2026-09-29T06:09:05.500845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.819455ms","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-09-29T06:09:05.500945Z","caller":"traceutil/trace.go:171","msg":"trace[4747136] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21678; }","duration":"129.997169ms","start":"2026-09-29T06:09:05.370924Z","end":"2026-09-29T06:09:05.500921Z","steps":["trace[4747136] 'range keys from in-memory index tree' (duration: 129.567029ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:09:21.30782Z","caller":"traceutil/trace.go:171","msg":"trace[827612213] transaction","detail":"{read_only:false; response_revision:21759; number_of_response:1; }","duration":"168.624101ms","start":"2026-09-29T06:09:21.139168Z","end":"2026-09-29T06:09:21.307792Z","steps":["trace[827612213] 'process raft request' (duration: 168.443656ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:09:22.51948Z","caller":"traceutil/trace.go:171","msg":"trace[2146115107] transaction","detail":"{read_only:false; response_revision:21764; number_of_response:1; }","duration":"341.268705ms","start":"2026-09-29T06:09:22.178174Z","end":"2026-09-29T06:09:22.519443Z","steps":["trace[2146115107] 'process raft request' (duration: 341.002708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:09:22.51975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:09:22.177797Z","time spent":"341.815921ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:09:22.537687Z","caller":"traceutil/trace.go:171","msg":"trace[33264511] linearizableReadLoop","detail":"{readStateIndex:22503; appliedIndex:22500; }","duration":"161.334733ms","start":"2026-09-29T06:09:22.376321Z","end":"2026-09-29T06:09:22.537656Z","steps":["trace[33264511] 'read index received' (duration: 142.917255ms)","trace[33264511] 'applied index is now lower than readState.Index' (duration: 18.415758ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:09:22.537717Z","caller":"traceutil/trace.go:171","msg":"trace[630209842] transaction","detail":"{read_only:false; response_revision:21765; number_of_response:1; }","duration":"280.315386ms","start":"2026-09-29T06:09:22.25737Z","end":"2026-09-29T06:09:22.537685Z","steps":["trace[630209842] 'process raft request' (duration: 278.391556ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:09:22.537832Z","caller":"traceutil/trace.go:171","msg":"trace[242143232] transaction","detail":"{read_only:false; response_revision:21766; number_of_response:1; }","duration":"279.923647ms","start":"2026-09-29T06:09:22.257872Z","end":"2026-09-29T06:09:22.537796Z","steps":["trace[242143232] 'process raft request' (duration: 279.728752ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:09:22.537958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.958116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-29T06:09:22.538008Z","caller":"traceutil/trace.go:171","msg":"trace[290760225] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:21766; }","duration":"143.089099ms","start":"2026-09-29T06:09:22.394905Z","end":"2026-09-29T06:09:22.537994Z","steps":["trace[290760225] 'agreement among raft nodes before linearized reading' (duration: 142.919824ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:09:22.538023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.692152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"} {"level":"info","ts":"2026-09-29T06:09:22.538106Z","caller":"traceutil/trace.go:171","msg":"trace[412064787] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:21766; }","duration":"161.847096ms","start":"2026-09-29T06:09:22.376243Z","end":"2026-09-29T06:09:22.53809Z","steps":["trace[412064787] 'agreement among raft nodes before linearized reading' (duration: 161.569769ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:10:15.932679Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20083} {"level":"info","ts":"2026-09-29T06:10:16.062449Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20083,"took":"125.224266ms","hash":1056537707,"current-db-size-bytes":56262656,"current-db-size":"56 MB","current-db-size-in-use-bytes":32346112,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-29T06:10:16.062521Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1056537707,"revision":20083,"compact-revision":17338} {"level":"warn","ts":"2026-09-29T06:13:16.877458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.897185ms","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-09-29T06:13:16.877562Z","caller":"traceutil/trace.go:171","msg":"trace[1480884103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24250; }","duration":"165.05294ms","start":"2026-09-29T06:13:16.712485Z","end":"2026-09-29T06:13:16.877538Z","steps":["trace[1480884103] 'range keys from in-memory index tree' (duration: 164.716401ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:13:16.877616Z","caller":"traceutil/trace.go:171","msg":"trace[1269766150] transaction","detail":"{read_only:false; response_revision:24251; number_of_response:1; }","duration":"114.488436ms","start":"2026-09-29T06:13:16.763083Z","end":"2026-09-29T06:13:16.877571Z","steps":["trace[1269766150] 'process raft request' (duration: 113.069789ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:13:16.877449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.778262ms","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:6"} {"level":"info","ts":"2026-09-29T06:13:16.877766Z","caller":"traceutil/trace.go:171","msg":"trace[1524114697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:24250; }","duration":"165.136892ms","start":"2026-09-29T06:13:16.712595Z","end":"2026-09-29T06:13:16.877732Z","steps":["trace[1524114697] 'count revisions from in-memory index tree' (duration: 164.672129ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:15:15.941754Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22362} {"level":"info","ts":"2026-09-29T06:15:16.065389Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22362,"took":"118.396858ms","hash":1558433202,"current-db-size-bytes":57106432,"current-db-size":"57 MB","current-db-size-in-use-bytes":44916736,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-09-29T06:15:16.06554Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1558433202,"revision":22362,"compact-revision":20083} {"level":"info","ts":"2026-09-29T06:15:30.794279Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000676f.wal"} {"level":"info","ts":"2026-09-29T06:16:54.325181Z","caller":"traceutil/trace.go:171","msg":"trace[243053226] linearizableReadLoop","detail":"{readStateIndex:27316; appliedIndex:27315; }","duration":"143.90325ms","start":"2026-09-29T06:16:54.181251Z","end":"2026-09-29T06:16:54.325154Z","steps":["trace[243053226] 'read index received' (duration: 143.623073ms)","trace[243053226] 'applied index is now lower than readState.Index' (duration: 279.007µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:16:54.325286Z","caller":"traceutil/trace.go:171","msg":"trace[1198885629] transaction","detail":"{read_only:false; response_revision:26446; number_of_response:1; }","duration":"162.096873ms","start":"2026-09-29T06:16:54.163128Z","end":"2026-09-29T06:16:54.325225Z","steps":["trace[1198885629] 'process raft request' (duration: 161.817626ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:54.325414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.151246ms","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-09-29T06:16:54.325457Z","caller":"traceutil/trace.go:171","msg":"trace[2083529477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26446; }","duration":"144.27766ms","start":"2026-09-29T06:16:54.181166Z","end":"2026-09-29T06:16:54.325444Z","steps":["trace[2083529477] 'agreement among raft nodes before linearized reading' (duration: 144.099015ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:16:54.721077Z","caller":"traceutil/trace.go:171","msg":"trace[1835093243] transaction","detail":"{read_only:false; response_revision:26448; number_of_response:1; }","duration":"200.239495ms","start":"2026-09-29T06:16:54.520772Z","end":"2026-09-29T06:16:54.721012Z","steps":["trace[1835093243] 'process raft request' (duration: 199.975029ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:16:54.791088Z","caller":"traceutil/trace.go:171","msg":"trace[198968326] transaction","detail":"{read_only:false; response_revision:26449; number_of_response:1; }","duration":"270.151472ms","start":"2026-09-29T06:16:54.520882Z","end":"2026-09-29T06:16:54.791033Z","steps":["trace[198968326] 'process raft request' (duration: 269.948377ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.017709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.685403ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-29T06:16:55.017842Z","caller":"traceutil/trace.go:171","msg":"trace[900740338] linearizableReadLoop","detail":"{readStateIndex:27319; appliedIndex:27317; }","duration":"464.161575ms","start":"2026-09-29T06:16:54.553663Z","end":"2026-09-29T06:16:55.017824Z","steps":["trace[900740338] 'read index received' (duration: 167.023481ms)","trace[900740338] 'applied index is now lower than readState.Index' (duration: 297.135784ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:16:55.018104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.430871ms","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-09-29T06:16:55.018142Z","caller":"traceutil/trace.go:171","msg":"trace[920509884] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26449; }","duration":"464.501634ms","start":"2026-09-29T06:16:54.553621Z","end":"2026-09-29T06:16:55.018123Z","steps":["trace[920509884] 'agreement among raft nodes before linearized reading' (duration: 464.297738ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.018174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:16:54.553606Z","time spent":"464.560236ms","remote":"127.0.0.1:57830","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-09-29T06:16:55.018199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.395273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-09-29T06:16:55.018227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.528523ms","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-09-29T06:16:55.018298Z","caller":"traceutil/trace.go:171","msg":"trace[1400884809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26449; }","duration":"185.654366ms","start":"2026-09-29T06:16:54.832629Z","end":"2026-09-29T06:16:55.018283Z","steps":["trace[1400884809] 'agreement among raft nodes before linearized reading' (duration: 185.43974ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:16:55.0183Z","caller":"traceutil/trace.go:171","msg":"trace[1242309751] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26449; }","duration":"224.550837ms","start":"2026-09-29T06:16:54.793723Z","end":"2026-09-29T06:16:55.018274Z","steps":["trace[1242309751] 'agreement among raft nodes before linearized reading' (duration: 224.25262ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:16:55.25792Z","caller":"traceutil/trace.go:171","msg":"trace[1737026227] transaction","detail":"{read_only:false; response_revision:26450; number_of_response:1; }","duration":"234.873945ms","start":"2026-09-29T06:16:55.023006Z","end":"2026-09-29T06:16:55.25788Z","steps":["trace[1737026227] 'process raft request' (duration: 234.623509ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.47899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.247257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:16:55.479265Z","caller":"traceutil/trace.go:171","msg":"trace[1297399979] linearizableReadLoop","detail":"{readStateIndex:27323; appliedIndex:27320; }","duration":"436.172648ms","start":"2026-09-29T06:16:55.043073Z","end":"2026-09-29T06:16:55.479246Z","steps":["trace[1297399979] 'read index received' (duration: 214.571608ms)","trace[1297399979] 'applied index is now lower than readState.Index' (duration: 221.5997ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:16:55.479519Z","caller":"traceutil/trace.go:171","msg":"trace[616638654] transaction","detail":"{read_only:false; response_revision:26454; number_of_response:1; }","duration":"353.375596ms","start":"2026-09-29T06:16:55.126122Z","end":"2026-09-29T06:16:55.479497Z","steps":["trace[616638654] 'process raft request' (duration: 353.076508ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.479623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:16:55.126089Z","time spent":"353.482428ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:16:55.47974Z","caller":"traceutil/trace.go:171","msg":"trace[1794580386] transaction","detail":"{read_only:false; response_revision:26453; number_of_response:1; }","duration":"363.650413ms","start":"2026-09-29T06:16:55.11608Z","end":"2026-09-29T06:16:55.479731Z","steps":["trace[1794580386] 'process raft request' (duration: 363.075958ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:16:55.479714Z","caller":"traceutil/trace.go:171","msg":"trace[1140966737] transaction","detail":"{read_only:false; response_revision:26452; number_of_response:1; }","duration":"455.917721ms","start":"2026-09-29T06:16:55.023764Z","end":"2026-09-29T06:16:55.479682Z","steps":["trace[1140966737] 'process raft request' (duration: 455.339727ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.479789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:16:55.116032Z","time spent":"363.729755ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T06:16:55.479869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:16:55.023754Z","time spent":"456.025594ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T06:16:55.479884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.841111ms","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-09-29T06:16:55.479848Z","caller":"traceutil/trace.go:171","msg":"trace[562320191] transaction","detail":"{read_only:false; response_revision:26451; number_of_response:1; }","duration":"456.492426ms","start":"2026-09-29T06:16:55.023253Z","end":"2026-09-29T06:16:55.479746Z","steps":["trace[562320191] 'process raft request' (duration: 348.364026ms)","trace[562320191] 'compare' (duration: 107.115974ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:16:55.479941Z","caller":"traceutil/trace.go:171","msg":"trace[822976808] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:26454; }","duration":"140.950203ms","start":"2026-09-29T06:16:55.338971Z","end":"2026-09-29T06:16:55.479921Z","steps":["trace[822976808] 'agreement among raft nodes before linearized reading' (duration: 140.783539ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.479951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.481712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-29T06:16:55.480009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.571851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-09-29T06:16:55.480107Z","caller":"traceutil/trace.go:171","msg":"trace[1490436252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26454; }","duration":"195.698997ms","start":"2026-09-29T06:16:55.284369Z","end":"2026-09-29T06:16:55.480068Z","steps":["trace[1490436252] 'agreement among raft nodes before linearized reading' (duration: 195.43635ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.480119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:16:55.023223Z","time spent":"456.731552ms","remote":"127.0.0.1:57830","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-09-29T06:16:55.480133Z","caller":"traceutil/trace.go:171","msg":"trace[987090844] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:26454; }","duration":"208.761546ms","start":"2026-09-29T06:16:55.271345Z","end":"2026-09-29T06:16:55.480107Z","steps":["trace[987090844] 'agreement among raft nodes before linearized reading' (duration: 208.359576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.480311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.234025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-09-29T06:16:55.48035Z","caller":"traceutil/trace.go:171","msg":"trace[385440155] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26454; }","duration":"437.321608ms","start":"2026-09-29T06:16:55.043015Z","end":"2026-09-29T06:16:55.480337Z","steps":["trace[385440155] 'agreement among raft nodes before linearized reading' (duration: 436.533018ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.480378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:16:55.043001Z","time spent":"437.370889ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-09-29T06:16:55.722435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.470046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:16:55.722617Z","caller":"traceutil/trace.go:171","msg":"trace[2007539278] transaction","detail":"{read_only:false; response_revision:26455; number_of_response:1; }","duration":"236.750535ms","start":"2026-09-29T06:16:55.48584Z","end":"2026-09-29T06:16:55.722591Z","steps":["trace[2007539278] 'process raft request' (duration: 111.974281ms)","trace[2007539278] 'compare' (duration: 124.097856ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:16:55.952043Z","caller":"traceutil/trace.go:171","msg":"trace[1543744305] linearizableReadLoop","detail":"{readStateIndex:27327; appliedIndex:27325; }","duration":"391.496567ms","start":"2026-09-29T06:16:55.560527Z","end":"2026-09-29T06:16:55.952023Z","steps":["trace[1543744305] 'read index received' (duration: 37.237748ms)","trace[1543744305] 'applied index is now lower than readState.Index' (duration: 354.257919ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:16:55.95208Z","caller":"traceutil/trace.go:171","msg":"trace[1511109773] transaction","detail":"{read_only:false; response_revision:26456; number_of_response:1; }","duration":"465.09714ms","start":"2026-09-29T06:16:55.486941Z","end":"2026-09-29T06:16:55.952038Z","steps":["trace[1511109773] 'process raft request' (duration: 464.29986ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.952166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.63241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-29T06:16:55.952205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:16:55.486927Z","time spent":"465.205023ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:16:55.952225Z","caller":"traceutil/trace.go:171","msg":"trace[398134871] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:26456; }","duration":"391.747483ms","start":"2026-09-29T06:16:55.560466Z","end":"2026-09-29T06:16:55.952214Z","steps":["trace[398134871] 'agreement among raft nodes before linearized reading' (duration: 391.65099ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:16:55.952244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:16:55.560444Z","time spent":"391.794734ms","remote":"127.0.0.1:57880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true "} {"level":"warn","ts":"2026-09-29T06:16:55.95261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.771669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-09-29T06:16:55.952637Z","caller":"traceutil/trace.go:171","msg":"trace[217134446] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26458; }","duration":"200.83888ms","start":"2026-09-29T06:16:55.751792Z","end":"2026-09-29T06:16:55.952631Z","steps":["trace[217134446] 'agreement among raft nodes before linearized reading' (duration: 200.719957ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:16:55.95264Z","caller":"traceutil/trace.go:171","msg":"trace[1694923451] transaction","detail":"{read_only:false; response_revision:26457; number_of_response:1; }","duration":"258.54969ms","start":"2026-09-29T06:16:55.694079Z","end":"2026-09-29T06:16:55.952628Z","steps":["trace[1694923451] 'process raft request' (duration: 258.356555ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:16:55.952667Z","caller":"traceutil/trace.go:171","msg":"trace[1912105212] transaction","detail":"{read_only:false; response_revision:26458; number_of_response:1; }","duration":"146.242691ms","start":"2026-09-29T06:16:55.806387Z","end":"2026-09-29T06:16:55.952629Z","steps":["trace[1912105212] 'process raft request' (duration: 146.097858ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:01.4118Z","caller":"traceutil/trace.go:171","msg":"trace[519853338] transaction","detail":"{read_only:false; response_revision:26496; number_of_response:1; }","duration":"116.513579ms","start":"2026-09-29T06:17:01.295262Z","end":"2026-09-29T06:17:01.411776Z","steps":["trace[519853338] 'process raft request' (duration: 116.348614ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:01.730458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.761332ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:17:01.730712Z","caller":"traceutil/trace.go:171","msg":"trace[546125056] linearizableReadLoop","detail":"{readStateIndex:27370; appliedIndex:27368; }","duration":"201.381835ms","start":"2026-09-29T06:17:01.529307Z","end":"2026-09-29T06:17:01.730689Z","steps":["trace[546125056] 'read index received' (duration: 56.408506ms)","trace[546125056] 'applied index is now lower than readState.Index' (duration: 144.971699ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:01.730721Z","caller":"traceutil/trace.go:171","msg":"trace[1769696570] transaction","detail":"{read_only:false; response_revision:26497; number_of_response:1; }","duration":"224.494176ms","start":"2026-09-29T06:17:01.506195Z","end":"2026-09-29T06:17:01.730689Z","steps":["trace[1769696570] 'process raft request' (duration: 79.349213ms)","trace[1769696570] 'compare' (duration: 144.602958ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:01.730826Z","caller":"traceutil/trace.go:171","msg":"trace[1740987103] transaction","detail":"{read_only:false; response_revision:26498; number_of_response:1; }","duration":"213.302376ms","start":"2026-09-29T06:17:01.517487Z","end":"2026-09-29T06:17:01.73079Z","steps":["trace[1740987103] 'process raft request' (duration: 213.108821ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:01.73099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.683533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-09-29T06:17:01.731281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.952064ms","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-09-29T06:17:01.731379Z","caller":"traceutil/trace.go:171","msg":"trace[837096228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26498; }","duration":"201.102908ms","start":"2026-09-29T06:17:01.530241Z","end":"2026-09-29T06:17:01.731344Z","steps":["trace[837096228] 'agreement among raft nodes before linearized reading' (duration: 200.769499ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:01.731442Z","caller":"traceutil/trace.go:171","msg":"trace[1295470013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26498; }","duration":"202.060433ms","start":"2026-09-29T06:17:01.529274Z","end":"2026-09-29T06:17:01.731335Z","steps":["trace[1295470013] 'agreement among raft nodes before linearized reading' (duration: 201.532899ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:02.054622Z","caller":"traceutil/trace.go:171","msg":"trace[1356398347] linearizableReadLoop","detail":"{readStateIndex:27373; appliedIndex:27372; }","duration":"216.874227ms","start":"2026-09-29T06:17:01.837719Z","end":"2026-09-29T06:17:02.054593Z","steps":["trace[1356398347] 'read index received' (duration: 195.234614ms)","trace[1356398347] 'applied index is now lower than readState.Index' (duration: 21.638443ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:02.054699Z","caller":"traceutil/trace.go:171","msg":"trace[823437735] transaction","detail":"{read_only:false; response_revision:26501; number_of_response:1; }","duration":"289.508735ms","start":"2026-09-29T06:17:01.765162Z","end":"2026-09-29T06:17:02.054671Z","steps":["trace[823437735] 'process raft request' (duration: 267.79387ms)","trace[823437735] 'compare' (duration: 20.982396ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:02.054793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.056142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:02.054831Z","caller":"traceutil/trace.go:171","msg":"trace[1648433246] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:26501; }","duration":"217.116364ms","start":"2026-09-29T06:17:01.8377Z","end":"2026-09-29T06:17:02.054817Z","steps":["trace[1648433246] 'agreement among raft nodes before linearized reading' (duration: 217.021581ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:02.384357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.669243ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:17:02.384759Z","caller":"traceutil/trace.go:171","msg":"trace[531826269] linearizableReadLoop","detail":"{readStateIndex:27376; appliedIndex:27375; }","duration":"278.846488ms","start":"2026-09-29T06:17:02.105865Z","end":"2026-09-29T06:17:02.384712Z","steps":["trace[531826269] 'read index received' (duration: 126.644242ms)","trace[531826269] 'applied index is now lower than readState.Index' (duration: 152.200376ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:02.385161Z","caller":"traceutil/trace.go:171","msg":"trace[121594367] transaction","detail":"{read_only:false; response_revision:26504; number_of_response:1; }","duration":"319.795943ms","start":"2026-09-29T06:17:02.065288Z","end":"2026-09-29T06:17:02.385083Z","steps":["trace[121594367] 'process raft request' (duration: 167.275009ms)","trace[121594367] 'compare' (duration: 151.419495ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:02.385411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:02.065257Z","time spent":"320.018628ms","remote":"127.0.0.1:57830","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-09-29T06:17:02.391942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.070927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:02.392027Z","caller":"traceutil/trace.go:171","msg":"trace[437772224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26505; }","duration":"286.20993ms","start":"2026-09-29T06:17:02.105798Z","end":"2026-09-29T06:17:02.392008Z","steps":["trace[437772224] 'agreement among raft nodes before linearized reading' (duration: 286.082187ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:02.736342Z","caller":"traceutil/trace.go:171","msg":"trace[1015364799] transaction","detail":"{read_only:false; response_revision:26506; number_of_response:1; }","duration":"300.547993ms","start":"2026-09-29T06:17:02.435751Z","end":"2026-09-29T06:17:02.736299Z","steps":["trace[1015364799] 'process raft request' (duration: 300.260134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:02.736605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:02.435732Z","time spent":"300.717088ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:17:03.041017Z","caller":"traceutil/trace.go:171","msg":"trace[872264119] linearizableReadLoop","detail":"{readStateIndex:27380; appliedIndex:27379; }","duration":"189.901985ms","start":"2026-09-29T06:17:02.851088Z","end":"2026-09-29T06:17:03.04099Z","steps":["trace[872264119] 'read index received' (duration: 118.650784ms)","trace[872264119] 'applied index is now lower than readState.Index' (duration: 71.249891ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:03.041226Z","caller":"traceutil/trace.go:171","msg":"trace[677744106] transaction","detail":"{read_only:false; response_revision:26508; number_of_response:1; }","duration":"204.67648ms","start":"2026-09-29T06:17:02.836531Z","end":"2026-09-29T06:17:03.041207Z","steps":["trace[677744106] 'process raft request' (duration: 133.273574ms)","trace[677744106] 'compare' (duration: 71.032366ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:03.041323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.436149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:03.041414Z","caller":"traceutil/trace.go:171","msg":"trace[1931436056] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:26508; }","duration":"118.594753ms","start":"2026-09-29T06:17:02.9228Z","end":"2026-09-29T06:17:03.041394Z","steps":["trace[1931436056] 'agreement among raft nodes before linearized reading' (duration: 118.446389ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:03.041661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.593334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:03.041699Z","caller":"traceutil/trace.go:171","msg":"trace[992589105] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:26508; }","duration":"190.668146ms","start":"2026-09-29T06:17:02.851021Z","end":"2026-09-29T06:17:03.041689Z","steps":["trace[992589105] 'agreement among raft nodes before linearized reading' (duration: 190.603054ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:03.33425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.201616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:17:03.334367Z","caller":"traceutil/trace.go:171","msg":"trace[1762724372] transaction","detail":"{read_only:false; response_revision:26509; number_of_response:1; }","duration":"212.37058ms","start":"2026-09-29T06:17:03.121973Z","end":"2026-09-29T06:17:03.334343Z","steps":["trace[1762724372] 'process raft request' (duration: 54.974809ms)","trace[1762724372] 'compare' (duration: 157.046122ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:03.61054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.052365ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:17:03.610655Z","caller":"traceutil/trace.go:171","msg":"trace[1813034565] linearizableReadLoop","detail":"{readStateIndex:27382; appliedIndex:27381; }","duration":"176.594251ms","start":"2026-09-29T06:17:03.434043Z","end":"2026-09-29T06:17:03.610637Z","steps":["trace[1813034565] 'read index received' (duration: 67.345511ms)","trace[1813034565] 'applied index is now lower than readState.Index' (duration: 109.24756ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:03.610742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.703493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:03.610766Z","caller":"traceutil/trace.go:171","msg":"trace[1521685146] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:26510; }","duration":"176.749955ms","start":"2026-09-29T06:17:03.434005Z","end":"2026-09-29T06:17:03.610755Z","steps":["trace[1521685146] 'agreement among raft nodes before linearized reading' (duration: 176.671093ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:03.611037Z","caller":"traceutil/trace.go:171","msg":"trace[683455985] transaction","detail":"{read_only:false; response_revision:26510; number_of_response:1; }","duration":"188.786928ms","start":"2026-09-29T06:17:03.422242Z","end":"2026-09-29T06:17:03.611029Z","steps":["trace[683455985] 'process raft request' (duration: 79.135007ms)","trace[683455985] 'compare' (duration: 108.902091ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:03.90772Z","caller":"traceutil/trace.go:171","msg":"trace[87390943] transaction","detail":"{read_only:false; response_revision:26511; number_of_response:1; }","duration":"433.310044ms","start":"2026-09-29T06:17:03.47438Z","end":"2026-09-29T06:17:03.90769Z","steps":["trace[87390943] 'process raft request' (duration: 343.741306ms)","trace[87390943] 'compare' (duration: 89.213819ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:03.908122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:03.474348Z","time spent":"433.52772ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:17:03.928092Z","caller":"traceutil/trace.go:171","msg":"trace[1495560753] linearizableReadLoop","detail":"{readStateIndex:27385; appliedIndex:27382; }","duration":"169.594759ms","start":"2026-09-29T06:17:03.758448Z","end":"2026-09-29T06:17:03.928043Z","steps":["trace[1495560753] 'read index received' (duration: 59.698392ms)","trace[1495560753] 'applied index is now lower than readState.Index' (duration: 109.895227ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:03.928183Z","caller":"traceutil/trace.go:171","msg":"trace[107994651] transaction","detail":"{read_only:false; response_revision:26513; number_of_response:1; }","duration":"189.955068ms","start":"2026-09-29T06:17:03.738179Z","end":"2026-09-29T06:17:03.928134Z","steps":["trace[107994651] 'process raft request' (duration: 189.808615ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:03.928198Z","caller":"traceutil/trace.go:171","msg":"trace[1546867058] transaction","detail":"{read_only:false; response_revision:26512; number_of_response:1; }","duration":"190.761638ms","start":"2026-09-29T06:17:03.737341Z","end":"2026-09-29T06:17:03.928103Z","steps":["trace[1546867058] 'process raft request' (duration: 190.458281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:03.928382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.916538ms","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-09-29T06:17:03.928447Z","caller":"traceutil/trace.go:171","msg":"trace[2014372553] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26513; }","duration":"170.03579ms","start":"2026-09-29T06:17:03.758396Z","end":"2026-09-29T06:17:03.928432Z","steps":["trace[2014372553] 'agreement among raft nodes before linearized reading' (duration: 169.816264ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:03.928816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.268495ms","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-09-29T06:17:03.928857Z","caller":"traceutil/trace.go:171","msg":"trace[1785901985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26513; }","duration":"168.346446ms","start":"2026-09-29T06:17:03.760497Z","end":"2026-09-29T06:17:03.928844Z","steps":["trace[1785901985] 'agreement among raft nodes before linearized reading' (duration: 168.222703ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:04.110211Z","caller":"traceutil/trace.go:171","msg":"trace[910140813] transaction","detail":"{read_only:false; response_revision:26515; number_of_response:1; }","duration":"174.816114ms","start":"2026-09-29T06:17:03.935355Z","end":"2026-09-29T06:17:04.110171Z","steps":["trace[910140813] 'process raft request' (duration: 160.049001ms)","trace[910140813] 'compare' (duration: 14.308511ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:04.40423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.933324ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:17:04.404355Z","caller":"traceutil/trace.go:171","msg":"trace[929285057] linearizableReadLoop","detail":"{readStateIndex:27388; appliedIndex:27387; }","duration":"294.28572ms","start":"2026-09-29T06:17:04.110049Z","end":"2026-09-29T06:17:04.404334Z","steps":["trace[929285057] 'read index received' (duration: 187.941415ms)","trace[929285057] 'applied index is now lower than readState.Index' (duration: 106.342785ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:04.404425Z","caller":"traceutil/trace.go:171","msg":"trace[106959231] transaction","detail":"{read_only:false; response_revision:26516; number_of_response:1; }","duration":"339.004933ms","start":"2026-09-29T06:17:04.065406Z","end":"2026-09-29T06:17:04.404411Z","steps":["trace[106959231] 'process raft request' (duration: 232.758261ms)","trace[106959231] 'compare' (duration: 105.77286ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:04.404485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:04.065386Z","time spent":"339.069604ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T06:17:04.40476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.100865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:04.404796Z","caller":"traceutil/trace.go:171","msg":"trace[326444964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26516; }","duration":"299.177457ms","start":"2026-09-29T06:17:04.105608Z","end":"2026-09-29T06:17:04.404785Z","steps":["trace[326444964] 'agreement among raft nodes before linearized reading' (duration: 299.089625ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:04.407435Z","caller":"traceutil/trace.go:171","msg":"trace[1804035031] transaction","detail":"{read_only:false; response_revision:26517; number_of_response:1; }","duration":"291.191969ms","start":"2026-09-29T06:17:04.116132Z","end":"2026-09-29T06:17:04.407324Z","steps":["trace[1804035031] 'process raft request' (duration: 291.007385ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:04.447278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.089062ms","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-09-29T06:17:04.447341Z","caller":"traceutil/trace.go:171","msg":"trace[90249908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26518; }","duration":"337.168564ms","start":"2026-09-29T06:17:04.110158Z","end":"2026-09-29T06:17:04.447327Z","steps":["trace[90249908] 'agreement among raft nodes before linearized reading' (duration: 336.965159ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:04.447366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:04.110062Z","time spent":"337.299908ms","remote":"127.0.0.1:57830","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-09-29T06:17:05.080232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.274591ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-29T06:17:05.080337Z","caller":"traceutil/trace.go:171","msg":"trace[872459699] linearizableReadLoop","detail":"{readStateIndex:27393; appliedIndex:27392; }","duration":"339.098695ms","start":"2026-09-29T06:17:04.741218Z","end":"2026-09-29T06:17:05.080317Z","steps":["trace[872459699] 'read index received' (duration: 82.722781ms)","trace[872459699] 'applied index is now lower than readState.Index' (duration: 256.374164ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:05.080494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.263649ms","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-09-29T06:17:05.080554Z","caller":"traceutil/trace.go:171","msg":"trace[2107125753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26520; }","duration":"339.330501ms","start":"2026-09-29T06:17:04.741211Z","end":"2026-09-29T06:17:05.080541Z","steps":["trace[2107125753] 'agreement among raft nodes before linearized reading' (duration: 339.151926ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:05.080585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:04.74115Z","time spent":"339.427083ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-29T06:17:05.203328Z","caller":"traceutil/trace.go:171","msg":"trace[1890454913] transaction","detail":"{read_only:false; response_revision:26521; number_of_response:1; }","duration":"377.348129ms","start":"2026-09-29T06:17:04.825953Z","end":"2026-09-29T06:17:05.203301Z","steps":["trace[1890454913] 'process raft request' (duration: 377.154624ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:05.203489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:04.825933Z","time spent":"377.471173ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:17:05.233632Z","caller":"traceutil/trace.go:171","msg":"trace[922875949] transaction","detail":"{read_only:false; response_revision:26522; number_of_response:1; }","duration":"186.325234ms","start":"2026-09-29T06:17:05.047284Z","end":"2026-09-29T06:17:05.233609Z","steps":["trace[922875949] 'process raft request' (duration: 186.107519ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:05.233788Z","caller":"traceutil/trace.go:171","msg":"trace[767606194] transaction","detail":"{read_only:false; response_revision:26523; number_of_response:1; }","duration":"147.990807ms","start":"2026-09-29T06:17:05.085774Z","end":"2026-09-29T06:17:05.233765Z","steps":["trace[767606194] 'process raft request' (duration: 147.792052ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:05.474488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.25372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:05.474558Z","caller":"traceutil/trace.go:171","msg":"trace[1920818794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26523; }","duration":"189.378053ms","start":"2026-09-29T06:17:05.285163Z","end":"2026-09-29T06:17:05.474542Z","steps":["trace[1920818794] 'range keys from in-memory index tree' (duration: 189.115947ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:05.735674Z","caller":"traceutil/trace.go:171","msg":"trace[401155816] transaction","detail":"{read_only:false; response_revision:26524; number_of_response:1; }","duration":"116.480517ms","start":"2026-09-29T06:17:05.619173Z","end":"2026-09-29T06:17:05.735653Z","steps":["trace[401155816] 'process raft request' (duration: 116.264902ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:16.793824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.934131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:16.793899Z","caller":"traceutil/trace.go:171","msg":"trace[590427790] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26670; }","duration":"152.016223ms","start":"2026-09-29T06:17:16.641869Z","end":"2026-09-29T06:17:16.793885Z","steps":["trace[590427790] 'range keys from in-memory index tree' (duration: 151.837208ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:17.355555Z","caller":"traceutil/trace.go:171","msg":"trace[987312651] transaction","detail":"{read_only:false; response_revision:26671; number_of_response:1; }","duration":"110.724197ms","start":"2026-09-29T06:17:17.244797Z","end":"2026-09-29T06:17:17.355521Z","steps":["trace[987312651] 'process raft request' (duration: 110.503872ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:17.640001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.714496ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:17:17.64023Z","caller":"traceutil/trace.go:171","msg":"trace[926009763] linearizableReadLoop","detail":"{readStateIndex:27548; appliedIndex:27546; }","duration":"334.170417ms","start":"2026-09-29T06:17:17.306041Z","end":"2026-09-29T06:17:17.640211Z","steps":["trace[926009763] 'read index received' (duration: 49.347923ms)","trace[926009763] 'applied index is now lower than readState.Index' (duration: 284.821174ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:17.640452Z","caller":"traceutil/trace.go:171","msg":"trace[422574074] transaction","detail":"{read_only:false; response_revision:26672; number_of_response:1; }","duration":"358.664524ms","start":"2026-09-29T06:17:17.281727Z","end":"2026-09-29T06:17:17.640392Z","steps":["trace[422574074] 'process raft request' (duration: 134.458026ms)","trace[422574074] 'compare' (duration: 223.571151ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:17.640593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.03778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-363338db-d67b-4257-b678-43fb6ae0313b\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-09-29T06:17:17.64067Z","caller":"traceutil/trace.go:171","msg":"trace[530315498] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-363338db-d67b-4257-b678-43fb6ae0313b; range_end:; response_count:1; response_revision:26672; }","duration":"270.226805ms","start":"2026-09-29T06:17:17.370426Z","end":"2026-09-29T06:17:17.640652Z","steps":["trace[530315498] 'agreement among raft nodes before linearized reading' (duration: 270.049251ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:17.640576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.201981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-363338db-d67b-4257-b678-43fb6ae0313b\" ","response":"range_response_count:1 size:3644"} {"level":"warn","ts":"2026-09-29T06:17:17.640776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:17.281692Z","time spent":"358.869618ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:17:17.640799Z","caller":"traceutil/trace.go:171","msg":"trace[2028109346] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-363338db-d67b-4257-b678-43fb6ae0313b; range_end:; response_count:1; response_revision:26672; }","duration":"111.492499ms","start":"2026-09-29T06:17:17.529287Z","end":"2026-09-29T06:17:17.64078Z","steps":["trace[2028109346] 'agreement among raft nodes before linearized reading' (duration: 111.131879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:17.640608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.565408ms","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-09-29T06:17:17.640994Z","caller":"traceutil/trace.go:171","msg":"trace[324341026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26672; }","duration":"334.951388ms","start":"2026-09-29T06:17:17.305996Z","end":"2026-09-29T06:17:17.640948Z","steps":["trace[324341026] 'agreement among raft nodes before linearized reading' (duration: 334.382103ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:17.641172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:17.30598Z","time spent":"335.111452ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-29T06:17:17.947397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.684944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:17:17.947508Z","caller":"traceutil/trace.go:171","msg":"trace[856357045] linearizableReadLoop","detail":"{readStateIndex:27550; appliedIndex:27549; }","duration":"139.873155ms","start":"2026-09-29T06:17:17.807617Z","end":"2026-09-29T06:17:17.94749Z","steps":["trace[856357045] 'read index received' (duration: 6.041946ms)","trace[856357045] 'applied index is now lower than readState.Index' (duration: 133.829789ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:17.947669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.05023ms","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-09-29T06:17:17.947703Z","caller":"traceutil/trace.go:171","msg":"trace[17987233] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26674; }","duration":"140.132514ms","start":"2026-09-29T06:17:17.807561Z","end":"2026-09-29T06:17:17.947694Z","steps":["trace[17987233] 'agreement among raft nodes before linearized reading' (duration: 139.975129ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:17.947739Z","caller":"traceutil/trace.go:171","msg":"trace[661438991] transaction","detail":"{read_only:false; response_revision:26674; number_of_response:1; }","duration":"297.76412ms","start":"2026-09-29T06:17:17.649942Z","end":"2026-09-29T06:17:17.947706Z","steps":["trace[661438991] 'process raft request' (duration: 163.653314ms)","trace[661438991] 'compare' (duration: 133.284304ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:18.123254Z","caller":"traceutil/trace.go:171","msg":"trace[1439232204] transaction","detail":"{read_only:false; response_revision:26675; number_of_response:1; }","duration":"169.634319ms","start":"2026-09-29T06:17:17.953565Z","end":"2026-09-29T06:17:18.1232Z","steps":["trace[1439232204] 'process raft request' (duration: 155.393788ms)","trace[1439232204] 'compare' (duration: 13.978224ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:18.154973Z","caller":"traceutil/trace.go:171","msg":"trace[1797032157] transaction","detail":"{read_only:false; response_revision:26676; number_of_response:1; }","duration":"169.472295ms","start":"2026-09-29T06:17:17.985463Z","end":"2026-09-29T06:17:18.154935Z","steps":["trace[1797032157] 'process raft request' (duration: 169.185538ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:18.155221Z","caller":"traceutil/trace.go:171","msg":"trace[352621624] linearizableReadLoop","detail":"{readStateIndex:27553; appliedIndex:27550; }","duration":"141.063848ms","start":"2026-09-29T06:17:18.014126Z","end":"2026-09-29T06:17:18.15519Z","steps":["trace[352621624] 'read index received' (duration: 95.053091ms)","trace[352621624] 'applied index is now lower than readState.Index' (duration: 46.008856ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:18.155389Z","caller":"traceutil/trace.go:171","msg":"trace[1597721957] transaction","detail":"{read_only:false; response_revision:26677; number_of_response:1; }","duration":"168.999464ms","start":"2026-09-29T06:17:17.986351Z","end":"2026-09-29T06:17:18.15535Z","steps":["trace[1597721957] 'process raft request' (duration: 168.49442ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:18.155506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.375646ms","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-09-29T06:17:18.155555Z","caller":"traceutil/trace.go:171","msg":"trace[1805616155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26677; }","duration":"141.442867ms","start":"2026-09-29T06:17:18.014097Z","end":"2026-09-29T06:17:18.155539Z","steps":["trace[1805616155] 'agreement among raft nodes before linearized reading' (duration: 141.200691ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:18.846048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.331552ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:17:18.846215Z","caller":"traceutil/trace.go:171","msg":"trace[1024217608] transaction","detail":"{read_only:false; response_revision:26681; number_of_response:1; }","duration":"357.692157ms","start":"2026-09-29T06:17:18.488495Z","end":"2026-09-29T06:17:18.846187Z","steps":["trace[1024217608] 'process raft request' (duration: 103.114039ms)","trace[1024217608] 'compare' (duration: 253.961142ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:18.84628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:18.48847Z","time spent":"357.77717ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:17:18.895746Z","caller":"traceutil/trace.go:171","msg":"trace[2055726950] linearizableReadLoop","detail":"{readStateIndex:27558; appliedIndex:27556; }","duration":"333.9491ms","start":"2026-09-29T06:17:18.561762Z","end":"2026-09-29T06:17:18.895711Z","steps":["trace[2055726950] 'read index received' (duration: 29.859755ms)","trace[2055726950] 'applied index is now lower than readState.Index' (duration: 304.087345ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:18.895881Z","caller":"traceutil/trace.go:171","msg":"trace[1149073079] transaction","detail":"{read_only:false; response_revision:26682; number_of_response:1; }","duration":"395.113161ms","start":"2026-09-29T06:17:18.500723Z","end":"2026-09-29T06:17:18.895837Z","steps":["trace[1149073079] 'process raft request' (duration: 394.782292ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:18.896096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:18.500709Z","time spent":"395.272354ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T06:17:18.896189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.409173ms","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-09-29T06:17:18.896245Z","caller":"traceutil/trace.go:171","msg":"trace[1342736002] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:26682; }","duration":"329.536147ms","start":"2026-09-29T06:17:18.56669Z","end":"2026-09-29T06:17:18.896226Z","steps":["trace[1342736002] 'agreement among raft nodes before linearized reading' (duration: 329.254349ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:18.896224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.585947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-363338db-d67b-4257-b678-43fb6ae0313b\" ","response":"range_response_count:1 size:3764"} {"level":"warn","ts":"2026-09-29T06:17:18.896229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.874483ms","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-09-29T06:17:18.8963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:18.566674Z","time spent":"329.614998ms","remote":"127.0.0.1:57830","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":"info","ts":"2026-09-29T06:17:18.896317Z","caller":"traceutil/trace.go:171","msg":"trace[295874535] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-363338db-d67b-4257-b678-43fb6ae0313b; range_end:; response_count:1; response_revision:26682; }","duration":"249.728451ms","start":"2026-09-29T06:17:18.646566Z","end":"2026-09-29T06:17:18.896295Z","steps":["trace[295874535] 'agreement among raft nodes before linearized reading' (duration: 249.427134ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:18.896336Z","caller":"traceutil/trace.go:171","msg":"trace[1805342544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26682; }","duration":"293.022336ms","start":"2026-09-29T06:17:18.603293Z","end":"2026-09-29T06:17:18.896316Z","steps":["trace[1805342544] 'agreement among raft nodes before linearized reading' (duration: 292.693487ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:18.89673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.957656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:18.896777Z","caller":"traceutil/trace.go:171","msg":"trace[826111662] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:26682; }","duration":"335.038058ms","start":"2026-09-29T06:17:18.561727Z","end":"2026-09-29T06:17:18.896765Z","steps":["trace[826111662] 'agreement among raft nodes before linearized reading' (duration: 334.123885ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:18.896807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:18.561714Z","time spent":"335.083159ms","remote":"127.0.0.1:56304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-09-29T06:17:19.157712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.119319ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:17:19.157866Z","caller":"traceutil/trace.go:171","msg":"trace[581562432] transaction","detail":"{read_only:false; response_revision:26683; number_of_response:1; }","duration":"255.649196ms","start":"2026-09-29T06:17:18.902183Z","end":"2026-09-29T06:17:19.157833Z","steps":["trace[581562432] 'process raft request' (duration: 149.003753ms)","trace[581562432] 'compare' (duration: 105.600566ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:19.197525Z","caller":"traceutil/trace.go:171","msg":"trace[1409935159] transaction","detail":"{read_only:false; response_revision:26684; number_of_response:1; }","duration":"294.596418ms","start":"2026-09-29T06:17:18.902904Z","end":"2026-09-29T06:17:19.197501Z","steps":["trace[1409935159] 'process raft request' (duration: 294.380893ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:19.197664Z","caller":"traceutil/trace.go:171","msg":"trace[1217280312] linearizableReadLoop","detail":"{readStateIndex:27561; appliedIndex:27558; }","duration":"237.378911ms","start":"2026-09-29T06:17:18.960259Z","end":"2026-09-29T06:17:19.197638Z","steps":["trace[1217280312] 'read index received' (duration: 90.946784ms)","trace[1217280312] 'applied index is now lower than readState.Index' (duration: 146.429067ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:19.197694Z","caller":"traceutil/trace.go:171","msg":"trace[915096425] transaction","detail":"{read_only:false; response_revision:26685; number_of_response:1; }","duration":"251.833147ms","start":"2026-09-29T06:17:18.945835Z","end":"2026-09-29T06:17:19.197668Z","steps":["trace[915096425] 'process raft request' (duration: 251.57095ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:19.197882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.608896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-29T06:17:19.197989Z","caller":"traceutil/trace.go:171","msg":"trace[950204178] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:26685; }","duration":"237.795121ms","start":"2026-09-29T06:17:18.960175Z","end":"2026-09-29T06:17:19.19797Z","steps":["trace[950204178] 'agreement among raft nodes before linearized reading' (duration: 237.569446ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:19.472341Z","caller":"traceutil/trace.go:171","msg":"trace[1049968282] transaction","detail":"{read_only:false; response_revision:26686; number_of_response:1; }","duration":"110.662497ms","start":"2026-09-29T06:17:19.36165Z","end":"2026-09-29T06:17:19.472313Z","steps":["trace[1049968282] 'process raft request' (duration: 108.681365ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:19.744403Z","caller":"traceutil/trace.go:171","msg":"trace[1681769815] linearizableReadLoop","detail":"{readStateIndex:27564; appliedIndex:27563; }","duration":"125.78105ms","start":"2026-09-29T06:17:19.61859Z","end":"2026-09-29T06:17:19.744371Z","steps":["trace[1681769815] 'read index received' (duration: 83.241764ms)","trace[1681769815] 'applied index is now lower than readState.Index' (duration: 42.537716ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:19.744427Z","caller":"traceutil/trace.go:171","msg":"trace[193401013] transaction","detail":"{read_only:false; response_revision:26687; number_of_response:1; }","duration":"198.422228ms","start":"2026-09-29T06:17:19.545964Z","end":"2026-09-29T06:17:19.744386Z","steps":["trace[193401013] 'process raft request' (duration: 155.842922ms)","trace[193401013] 'compare' (duration: 42.265618ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:19.74466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.034646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-29T06:17:19.744765Z","caller":"traceutil/trace.go:171","msg":"trace[338094033] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:26687; }","duration":"126.159949ms","start":"2026-09-29T06:17:19.618582Z","end":"2026-09-29T06:17:19.744742Z","steps":["trace[338094033] 'agreement among raft nodes before linearized reading' (duration: 125.901392ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:19.814552Z","caller":"traceutil/trace.go:171","msg":"trace[1833640222] transaction","detail":"{read_only:false; response_revision:26688; number_of_response:1; }","duration":"167.118915ms","start":"2026-09-29T06:17:19.64738Z","end":"2026-09-29T06:17:19.814499Z","steps":["trace[1833640222] 'process raft request' (duration: 166.822117ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:19.814597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.762254ms","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-09-29T06:17:19.814692Z","caller":"traceutil/trace.go:171","msg":"trace[236116786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26688; }","duration":"144.873046ms","start":"2026-09-29T06:17:19.669794Z","end":"2026-09-29T06:17:19.814667Z","steps":["trace[236116786] 'agreement among raft nodes before linearized reading' (duration: 144.62963ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:19.814587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.282751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:19.814802Z","caller":"traceutil/trace.go:171","msg":"trace[1697077049] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:26688; }","duration":"149.599798ms","start":"2026-09-29T06:17:19.665183Z","end":"2026-09-29T06:17:19.814782Z","steps":["trace[1697077049] 'agreement among raft nodes before linearized reading' (duration: 149.243249ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:19.973669Z","caller":"traceutil/trace.go:171","msg":"trace[480803504] linearizableReadLoop","detail":"{readStateIndex:27566; appliedIndex:27565; }","duration":"115.02237ms","start":"2026-09-29T06:17:19.858603Z","end":"2026-09-29T06:17:19.973625Z","steps":["trace[480803504] 'read index received' (duration: 42.044543ms)","trace[480803504] 'applied index is now lower than readState.Index' (duration: 72.976187ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:19.974162Z","caller":"traceutil/trace.go:171","msg":"trace[1294601407] transaction","detail":"{read_only:false; response_revision:26689; number_of_response:1; }","duration":"154.464895ms","start":"2026-09-29T06:17:19.81962Z","end":"2026-09-29T06:17:19.974085Z","steps":["trace[1294601407] 'process raft request' (duration: 81.080178ms)","trace[1294601407] 'compare' (duration: 72.668039ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:19.974205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.567824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:19.974286Z","caller":"traceutil/trace.go:171","msg":"trace[1253453288] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:26689; }","duration":"115.703568ms","start":"2026-09-29T06:17:19.858563Z","end":"2026-09-29T06:17:19.974267Z","steps":["trace[1253453288] 'agreement among raft nodes before linearized reading' (duration: 115.507663ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:21.833638Z","caller":"traceutil/trace.go:171","msg":"trace[1840040021] transaction","detail":"{read_only:false; response_revision:26703; number_of_response:1; }","duration":"205.316107ms","start":"2026-09-29T06:17:21.628297Z","end":"2026-09-29T06:17:21.833613Z","steps":["trace[1840040021] 'process raft request' (duration: 205.152523ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:25.016171Z","caller":"traceutil/trace.go:171","msg":"trace[34794578] transaction","detail":"{read_only:false; response_revision:26744; number_of_response:1; }","duration":"134.449505ms","start":"2026-09-29T06:17:24.881664Z","end":"2026-09-29T06:17:25.016114Z","steps":["trace[34794578] 'process raft request' (duration: 134.201188ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:25.034272Z","caller":"traceutil/trace.go:171","msg":"trace[864988781] transaction","detail":"{read_only:false; response_revision:26745; number_of_response:1; }","duration":"110.909722ms","start":"2026-09-29T06:17:24.923334Z","end":"2026-09-29T06:17:25.034244Z","steps":["trace[864988781] 'process raft request' (duration: 110.699067ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:25.312984Z","caller":"traceutil/trace.go:171","msg":"trace[1761528248] transaction","detail":"{read_only:false; response_revision:26746; number_of_response:1; }","duration":"123.949853ms","start":"2026-09-29T06:17:25.189006Z","end":"2026-09-29T06:17:25.312956Z","steps":["trace[1761528248] 'process raft request' (duration: 123.787998ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:25.491958Z","caller":"traceutil/trace.go:171","msg":"trace[516600585] transaction","detail":"{read_only:false; response_revision:26747; number_of_response:1; }","duration":"173.399458ms","start":"2026-09-29T06:17:25.318519Z","end":"2026-09-29T06:17:25.491918Z","steps":["trace[516600585] 'process raft request' (duration: 106.756145ms)","trace[516600585] 'compare' (duration: 66.472357ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:56.38579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15497907676571171836,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-29T06:17:56.891823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15497907676571171836,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-29T06:17:57.39283Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15497907676571171836,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-29T06:17:57.41024Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.611201002s","expected-duration":"1s"} {"level":"info","ts":"2026-09-29T06:17:57.410713Z","caller":"traceutil/trace.go:171","msg":"trace[1848588050] transaction","detail":"{read_only:false; response_revision:26994; number_of_response:1; }","duration":"1.611734045s","start":"2026-09-29T06:17:55.798951Z","end":"2026-09-29T06:17:57.410685Z","steps":["trace[1848588050] 'process raft request' (duration: 1.611543101s)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.410883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:55.798935Z","time spent":"1.61185226s","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:17:57.591072Z","caller":"traceutil/trace.go:171","msg":"trace[610869407] transaction","detail":"{read_only:false; response_revision:26995; number_of_response:1; }","duration":"1.585572416s","start":"2026-09-29T06:17:56.00546Z","end":"2026-09-29T06:17:57.591032Z","steps":["trace[610869407] 'process raft request' (duration: 1.548564664s)","trace[610869407] 'compare' (duration: 36.584201ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:57.591159Z","caller":"traceutil/trace.go:171","msg":"trace[1714222695] linearizableReadLoop","detail":"{readStateIndex:27885; appliedIndex:27879; }","duration":"1.718545253s","start":"2026-09-29T06:17:55.872592Z","end":"2026-09-29T06:17:57.591137Z","steps":["trace[1714222695] 'read index received' (duration: 1.538619326s)","trace[1714222695] 'applied index is now lower than readState.Index' (duration: 179.924967ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:57.591216Z","caller":"traceutil/trace.go:171","msg":"trace[1111376299] transaction","detail":"{read_only:false; response_revision:26997; number_of_response:1; }","duration":"1.258792731s","start":"2026-09-29T06:17:56.332367Z","end":"2026-09-29T06:17:57.59116Z","steps":["trace[1111376299] 'process raft request' (duration: 1.258600996s)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.591277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.005432Z","time spent":"1.585727049s","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:17:57.591317Z","caller":"traceutil/trace.go:171","msg":"trace[556387414] transaction","detail":"{read_only:false; response_revision:26999; number_of_response:1; }","duration":"409.32751ms","start":"2026-09-29T06:17:57.18195Z","end":"2026-09-29T06:17:57.591277Z","steps":["trace[556387414] 'process raft request' (duration: 409.103695ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.591385Z","caller":"traceutil/trace.go:171","msg":"trace[710422758] transaction","detail":"{read_only:false; response_revision:26996; number_of_response:1; }","duration":"1.259063578s","start":"2026-09-29T06:17:56.332281Z","end":"2026-09-29T06:17:57.591344Z","steps":["trace[710422758] 'process raft request' (duration: 1.258596086s)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.591395Z","caller":"traceutil/trace.go:171","msg":"trace[253043636] transaction","detail":"{read_only:false; response_revision:27000; number_of_response:1; }","duration":"298.89318ms","start":"2026-09-29T06:17:57.292447Z","end":"2026-09-29T06:17:57.59134Z","steps":["trace[253043636] 'process raft request' (duration: 298.643824ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.591454Z","caller":"traceutil/trace.go:171","msg":"trace[1851369480] transaction","detail":"{read_only:false; response_revision:26998; number_of_response:1; }","duration":"953.033714ms","start":"2026-09-29T06:17:56.638375Z","end":"2026-09-29T06:17:57.591409Z","steps":["trace[1851369480] 'process raft request' (duration: 952.633023ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.591496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:57.18193Z","time spent":"409.471364ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T06:17:57.591512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183744951s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-09-29T06:17:57.591517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.33225Z","time spent":"1.259178931s","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:17:57.591547Z","caller":"traceutil/trace.go:171","msg":"trace[1458470840] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27000; }","duration":"1.183780532s","start":"2026-09-29T06:17:56.407755Z","end":"2026-09-29T06:17:57.591536Z","steps":["trace[1458470840] 'agreement among raft nodes before linearized reading' (duration: 1.18369626s)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.591547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.638348Z","time spent":"953.150746ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T06:17:57.591579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.40775Z","time spent":"1.183821253s","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-29T06:17:57.591425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.572144066s","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-09-29T06:17:57.591646Z","caller":"traceutil/trace.go:171","msg":"trace[95750995] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:27000; }","duration":"1.572404773s","start":"2026-09-29T06:17:56.019225Z","end":"2026-09-29T06:17:57.59163Z","steps":["trace[95750995] 'agreement among raft nodes before linearized reading' (duration: 1.572070125s)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.591689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454663633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-29T06:17:57.591692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.019215Z","time spent":"1.572449544s","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-09-29T06:17:57.591722Z","caller":"traceutil/trace.go:171","msg":"trace[2124134016] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27000; }","duration":"1.454739615s","start":"2026-09-29T06:17:56.136975Z","end":"2026-09-29T06:17:57.591714Z","steps":["trace[2124134016] 'agreement among raft nodes before linearized reading' (duration: 1.454687993s)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.591748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.13695Z","time spent":"1.454793226s","remote":"127.0.0.1:57566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-29T06:17:57.59165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.582312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:57.591779Z","caller":"traceutil/trace.go:171","msg":"trace[1209723320] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:27000; }","duration":"967.817227ms","start":"2026-09-29T06:17:56.62395Z","end":"2026-09-29T06:17:57.591767Z","steps":["trace[1209723320] 'agreement among raft nodes before linearized reading' (duration: 967.482988ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.591804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.623933Z","time spent":"967.859269ms","remote":"127.0.0.1:37488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true "} {"level":"warn","ts":"2026-09-29T06:17:57.591806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.383976726s","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-09-29T06:17:57.591843Z","caller":"traceutil/trace.go:171","msg":"trace[55955761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27000; }","duration":"1.384043318s","start":"2026-09-29T06:17:56.207789Z","end":"2026-09-29T06:17:57.591832Z","steps":["trace[55955761] 'agreement among raft nodes before linearized reading' (duration: 1.383864293s)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.591849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184101441s","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-09-29T06:17:57.591815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.232648311s","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-09-29T06:17:57.591869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.20777Z","time spent":"1.384093058s","remote":"127.0.0.1:57830","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-09-29T06:17:57.591905Z","caller":"traceutil/trace.go:171","msg":"trace[1359839929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27000; }","duration":"1.184151052s","start":"2026-09-29T06:17:56.407725Z","end":"2026-09-29T06:17:57.591876Z","steps":["trace[1359839929] 'agreement among raft nodes before linearized reading' (duration: 1.184028239s)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.591929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.407718Z","time spent":"1.184204083s","remote":"127.0.0.1:57830","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":"info","ts":"2026-09-29T06:17:57.591925Z","caller":"traceutil/trace.go:171","msg":"trace[771120651] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27000; }","duration":"1.232798185s","start":"2026-09-29T06:17:56.359097Z","end":"2026-09-29T06:17:57.591896Z","steps":["trace[771120651] 'agreement among raft nodes before linearized reading' (duration: 1.232530618s)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.591972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.359087Z","time spent":"1.232875387s","remote":"127.0.0.1:57830","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-09-29T06:17:57.592043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.16283ms","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-09-29T06:17:57.592062Z","caller":"traceutil/trace.go:171","msg":"trace[1252457463] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:27000; }","duration":"378.202141ms","start":"2026-09-29T06:17:57.213853Z","end":"2026-09-29T06:17:57.592055Z","steps":["trace[1252457463] 'agreement among raft nodes before linearized reading' (duration: 378.133239ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.59208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:57.213843Z","time spent":"378.233162ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-09-29T06:17:57.592154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.009112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-09-29T06:17:57.592193Z","caller":"traceutil/trace.go:171","msg":"trace[804705183] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:27000; }","duration":"721.066144ms","start":"2026-09-29T06:17:56.871119Z","end":"2026-09-29T06:17:57.592186Z","steps":["trace[804705183] 'agreement among raft nodes before linearized reading' (duration: 720.90908ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.592231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.871103Z","time spent":"721.123125ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":555,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-09-29T06:17:57.592321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.719727853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:57.592349Z","caller":"traceutil/trace.go:171","msg":"trace[698654931] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:27000; }","duration":"1.719753003s","start":"2026-09-29T06:17:55.872584Z","end":"2026-09-29T06:17:57.592337Z","steps":["trace[698654931] 'agreement among raft nodes before linearized reading' (duration: 1.719703842s)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.592365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:55.87256Z","time spent":"1.719800485s","remote":"127.0.0.1:43296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true "} {"level":"warn","ts":"2026-09-29T06:17:57.596469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:17:56.332362Z","time spent":"1.258928795s","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T06:17:57.794831Z","caller":"traceutil/trace.go:171","msg":"trace[737286374] linearizableReadLoop","detail":"{readStateIndex:27886; appliedIndex:27885; }","duration":"190.356088ms","start":"2026-09-29T06:17:57.604445Z","end":"2026-09-29T06:17:57.794801Z","steps":["trace[737286374] 'read index received' (duration: 97.265218ms)","trace[737286374] 'applied index is now lower than readState.Index' (duration: 93.08917ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:17:57.794965Z","caller":"traceutil/trace.go:171","msg":"trace[446048299] transaction","detail":"{read_only:false; response_revision:27001; number_of_response:1; }","duration":"192.089514ms","start":"2026-09-29T06:17:57.602859Z","end":"2026-09-29T06:17:57.794949Z","steps":["trace[446048299] 'process raft request' (duration: 98.830539ms)","trace[446048299] 'compare' (duration: 92.920096ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:17:57.795133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.667216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:17:57.79524Z","caller":"traceutil/trace.go:171","msg":"trace[432495392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27001; }","duration":"190.772549ms","start":"2026-09-29T06:17:57.604424Z","end":"2026-09-29T06:17:57.795196Z","steps":["trace[432495392] 'agreement among raft nodes before linearized reading' (duration: 190.644406ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.866673Z","caller":"traceutil/trace.go:171","msg":"trace[2018595451] transaction","detail":"{read_only:false; response_revision:27002; number_of_response:1; }","duration":"263.580531ms","start":"2026-09-29T06:17:57.60307Z","end":"2026-09-29T06:17:57.86665Z","steps":["trace[2018595451] 'process raft request' (duration: 263.235442ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.866954Z","caller":"traceutil/trace.go:171","msg":"trace[1762494758] transaction","detail":"{read_only:false; response_revision:27003; number_of_response:1; }","duration":"263.780457ms","start":"2026-09-29T06:17:57.603139Z","end":"2026-09-29T06:17:57.86692Z","steps":["trace[1762494758] 'process raft request' (duration: 263.454379ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.867065Z","caller":"traceutil/trace.go:171","msg":"trace[1131383772] transaction","detail":"{read_only:false; response_revision:27006; number_of_response:1; }","duration":"262.428141ms","start":"2026-09-29T06:17:57.604615Z","end":"2026-09-29T06:17:57.867043Z","steps":["trace[1131383772] 'process raft request' (duration: 262.335509ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.867068Z","caller":"traceutil/trace.go:171","msg":"trace[1616890279] transaction","detail":"{read_only:false; response_revision:27004; number_of_response:1; }","duration":"262.866892ms","start":"2026-09-29T06:17:57.60418Z","end":"2026-09-29T06:17:57.867047Z","steps":["trace[1616890279] 'process raft request' (duration: 262.647367ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.86729Z","caller":"traceutil/trace.go:171","msg":"trace[1757348954] transaction","detail":"{read_only:false; response_revision:27007; number_of_response:1; }","duration":"262.225566ms","start":"2026-09-29T06:17:57.605055Z","end":"2026-09-29T06:17:57.86728Z","steps":["trace[1757348954] 'process raft request' (duration: 261.954939ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.867355Z","caller":"traceutil/trace.go:171","msg":"trace[171614582] transaction","detail":"{read_only:false; response_revision:27008; number_of_response:1; }","duration":"259.244518ms","start":"2026-09-29T06:17:57.608104Z","end":"2026-09-29T06:17:57.867349Z","steps":["trace[171614582] 'process raft request' (duration: 259.070534ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.867432Z","caller":"traceutil/trace.go:171","msg":"trace[2018560583] transaction","detail":"{read_only:false; response_revision:27009; number_of_response:1; }","duration":"219.146037ms","start":"2026-09-29T06:17:57.648258Z","end":"2026-09-29T06:17:57.867404Z","steps":["trace[2018560583] 'process raft request' (duration: 219.017263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:57.867621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.459374ms","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-09-29T06:17:57.867695Z","caller":"traceutil/trace.go:171","msg":"trace[530810145] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:27009; }","duration":"197.557756ms","start":"2026-09-29T06:17:57.670126Z","end":"2026-09-29T06:17:57.867683Z","steps":["trace[530810145] 'agreement among raft nodes before linearized reading' (duration: 197.35576ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:57.870018Z","caller":"traceutil/trace.go:171","msg":"trace[187131240] transaction","detail":"{read_only:false; response_revision:27005; number_of_response:1; }","duration":"265.668815ms","start":"2026-09-29T06:17:57.604316Z","end":"2026-09-29T06:17:57.869985Z","steps":["trace[187131240] 'process raft request' (duration: 262.605975ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:59.117363Z","caller":"traceutil/trace.go:171","msg":"trace[1021190034] transaction","detail":"{read_only:false; response_revision:27010; number_of_response:1; }","duration":"182.903895ms","start":"2026-09-29T06:17:58.934413Z","end":"2026-09-29T06:17:59.117317Z","steps":["trace[1021190034] 'process raft request' (duration: 182.587587ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:59.468718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.549027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-96e814b2-a9f5-43a4-8883-17ea6f94e6ef\" ","response":"range_response_count:1 size:1318"} {"level":"info","ts":"2026-09-29T06:17:59.468842Z","caller":"traceutil/trace.go:171","msg":"trace[1769876150] range","detail":"{range_begin:/registry/persistentvolumes/pvc-96e814b2-a9f5-43a4-8883-17ea6f94e6ef; range_end:; response_count:1; response_revision:27011; }","duration":"129.695041ms","start":"2026-09-29T06:17:59.339114Z","end":"2026-09-29T06:17:59.468809Z","steps":["trace[1769876150] 'range keys from in-memory index tree' (duration: 129.337192ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:59.57867Z","caller":"traceutil/trace.go:171","msg":"trace[537737555] transaction","detail":"{read_only:false; response_revision:27012; number_of_response:1; }","duration":"103.978703ms","start":"2026-09-29T06:17:59.474655Z","end":"2026-09-29T06:17:59.578634Z","steps":["trace[537737555] 'process raft request' (duration: 103.429809ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:17:59.802201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.395892ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-09-29T06:17:59.802909Z","caller":"traceutil/trace.go:171","msg":"trace[1389002053] transaction","detail":"{read_only:false; response_revision:27016; number_of_response:1; }","duration":"196.559319ms","start":"2026-09-29T06:17:59.606335Z","end":"2026-09-29T06:17:59.802894Z","steps":["trace[1389002053] 'process raft request' (duration: 196.143988ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:59.802862Z","caller":"traceutil/trace.go:171","msg":"trace[613608702] transaction","detail":"{read_only:false; response_revision:27015; number_of_response:1; }","duration":"198.525189ms","start":"2026-09-29T06:17:59.604307Z","end":"2026-09-29T06:17:59.802832Z","steps":["trace[613608702] 'process raft request' (duration: 198.14782ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:59.802949Z","caller":"traceutil/trace.go:171","msg":"trace[1451089850] transaction","detail":"{read_only:false; response_revision:27013; number_of_response:1; }","duration":"198.745807ms","start":"2026-09-29T06:17:59.604171Z","end":"2026-09-29T06:17:59.802917Z","steps":["trace[1451089850] 'process raft request' (duration: 198.139501ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:59.803166Z","caller":"traceutil/trace.go:171","msg":"trace[728927781] transaction","detail":"{read_only:false; response_revision:27014; number_of_response:1; }","duration":"198.904651ms","start":"2026-09-29T06:17:59.604247Z","end":"2026-09-29T06:17:59.803152Z","steps":["trace[728927781] 'process raft request' (duration: 198.170841ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:17:59.803133Z","caller":"traceutil/trace.go:171","msg":"trace[171177808] transaction","detail":"{read_only:false; response_revision:27017; number_of_response:1; }","duration":"195.916572ms","start":"2026-09-29T06:17:59.607173Z","end":"2026-09-29T06:17:59.803089Z","steps":["trace[171177808] 'process raft request' (duration: 195.342997ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:00.091725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.163265ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-29T06:18:00.091935Z","caller":"traceutil/trace.go:171","msg":"trace[1531906595] linearizableReadLoop","detail":"{readStateIndex:27905; appliedIndex:27903; }","duration":"267.383171ms","start":"2026-09-29T06:17:59.824536Z","end":"2026-09-29T06:18:00.091919Z","steps":["trace[1531906595] 'read index received' (duration: 94.921407ms)","trace[1531906595] 'applied index is now lower than readState.Index' (duration: 172.460334ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:00.092046Z","caller":"traceutil/trace.go:171","msg":"trace[769557867] transaction","detail":"{read_only:false; response_revision:27019; number_of_response:1; }","duration":"281.940869ms","start":"2026-09-29T06:17:59.810096Z","end":"2026-09-29T06:18:00.092036Z","steps":["trace[769557867] 'process raft request' (duration: 281.740154ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:00.092229Z","caller":"traceutil/trace.go:171","msg":"trace[1275301691] transaction","detail":"{read_only:false; response_revision:27018; number_of_response:1; }","duration":"287.552485ms","start":"2026-09-29T06:17:59.804616Z","end":"2026-09-29T06:18:00.092169Z","steps":["trace[1275301691] 'process raft request' (duration: 114.857116ms)","trace[1275301691] 'compare' (duration: 171.99998ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:00.092279Z","caller":"traceutil/trace.go:171","msg":"trace[17608275] transaction","detail":"{read_only:false; response_revision:27020; number_of_response:1; }","duration":"217.398502ms","start":"2026-09-29T06:17:59.874872Z","end":"2026-09-29T06:18:00.092271Z","steps":["trace[17608275] 'process raft request' (duration: 217.005392ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:00.092731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.522485ms","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-09-29T06:18:00.092763Z","caller":"traceutil/trace.go:171","msg":"trace[923485596] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:27020; }","duration":"219.571107ms","start":"2026-09-29T06:17:59.873181Z","end":"2026-09-29T06:18:00.092752Z","steps":["trace[923485596] 'agreement among raft nodes before linearized reading' (duration: 219.430583ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:00.092768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.619495ms","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-09-29T06:18:00.092825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.491399ms","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-09-29T06:18:00.092872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.526235ms","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-09-29T06:18:00.092929Z","caller":"traceutil/trace.go:171","msg":"trace[1663106795] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27020; }","duration":"219.612358ms","start":"2026-09-29T06:17:59.873302Z","end":"2026-09-29T06:18:00.092914Z","steps":["trace[1663106795] 'agreement among raft nodes before linearized reading' (duration: 219.395713ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:00.092934Z","caller":"traceutil/trace.go:171","msg":"trace[153620413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27020; }","duration":"218.624903ms","start":"2026-09-29T06:17:59.874285Z","end":"2026-09-29T06:18:00.09291Z","steps":["trace[153620413] 'agreement among raft nodes before linearized reading' (duration: 218.318285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:00.092964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.692965ms","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:8"} {"level":"warn","ts":"2026-09-29T06:18:00.092968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.723417ms","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-09-29T06:18:00.092995Z","caller":"traceutil/trace.go:171","msg":"trace[1479877545] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:27020; }","duration":"103.755367ms","start":"2026-09-29T06:17:59.989231Z","end":"2026-09-29T06:18:00.092987Z","steps":["trace[1479877545] 'agreement among raft nodes before linearized reading' (duration: 103.645634ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:00.092865Z","caller":"traceutil/trace.go:171","msg":"trace[1695307395] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27020; }","duration":"220.774808ms","start":"2026-09-29T06:17:59.872069Z","end":"2026-09-29T06:18:00.092843Z","steps":["trace[1695307395] 'agreement among raft nodes before linearized reading' (duration: 220.532582ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:00.093002Z","caller":"traceutil/trace.go:171","msg":"trace[1558966624] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27020; }","duration":"220.83587ms","start":"2026-09-29T06:17:59.872156Z","end":"2026-09-29T06:18:00.092992Z","steps":["trace[1558966624] 'agreement among raft nodes before linearized reading' (duration: 220.734728ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:00.09355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.014442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-29T06:18:00.093592Z","caller":"traceutil/trace.go:171","msg":"trace[123718361] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:27020; }","duration":"269.056113ms","start":"2026-09-29T06:17:59.824526Z","end":"2026-09-29T06:18:00.093582Z","steps":["trace[123718361] 'agreement among raft nodes before linearized reading' (duration: 267.76741ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:00.321202Z","caller":"traceutil/trace.go:171","msg":"trace[1442373342] transaction","detail":"{read_only:false; response_revision:27021; number_of_response:1; }","duration":"223.511899ms","start":"2026-09-29T06:18:00.097648Z","end":"2026-09-29T06:18:00.32116Z","steps":["trace[1442373342] 'process raft request' (duration: 203.972511ms)","trace[1442373342] 'compare' (duration: 19.190409ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:00.323664Z","caller":"traceutil/trace.go:171","msg":"trace[383101991] linearizableReadLoop","detail":"{readStateIndex:27911; appliedIndex:27906; }","duration":"224.237069ms","start":"2026-09-29T06:18:00.09941Z","end":"2026-09-29T06:18:00.323647Z","steps":["trace[383101991] 'read index received' (duration: 202.202666ms)","trace[383101991] 'applied index is now lower than readState.Index' (duration: 22.033033ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:00.323924Z","caller":"traceutil/trace.go:171","msg":"trace[225281103] transaction","detail":"{read_only:false; response_revision:27022; number_of_response:1; }","duration":"224.846074ms","start":"2026-09-29T06:18:00.099067Z","end":"2026-09-29T06:18:00.323913Z","steps":["trace[225281103] 'process raft request' (duration: 224.359712ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:00.324095Z","caller":"traceutil/trace.go:171","msg":"trace[355535937] transaction","detail":"{read_only:false; response_revision:27023; number_of_response:1; }","duration":"224.883846ms","start":"2026-09-29T06:18:00.099195Z","end":"2026-09-29T06:18:00.324078Z","steps":["trace[355535937] 'process raft request' (duration: 224.314451ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:00.32426Z","caller":"traceutil/trace.go:171","msg":"trace[1275269900] transaction","detail":"{read_only:false; response_revision:27024; number_of_response:1; }","duration":"224.968139ms","start":"2026-09-29T06:18:00.099281Z","end":"2026-09-29T06:18:00.324249Z","steps":["trace[1275269900] 'process raft request' (duration: 224.27814ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:00.324384Z","caller":"traceutil/trace.go:171","msg":"trace[1356472855] transaction","detail":"{read_only:false; response_revision:27025; number_of_response:1; }","duration":"225.03227ms","start":"2026-09-29T06:18:00.099342Z","end":"2026-09-29T06:18:00.324374Z","steps":["trace[1356472855] 'process raft request' (duration: 224.250959ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:00.324639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.201334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-09-29T06:18:00.324678Z","caller":"traceutil/trace.go:171","msg":"trace[1763406050] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:27025; }","duration":"225.288727ms","start":"2026-09-29T06:18:00.09938Z","end":"2026-09-29T06:18:00.324669Z","steps":["trace[1763406050] 'agreement among raft nodes before linearized reading' (duration: 225.107482ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:00.324866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.019729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:18:00.3249Z","caller":"traceutil/trace.go:171","msg":"trace[1010870319] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:27025; }","duration":"220.079451ms","start":"2026-09-29T06:18:00.104811Z","end":"2026-09-29T06:18:00.324891Z","steps":["trace[1010870319] 'agreement among raft nodes before linearized reading' (duration: 220.01476ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:01.476772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.040274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18739"} {"level":"info","ts":"2026-09-29T06:18:01.476871Z","caller":"traceutil/trace.go:171","msg":"trace[884769601] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:27026; }","duration":"104.192848ms","start":"2026-09-29T06:18:01.372657Z","end":"2026-09-29T06:18:01.476849Z","steps":["trace[884769601] 'range keys from in-memory index tree' (duration: 103.84673ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:02.007972Z","caller":"traceutil/trace.go:171","msg":"trace[1118047456] transaction","detail":"{read_only:false; response_revision:27028; number_of_response:1; }","duration":"197.990327ms","start":"2026-09-29T06:18:01.80993Z","end":"2026-09-29T06:18:02.00792Z","steps":["trace[1118047456] 'process raft request' (duration: 197.77515ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:02.097822Z","caller":"traceutil/trace.go:171","msg":"trace[81992411] transaction","detail":"{read_only:false; response_revision:27032; number_of_response:1; }","duration":"286.545259ms","start":"2026-09-29T06:18:01.811251Z","end":"2026-09-29T06:18:02.097797Z","steps":["trace[81992411] 'process raft request' (duration: 286.486927ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:02.098099Z","caller":"traceutil/trace.go:171","msg":"trace[1545198481] transaction","detail":"{read_only:false; response_revision:27029; number_of_response:1; }","duration":"287.416871ms","start":"2026-09-29T06:18:01.81067Z","end":"2026-09-29T06:18:02.098087Z","steps":["trace[1545198481] 'process raft request' (duration: 277.662487ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:02.098176Z","caller":"traceutil/trace.go:171","msg":"trace[1520434341] transaction","detail":"{read_only:false; response_revision:27030; number_of_response:1; }","duration":"287.104463ms","start":"2026-09-29T06:18:01.811027Z","end":"2026-09-29T06:18:02.098132Z","steps":["trace[1520434341] 'process raft request' (duration: 286.612621ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:02.098242Z","caller":"traceutil/trace.go:171","msg":"trace[221826508] transaction","detail":"{read_only:false; response_revision:27031; number_of_response:1; }","duration":"287.096173ms","start":"2026-09-29T06:18:01.811097Z","end":"2026-09-29T06:18:02.098193Z","steps":["trace[221826508] 'process raft request' (duration: 286.59275ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:02.3037Z","caller":"traceutil/trace.go:171","msg":"trace[1708859931] linearizableReadLoop","detail":"{readStateIndex:27920; appliedIndex:27918; }","duration":"191.391025ms","start":"2026-09-29T06:18:02.112268Z","end":"2026-09-29T06:18:02.303659Z","steps":["trace[1708859931] 'read index received' (duration: 46.103158ms)","trace[1708859931] 'applied index is now lower than readState.Index' (duration: 145.286517ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:02.303871Z","caller":"traceutil/trace.go:171","msg":"trace[201669129] transaction","detail":"{read_only:false; response_revision:27034; number_of_response:1; }","duration":"199.361882ms","start":"2026-09-29T06:18:02.104496Z","end":"2026-09-29T06:18:02.303858Z","steps":["trace[201669129] 'process raft request' (duration: 182.810441ms)","trace[201669129] 'compare' (duration: 16.188502ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:18:02.304362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.078002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:18:02.304406Z","caller":"traceutil/trace.go:171","msg":"trace[1519912778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27034; }","duration":"192.203196ms","start":"2026-09-29T06:18:02.112191Z","end":"2026-09-29T06:18:02.304394Z","steps":["trace[1519912778] 'agreement among raft nodes before linearized reading' (duration: 192.095053ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:02.305856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.307163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/images/\" range_end:\"/registry/openstack.k-orc.cloud/images0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:18:02.306059Z","caller":"traceutil/trace.go:171","msg":"trace[2023042036] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/images/; range_end:/registry/openstack.k-orc.cloud/images0; response_count:0; response_revision:27034; }","duration":"166.510008ms","start":"2026-09-29T06:18:02.139468Z","end":"2026-09-29T06:18:02.305978Z","steps":["trace[2023042036] 'agreement among raft nodes before linearized reading' (duration: 166.216651ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:02.536654Z","caller":"traceutil/trace.go:171","msg":"trace[1789782801] transaction","detail":"{read_only:false; response_revision:27037; number_of_response:1; }","duration":"147.067482ms","start":"2026-09-29T06:18:02.389554Z","end":"2026-09-29T06:18:02.536622Z","steps":["trace[1789782801] 'process raft request' (duration: 147.005451ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:02.537049Z","caller":"traceutil/trace.go:171","msg":"trace[614023794] linearizableReadLoop","detail":"{readStateIndex:27922; appliedIndex:27921; }","duration":"151.907989ms","start":"2026-09-29T06:18:02.38508Z","end":"2026-09-29T06:18:02.536988Z","steps":["trace[614023794] 'read index received' (duration: 74.872326ms)","trace[614023794] 'applied index is now lower than readState.Index' (duration: 77.032533ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:02.537154Z","caller":"traceutil/trace.go:171","msg":"trace[1717380415] transaction","detail":"{read_only:false; response_revision:27036; number_of_response:1; }","duration":"196.917809ms","start":"2026-09-29T06:18:02.340162Z","end":"2026-09-29T06:18:02.53708Z","steps":["trace[1717380415] 'process raft request' (duration: 119.737003ms)","trace[1717380415] 'compare' (duration: 76.512709ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:18:02.537341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.733284ms","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-09-29T06:18:02.537399Z","caller":"traceutil/trace.go:171","msg":"trace[1112504301] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27037; }","duration":"201.831588ms","start":"2026-09-29T06:18:02.335553Z","end":"2026-09-29T06:18:02.537385Z","steps":["trace[1112504301] 'agreement among raft nodes before linearized reading' (duration: 201.591981ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:02.537397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.206571ms","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-09-29T06:18:02.5375Z","caller":"traceutil/trace.go:171","msg":"trace[753966944] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27037; }","duration":"201.384725ms","start":"2026-09-29T06:18:02.336086Z","end":"2026-09-29T06:18:02.537471Z","steps":["trace[753966944] 'agreement among raft nodes before linearized reading' (duration: 201.003644ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:02.798861Z","caller":"traceutil/trace.go:171","msg":"trace[545640561] transaction","detail":"{read_only:false; response_revision:27039; number_of_response:1; }","duration":"255.962674ms","start":"2026-09-29T06:18:02.542804Z","end":"2026-09-29T06:18:02.798767Z","steps":["trace[545640561] 'process raft request' (duration: 186.838217ms)","trace[545640561] 'compare' (duration: 68.85318ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:04.236561Z","caller":"traceutil/trace.go:171","msg":"trace[503676212] transaction","detail":"{read_only:false; response_revision:27043; number_of_response:1; }","duration":"128.911941ms","start":"2026-09-29T06:18:04.107618Z","end":"2026-09-29T06:18:04.23653Z","steps":["trace[503676212] 'process raft request' (duration: 128.677455ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:04.236847Z","caller":"traceutil/trace.go:171","msg":"trace[1473645354] transaction","detail":"{read_only:false; response_revision:27044; number_of_response:1; }","duration":"128.560762ms","start":"2026-09-29T06:18:04.10825Z","end":"2026-09-29T06:18:04.23681Z","steps":["trace[1473645354] 'process raft request' (duration: 128.231814ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:04.237409Z","caller":"traceutil/trace.go:171","msg":"trace[145593354] transaction","detail":"{read_only:false; response_revision:27045; number_of_response:1; }","duration":"127.268998ms","start":"2026-09-29T06:18:04.110123Z","end":"2026-09-29T06:18:04.237392Z","steps":["trace[145593354] 'process raft request' (duration: 126.638582ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:04.377903Z","caller":"traceutil/trace.go:171","msg":"trace[1163237155] transaction","detail":"{read_only:false; response_revision:27046; number_of_response:1; }","duration":"213.374377ms","start":"2026-09-29T06:18:04.164478Z","end":"2026-09-29T06:18:04.377852Z","steps":["trace[1163237155] 'process raft request' (duration: 135.595315ms)","trace[1163237155] 'compare' (duration: 77.616667ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:04.377952Z","caller":"traceutil/trace.go:171","msg":"trace[1848945645] linearizableReadLoop","detail":"{readStateIndex:27932; appliedIndex:27928; }","duration":"164.496506ms","start":"2026-09-29T06:18:04.213425Z","end":"2026-09-29T06:18:04.377922Z","steps":["trace[1848945645] 'read index received' (duration: 22.908985ms)","trace[1848945645] 'applied index is now lower than readState.Index' (duration: 141.581841ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:18:04.378076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.63223ms","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-09-29T06:18:04.378142Z","caller":"traceutil/trace.go:171","msg":"trace[11399585] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:27047; }","duration":"164.794334ms","start":"2026-09-29T06:18:04.213332Z","end":"2026-09-29T06:18:04.378126Z","steps":["trace[11399585] 'agreement among raft nodes before linearized reading' (duration: 164.665141ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:04.776851Z","caller":"traceutil/trace.go:171","msg":"trace[813587169] transaction","detail":"{read_only:false; response_revision:27050; number_of_response:1; }","duration":"172.265229ms","start":"2026-09-29T06:18:04.604556Z","end":"2026-09-29T06:18:04.776821Z","steps":["trace[813587169] 'process raft request' (duration: 172.085224ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:04.915277Z","caller":"traceutil/trace.go:171","msg":"trace[290938291] transaction","detail":"{read_only:false; response_revision:27051; number_of_response:1; }","duration":"309.187257ms","start":"2026-09-29T06:18:04.606022Z","end":"2026-09-29T06:18:04.915209Z","steps":["trace[290938291] 'process raft request' (duration: 211.521767ms)","trace[290938291] 'compare' (duration: 97.175067ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:04.915279Z","caller":"traceutil/trace.go:171","msg":"trace[318416746] transaction","detail":"{read_only:false; response_revision:27052; number_of_response:1; }","duration":"276.777614ms","start":"2026-09-29T06:18:04.638461Z","end":"2026-09-29T06:18:04.915239Z","steps":["trace[318416746] 'process raft request' (duration: 276.435196ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:04.915317Z","caller":"traceutil/trace.go:171","msg":"trace[523297866] linearizableReadLoop","detail":"{readStateIndex:27937; appliedIndex:27935; }","duration":"303.846927ms","start":"2026-09-29T06:18:04.611432Z","end":"2026-09-29T06:18:04.915278Z","steps":["trace[523297866] 'read index received' (duration: 165.200814ms)","trace[523297866] 'applied index is now lower than readState.Index' (duration: 138.643183ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:18:04.915487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:18:04.606009Z","time spent":"309.362081ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T06:18:05.037278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.234357ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-29T06:18:05.037431Z","caller":"traceutil/trace.go:171","msg":"trace[1582539284] linearizableReadLoop","detail":"{readStateIndex:27939; appliedIndex:27938; }","duration":"122.019792ms","start":"2026-09-29T06:18:04.915385Z","end":"2026-09-29T06:18:05.037404Z","steps":["trace[1582539284] 'read index received' (duration: 87.262µs)","trace[1582539284] 'applied index is now lower than readState.Index' (duration: 121.93034ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:18:05.037641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.179428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-09-29T06:18:05.037701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.280974ms","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-09-29T06:18:05.037698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.710245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-29T06:18:05.037758Z","caller":"traceutil/trace.go:171","msg":"trace[201393401] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27052; }","duration":"233.345516ms","start":"2026-09-29T06:18:04.804386Z","end":"2026-09-29T06:18:05.037732Z","steps":["trace[201393401] 'agreement among raft nodes before linearized reading' (duration: 233.083679ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:05.037763Z","caller":"traceutil/trace.go:171","msg":"trace[1215830594] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:27052; }","duration":"208.830148ms","start":"2026-09-29T06:18:04.828914Z","end":"2026-09-29T06:18:05.037744Z","steps":["trace[1215830594] 'agreement among raft nodes before linearized reading' (duration: 208.703165ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:05.037763Z","caller":"traceutil/trace.go:171","msg":"trace[1994610633] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27052; }","duration":"426.342383ms","start":"2026-09-29T06:18:04.611389Z","end":"2026-09-29T06:18:05.037731Z","steps":["trace[1994610633] 'agreement among raft nodes before linearized reading' (duration: 304.061064ms)","trace[1994610633] 'range keys from in-memory index tree' (duration: 121.984211ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:18:05.037785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.430006ms","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-09-29T06:18:05.037869Z","caller":"traceutil/trace.go:171","msg":"trace[407492305] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:27052; }","duration":"156.55745ms","start":"2026-09-29T06:18:04.881292Z","end":"2026-09-29T06:18:05.037849Z","steps":["trace[407492305] 'agreement among raft nodes before linearized reading' (duration: 156.241112ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:05.037815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T06:18:04.611376Z","time spent":"426.429465ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-29T06:18:16.96244Z","caller":"traceutil/trace.go:171","msg":"trace[1988123009] linearizableReadLoop","detail":"{readStateIndex:28028; appliedIndex:28027; }","duration":"100.445241ms","start":"2026-09-29T06:18:16.86197Z","end":"2026-09-29T06:18:16.962415Z","steps":["trace[1988123009] 'read index received' (duration: 100.195764ms)","trace[1988123009] 'applied index is now lower than readState.Index' (duration: 248.497µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:16.962511Z","caller":"traceutil/trace.go:171","msg":"trace[99558368] transaction","detail":"{read_only:false; response_revision:27139; number_of_response:1; }","duration":"107.004731ms","start":"2026-09-29T06:18:16.855462Z","end":"2026-09-29T06:18:16.962467Z","steps":["trace[99558368] 'process raft request' (duration: 106.773625ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T06:18:16.962604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.605086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-29T06:18:16.962643Z","caller":"traceutil/trace.go:171","msg":"trace[348586464] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:27139; }","duration":"100.663927ms","start":"2026-09-29T06:18:16.861965Z","end":"2026-09-29T06:18:16.962629Z","steps":["trace[348586464] 'agreement among raft nodes before linearized reading' (duration: 100.544574ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:18.166839Z","caller":"traceutil/trace.go:171","msg":"trace[1748145402] transaction","detail":"{read_only:false; response_revision:27144; number_of_response:1; }","duration":"187.954956ms","start":"2026-09-29T06:18:17.978846Z","end":"2026-09-29T06:18:18.166801Z","steps":["trace[1748145402] 'process raft request' (duration: 187.71242ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:18.294419Z","caller":"traceutil/trace.go:171","msg":"trace[1949666400] linearizableReadLoop","detail":"{readStateIndex:28034; appliedIndex:28032; }","duration":"187.72723ms","start":"2026-09-29T06:18:18.10665Z","end":"2026-09-29T06:18:18.294377Z","steps":["trace[1949666400] 'read index received' (duration: 59.875167ms)","trace[1949666400] 'applied index is now lower than readState.Index' (duration: 127.849943ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:18:18.294614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.947906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-29T06:18:18.29466Z","caller":"traceutil/trace.go:171","msg":"trace[774750356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27145; }","duration":"188.127811ms","start":"2026-09-29T06:18:18.106518Z","end":"2026-09-29T06:18:18.294645Z","steps":["trace[774750356] 'agreement among raft nodes before linearized reading' (duration: 188.001497ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:18.294681Z","caller":"traceutil/trace.go:171","msg":"trace[2142771150] transaction","detail":"{read_only:false; response_revision:27145; number_of_response:1; }","duration":"209.075164ms","start":"2026-09-29T06:18:18.085538Z","end":"2026-09-29T06:18:18.294613Z","steps":["trace[2142771150] 'process raft request' (duration: 132.192556ms)","trace[2142771150] 'compare' (duration: 76.19926ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:40.500866Z","caller":"traceutil/trace.go:171","msg":"trace[653481312] transaction","detail":"{read_only:false; response_revision:27460; number_of_response:1; }","duration":"109.64862ms","start":"2026-09-29T06:18:40.391186Z","end":"2026-09-29T06:18:40.500835Z","steps":["trace[653481312] 'process raft request' (duration: 109.481426ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:40.70199Z","caller":"traceutil/trace.go:171","msg":"trace[1640403783] transaction","detail":"{read_only:false; response_revision:27461; number_of_response:1; }","duration":"283.702894ms","start":"2026-09-29T06:18:40.418228Z","end":"2026-09-29T06:18:40.701931Z","steps":["trace[1640403783] 'process raft request' (duration: 283.421637ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:40.702241Z","caller":"traceutil/trace.go:171","msg":"trace[939742515] transaction","detail":"{read_only:false; response_revision:27462; number_of_response:1; }","duration":"233.270083ms","start":"2026-09-29T06:18:40.468929Z","end":"2026-09-29T06:18:40.702199Z","steps":["trace[939742515] 'process raft request' (duration: 232.943144ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:40.702339Z","caller":"traceutil/trace.go:171","msg":"trace[1434567135] transaction","detail":"{read_only:false; response_revision:27463; number_of_response:1; }","duration":"226.493078ms","start":"2026-09-29T06:18:40.475822Z","end":"2026-09-29T06:18:40.702315Z","steps":["trace[1434567135] 'process raft request' (duration: 226.280962ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:40.702466Z","caller":"traceutil/trace.go:171","msg":"trace[1865764412] transaction","detail":"{read_only:false; response_revision:27464; number_of_response:1; }","duration":"226.612901ms","start":"2026-09-29T06:18:40.475822Z","end":"2026-09-29T06:18:40.702435Z","steps":["trace[1865764412] 'process raft request' (duration: 226.420136ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:18:40.76687Z","caller":"traceutil/trace.go:171","msg":"trace[1080157323] transaction","detail":"{read_only:false; response_revision:27465; number_of_response:1; }","duration":"237.155174ms","start":"2026-09-29T06:18:40.529682Z","end":"2026-09-29T06:18:40.766837Z","steps":["trace[1080157323] 'process raft request' (duration: 224.67002ms)","trace[1080157323] 'compare' (duration: 11.833247ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:40.956048Z","caller":"traceutil/trace.go:171","msg":"trace[995471037] linearizableReadLoop","detail":"{readStateIndex:28363; appliedIndex:28362; }","duration":"104.301532ms","start":"2026-09-29T06:18:40.851717Z","end":"2026-09-29T06:18:40.956019Z","steps":["trace[995471037] 'read index received' (duration: 69.725343ms)","trace[995471037] 'applied index is now lower than readState.Index' (duration: 34.570909ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T06:18:40.956209Z","caller":"traceutil/trace.go:171","msg":"trace[691824157] transaction","detail":"{read_only:false; response_revision:27467; number_of_response:1; }","duration":"183.751577ms","start":"2026-09-29T06:18:40.772443Z","end":"2026-09-29T06:18:40.956194Z","steps":["trace[691824157] 'process raft request' (duration: 149.062794ms)","trace[691824157] 'compare' (duration: 34.233611ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T06:18:40.958109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.369275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-09-29T06:18:40.958158Z","caller":"traceutil/trace.go:171","msg":"trace[149022916] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:27467; }","duration":"106.478048ms","start":"2026-09-29T06:18:40.851668Z","end":"2026-09-29T06:18:40.958146Z","steps":["trace[149022916] 'agreement among raft nodes before linearized reading' (duration: 104.698562ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T06:20:15.949777Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25517} {"level":"info","ts":"2026-09-29T06:20:16.115417Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25517,"took":"158.129195ms","hash":1179818551,"current-db-size-bytes":58806272,"current-db-size":"59 MB","current-db-size-in-use-bytes":37871616,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-09-29T06:20:16.115537Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1179818551,"revision":25517,"compact-revision":22362} {"level":"info","ts":"2026-09-29T06:21:20.335182Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6814e3e3d6b4d713","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-29T06:21:20.342815Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-09-29T06:21:20.343126Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-09-29T06:25:15.959864Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28375} {"level":"info","ts":"2026-09-29T06:25:16.111923Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28375,"took":"144.429569ms","hash":1465095780,"current-db-size-bytes":58806272,"current-db-size":"59 MB","current-db-size-in-use-bytes":34983936,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-09-29T06:25:16.112031Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1465095780,"revision":28375,"compact-revision":25517} {"level":"info","ts":"2026-09-29T06:30:15.967068Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30985} {"level":"info","ts":"2026-09-29T06:30:16.151737Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30985,"took":"179.365995ms","hash":2254494911,"current-db-size-bytes":58806272,"current-db-size":"59 MB","current-db-size-in-use-bytes":31772672,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-29T06:30:16.151828Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2254494911,"revision":30985,"compact-revision":28375} {"level":"info","ts":"2026-09-29T06:35:15.985265Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33283} {"level":"info","ts":"2026-09-29T06:35:16.157993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33283,"took":"166.216345ms","hash":1216382900,"current-db-size-bytes":59850752,"current-db-size":"60 MB","current-db-size-in-use-bytes":31485952,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-29T06:35:16.158066Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1216382900,"revision":33283,"compact-revision":30985} {"level":"info","ts":"2026-09-29T06:40:15.992415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35545} {"level":"info","ts":"2026-09-29T06:40:16.149193Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35545,"took":"150.874067ms","hash":3773739815,"current-db-size-bytes":59850752,"current-db-size":"60 MB","current-db-size-in-use-bytes":31621120,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-29T06:40:16.149272Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3773739815,"revision":35545,"compact-revision":33283} {"level":"info","ts":"2026-09-29T06:42:19.862655Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6814e3e3d6b4d713","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-29T06:42:19.869311Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-09-29T06:42:19.869713Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-09-29T06:45:16.000295Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37831} {"level":"info","ts":"2026-09-29T06:45:16.180514Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37831,"took":"173.809874ms","hash":703719020,"current-db-size-bytes":59850752,"current-db-size":"60 MB","current-db-size-in-use-bytes":32313344,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-29T06:45:16.180699Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":703719020,"revision":37831,"compact-revision":35545} {"level":"info","ts":"2026-09-29T06:50:16.008541Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":40082} {"level":"info","ts":"2026-09-29T06:50:16.161544Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":40082,"took":"146.549507ms","hash":3776570984,"current-db-size-bytes":61132800,"current-db-size":"61 MB","current-db-size-in-use-bytes":33275904,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-29T06:50:16.16164Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3776570984,"revision":40082,"compact-revision":37831}