{"level":"warn","ts":"2026-06-15T19:03:27.387788Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T19:03:27.387875Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.84:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.84:2380","--initial-cluster=instance=https://199.19.213.84:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.84:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.84:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-15T19:03:27.387953Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-15T19:03:27.387973Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.84:2380"]} {"level":"info","ts":"2026-06-15T19:03:27.387994Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-15T19:03:27.388618Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.84:2379"]} {"level":"info","ts":"2026-06-15T19:03:27.388713Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.84:2380"],"listen-peer-urls":["https://199.19.213.84:2380"],"advertise-client-urls":["https://199.19.213.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.84:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-15T19:03:27.392155Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.215419ms"} {"level":"info","ts":"2026-06-15T19:03:27.397702Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f823adf772f78a4c","cluster-id":"b5473e4c769d66"} {"level":"info","ts":"2026-06-15T19:03:27.397769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T19:03:27.397789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became follower at term 0"} {"level":"info","ts":"2026-06-15T19:03:27.397799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f823adf772f78a4c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T19:03:27.397813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became follower at term 1"} {"level":"info","ts":"2026-06-15T19:03:27.397846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c switched to configuration voters=(17880326223888353868)"} {"level":"warn","ts":"2026-06-15T19:03:27.402633Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T19:03:27.4046Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T19:03:27.405692Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-15T19:03:27.408875Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f823adf772f78a4c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T19:03:27.409077Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f823adf772f78a4c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T19:03:27.409216Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T19:03:27.409333Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T19:03:27.409353Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-15T19:03:27.410709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c switched to configuration voters=(17880326223888353868)"} {"level":"info","ts":"2026-06-15T19:03:27.410962Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b5473e4c769d66","local-member-id":"f823adf772f78a4c","added-peer-id":"f823adf772f78a4c","added-peer-peer-urls":["https://199.19.213.84:2380"]} {"level":"info","ts":"2026-06-15T19:03:27.414361Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-15T19:03:27.414568Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f823adf772f78a4c","initial-advertise-peer-urls":["https://199.19.213.84:2380"],"listen-peer-urls":["https://199.19.213.84:2380"],"advertise-client-urls":["https://199.19.213.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T19:03:27.414621Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T19:03:27.414552Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.84:2380"} {"level":"info","ts":"2026-06-15T19:03:27.414699Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.84:2380"} {"level":"info","ts":"2026-06-15T19:03:27.598283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T19:03:27.598355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T19:03:27.598378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c received MsgPreVoteResp from f823adf772f78a4c at term 1"} {"level":"info","ts":"2026-06-15T19:03:27.598563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became candidate at term 2"} {"level":"info","ts":"2026-06-15T19:03:27.598579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c received MsgVoteResp from f823adf772f78a4c at term 2"} {"level":"info","ts":"2026-06-15T19:03:27.598595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became leader at term 2"} {"level":"info","ts":"2026-06-15T19:03:27.598642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f823adf772f78a4c elected leader f823adf772f78a4c at term 2"} {"level":"info","ts":"2026-06-15T19:03:27.599663Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:03:27.600507Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:03:27.600508Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f823adf772f78a4c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.84:2379]}","request-path":"/0/members/f823adf772f78a4c/attributes","cluster-id":"b5473e4c769d66","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T19:03:27.600577Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:03:27.600947Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T19:03:27.60099Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T19:03:27.601199Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b5473e4c769d66","local-member-id":"f823adf772f78a4c","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:03:27.601431Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:03:27.601764Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:03:27.604257Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.84:2379"} {"level":"info","ts":"2026-06-15T19:03:27.604922Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T19:04:04.306807Z","caller":"traceutil/trace.go:171","msg":"trace[34863971] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"112.83252ms","start":"2026-06-15T19:04:04.192098Z","end":"2026-06-15T19:04:04.30493Z","steps":["trace[34863971] 'process raft request' (duration: 98.871666ms)","trace[34863971] 'compare' (duration: 13.288687ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:04:04.307628Z","caller":"traceutil/trace.go:171","msg":"trace[77168391] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"101.792958ms","start":"2026-06-15T19:04:04.205798Z","end":"2026-06-15T19:04:04.307591Z","steps":["trace[77168391] 'process raft request' (duration: 98.813915ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:04:10.614233Z","caller":"traceutil/trace.go:171","msg":"trace[169399177] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"235.052231ms","start":"2026-06-15T19:04:10.379133Z","end":"2026-06-15T19:04:10.614186Z","steps":["trace[169399177] 'process raft request' (duration: 234.298372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:10.95511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.666695ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:04:10.955296Z","caller":"traceutil/trace.go:171","msg":"trace[2056254062] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:592; }","duration":"220.88105ms","start":"2026-06-15T19:04:10.734396Z","end":"2026-06-15T19:04:10.955277Z","steps":["trace[2056254062] 'range keys from in-memory index tree' (duration: 220.646785ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:04:10.964536Z","caller":"traceutil/trace.go:171","msg":"trace[264237118] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"131.854754ms","start":"2026-06-15T19:04:10.832657Z","end":"2026-06-15T19:04:10.964511Z","steps":["trace[264237118] 'read index received' (duration: 131.624288ms)","trace[264237118] 'applied index is now lower than readState.Index' (duration: 229.346µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:04:10.964611Z","caller":"traceutil/trace.go:171","msg":"trace[1032582149] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"287.342671ms","start":"2026-06-15T19:04:10.677242Z","end":"2026-06-15T19:04:10.964585Z","steps":["trace[1032582149] 'process raft request' (duration: 287.130936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:10.964752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.083899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.84\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-15T19:04:10.964813Z","caller":"traceutil/trace.go:171","msg":"trace[15171111] range","detail":"{range_begin:/registry/masterleases/199.19.213.84; range_end:; response_count:1; response_revision:593; }","duration":"132.185852ms","start":"2026-06-15T19:04:10.832613Z","end":"2026-06-15T19:04:10.964799Z","steps":["trace[15171111] 'agreement among raft nodes before linearized reading' (duration: 132.034058ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:04:11.105776Z","caller":"traceutil/trace.go:171","msg":"trace[1543969963] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"136.261202ms","start":"2026-06-15T19:04:10.969496Z","end":"2026-06-15T19:04:11.105757Z","steps":["trace[1543969963] 'process raft request' (duration: 128.635025ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:04:11.1061Z","caller":"traceutil/trace.go:171","msg":"trace[2108209530] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"128.43775ms","start":"2026-06-15T19:04:10.977635Z","end":"2026-06-15T19:04:11.106073Z","steps":["trace[2108209530] 'process raft request' (duration: 128.07652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:26.56787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.425551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-15T19:04:26.56796Z","caller":"traceutil/trace.go:171","msg":"trace[916422014] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:756; }","duration":"218.572514ms","start":"2026-06-15T19:04:26.349369Z","end":"2026-06-15T19:04:26.567942Z","steps":["trace[916422014] 'range keys from in-memory index tree' (duration: 218.216665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:58.145951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.995339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T19:04:58.146034Z","caller":"traceutil/trace.go:171","msg":"trace[1687013207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1160; }","duration":"205.122612ms","start":"2026-06-15T19:04:57.940894Z","end":"2026-06-15T19:04:58.146017Z","steps":["trace[1687013207] 'range keys from in-memory index tree' (duration: 204.832045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:58.146135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.57211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T19:04:58.146253Z","caller":"traceutil/trace.go:171","msg":"trace[1050518495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1160; }","duration":"170.740854ms","start":"2026-06-15T19:04:57.975482Z","end":"2026-06-15T19:04:58.146223Z","steps":["trace[1050518495] 'range keys from in-memory index tree' (duration: 170.304264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:40.545118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.551076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-15T19:05:40.545248Z","caller":"traceutil/trace.go:171","msg":"trace[436051081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1807; }","duration":"188.694069ms","start":"2026-06-15T19:05:40.356499Z","end":"2026-06-15T19:05:40.545193Z","steps":["trace[436051081] 'range keys from in-memory index tree' (duration: 188.388192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:40.545123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.938601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a590b68-85c6-4e43-ac65-2f16b1ba6ea5\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-15T19:05:40.545429Z","caller":"traceutil/trace.go:171","msg":"trace[1555282975] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7a590b68-85c6-4e43-ac65-2f16b1ba6ea5; range_end:; response_count:1; response_revision:1807; }","duration":"212.28942ms","start":"2026-06-15T19:05:40.333099Z","end":"2026-06-15T19:05:40.545389Z","steps":["trace[1555282975] 'range keys from in-memory index tree' (duration: 211.729657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:40.545668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.837348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T19:05:40.545753Z","caller":"traceutil/trace.go:171","msg":"trace[1889114707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1807; }","duration":"189.973171ms","start":"2026-06-15T19:05:40.355763Z","end":"2026-06-15T19:05:40.545736Z","steps":["trace[1889114707] 'range keys from in-memory index tree' (duration: 189.54475ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:29.976251Z","caller":"traceutil/trace.go:171","msg":"trace[832448085] linearizableReadLoop","detail":"{readStateIndex:2211; appliedIndex:2210; }","duration":"126.161347ms","start":"2026-06-15T19:06:29.850065Z","end":"2026-06-15T19:06:29.976226Z","steps":["trace[832448085] 'read index received' (duration: 125.930202ms)","trace[832448085] 'applied index is now lower than readState.Index' (duration: 230.315µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:06:29.97631Z","caller":"traceutil/trace.go:171","msg":"trace[166568264] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"155.138032ms","start":"2026-06-15T19:06:29.821137Z","end":"2026-06-15T19:06:29.976275Z","steps":["trace[166568264] 'process raft request' (duration: 154.918997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:29.976484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.387234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-15T19:06:29.976536Z","caller":"traceutil/trace.go:171","msg":"trace[1995893639] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2133; }","duration":"126.488555ms","start":"2026-06-15T19:06:29.850035Z","end":"2026-06-15T19:06:29.976523Z","steps":["trace[1995893639] 'agreement among raft nodes before linearized reading' (duration: 126.302831ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:30.135099Z","caller":"traceutil/trace.go:171","msg":"trace[407285975] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"154.809054ms","start":"2026-06-15T19:06:29.980254Z","end":"2026-06-15T19:06:30.135063Z","steps":["trace[407285975] 'process raft request' (duration: 92.54214ms)","trace[407285975] 'compare' (duration: 62.054678ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:52.216232Z","caller":"traceutil/trace.go:171","msg":"trace[1665435027] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"111.858795ms","start":"2026-06-15T19:07:52.104346Z","end":"2026-06-15T19:07:52.216205Z","steps":["trace[1665435027] 'process raft request' (duration: 111.65676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:52.4802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.401827ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:07:52.480329Z","caller":"traceutil/trace.go:171","msg":"trace[45460221] linearizableReadLoop","detail":"{readStateIndex:2878; appliedIndex:2877; }","duration":"159.437317ms","start":"2026-06-15T19:07:52.320871Z","end":"2026-06-15T19:07:52.480308Z","steps":["trace[45460221] 'read index received' (duration: 55.264952ms)","trace[45460221] 'applied index is now lower than readState.Index' (duration: 104.170985ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:52.480461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.57435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:52.480401Z","caller":"traceutil/trace.go:171","msg":"trace[563358365] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"226.075708ms","start":"2026-06-15T19:07:52.254275Z","end":"2026-06-15T19:07:52.48035Z","steps":["trace[563358365] 'process raft request' (duration: 121.849751ms)","trace[563358365] 'compare' (duration: 102.993336ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:52.480548Z","caller":"traceutil/trace.go:171","msg":"trace[590675325] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2774; }","duration":"159.713993ms","start":"2026-06-15T19:07:52.320815Z","end":"2026-06-15T19:07:52.480529Z","steps":["trace[590675325] 'agreement among raft nodes before linearized reading' (duration: 159.552269ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:52.712496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.513419ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:07:52.713441Z","caller":"traceutil/trace.go:171","msg":"trace[1918401416] transaction","detail":"{read_only:false; response_revision:2775; number_of_response:1; }","duration":"208.955836ms","start":"2026-06-15T19:07:52.504449Z","end":"2026-06-15T19:07:52.713405Z","steps":["trace[1918401416] 'process raft request' (duration: 104.406542ms)","trace[1918401416] 'compare' (duration: 103.376066ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:10:28.294769Z","caller":"traceutil/trace.go:171","msg":"trace[1411947144] transaction","detail":"{read_only:false; response_revision:3794; number_of_response:1; }","duration":"133.229403ms","start":"2026-06-15T19:10:28.161515Z","end":"2026-06-15T19:10:28.294745Z","steps":["trace[1411947144] 'process raft request' (duration: 133.046739ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:10:28.466075Z","caller":"traceutil/trace.go:171","msg":"trace[703389963] transaction","detail":"{read_only:false; response_revision:3795; number_of_response:1; }","duration":"304.48094ms","start":"2026-06-15T19:10:28.161551Z","end":"2026-06-15T19:10:28.466032Z","steps":["trace[703389963] 'process raft request' (duration: 275.146499ms)","trace[703389963] 'compare' (duration: 29.023864ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:10:28.466124Z","caller":"traceutil/trace.go:171","msg":"trace[671725309] transaction","detail":"{read_only:false; response_revision:3796; number_of_response:1; }","duration":"152.20327ms","start":"2026-06-15T19:10:28.313872Z","end":"2026-06-15T19:10:28.466075Z","steps":["trace[671725309] 'process raft request' (duration: 152.028596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:10:28.467193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:10:28.161533Z","time spent":"304.631453ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:11:53.89382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.888659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-26fce431-0843-47a7-8391-7f629e6d621e\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-06-15T19:11:53.893896Z","caller":"traceutil/trace.go:171","msg":"trace[414164165] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-26fce431-0843-47a7-8391-7f629e6d621e; range_end:; response_count:1; response_revision:4987; }","duration":"156.008112ms","start":"2026-06-15T19:11:53.737871Z","end":"2026-06-15T19:11:53.893879Z","steps":["trace[414164165] 'range keys from in-memory index tree' (duration: 155.714205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:11:53.8939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.5487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-jrp5c-tls\" ","response":"range_response_count:1 size:1966"} {"level":"info","ts":"2026-06-15T19:11:53.893985Z","caller":"traceutil/trace.go:171","msg":"trace[613960411] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-jrp5c-tls; range_end:; response_count:1; response_revision:4987; }","duration":"204.688903ms","start":"2026-06-15T19:11:53.689275Z","end":"2026-06-15T19:11:53.893964Z","steps":["trace[613960411] 'range keys from in-memory index tree' (duration: 204.362035ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:11:54.299316Z","caller":"traceutil/trace.go:171","msg":"trace[2041014547] linearizableReadLoop","detail":"{readStateIndex:5175; appliedIndex:5174; }","duration":"135.960948ms","start":"2026-06-15T19:11:54.163326Z","end":"2026-06-15T19:11:54.299286Z","steps":["trace[2041014547] 'read index received' (duration: 135.847994ms)","trace[2041014547] 'applied index is now lower than readState.Index' (duration: 111.564µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:11:54.299372Z","caller":"traceutil/trace.go:171","msg":"trace[965301225] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"140.674059ms","start":"2026-06-15T19:11:54.158649Z","end":"2026-06-15T19:11:54.299323Z","steps":["trace[965301225] 'process raft request' (duration: 140.459863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:11:54.299571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.228805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-26fce431-0843-47a7-8391-7f629e6d621e\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-06-15T19:11:54.299673Z","caller":"traceutil/trace.go:171","msg":"trace[2131272625] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-26fce431-0843-47a7-8391-7f629e6d621e; range_end:; response_count:1; response_revision:4990; }","duration":"136.357667ms","start":"2026-06-15T19:11:54.163294Z","end":"2026-06-15T19:11:54.299651Z","steps":["trace[2131272625] 'agreement among raft nodes before linearized reading' (duration: 136.130492ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:11:54.380391Z","caller":"traceutil/trace.go:171","msg":"trace[1579202657] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"112.085562ms","start":"2026-06-15T19:11:54.268277Z","end":"2026-06-15T19:11:54.380363Z","steps":["trace[1579202657] 'process raft request' (duration: 46.623763ms)","trace[1579202657] 'compare' (duration: 65.07206ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:11:54.380529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.966911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786845"} {"level":"info","ts":"2026-06-15T19:11:54.380609Z","caller":"traceutil/trace.go:171","msg":"trace[553628255] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4991; }","duration":"189.121655ms","start":"2026-06-15T19:11:54.191471Z","end":"2026-06-15T19:11:54.380592Z","steps":["trace[553628255] 'agreement among raft nodes before linearized reading' (duration: 188.633073ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:11:54.469098Z","caller":"traceutil/trace.go:171","msg":"trace[225044442] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"164.895272ms","start":"2026-06-15T19:11:54.304173Z","end":"2026-06-15T19:11:54.469069Z","steps":["trace[225044442] 'process raft request' (duration: 164.79021ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:12:04.977744Z","caller":"traceutil/trace.go:171","msg":"trace[1485225333] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"129.514264ms","start":"2026-06-15T19:12:04.848207Z","end":"2026-06-15T19:12:04.977721Z","steps":["trace[1485225333] 'process raft request' (duration: 129.387161ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:12:04.980494Z","caller":"traceutil/trace.go:171","msg":"trace[293752729] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"130.415966ms","start":"2026-06-15T19:12:04.850051Z","end":"2026-06-15T19:12:04.980467Z","steps":["trace[293752729] 'process raft request' (duration: 129.73714ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:12:14.492603Z","caller":"traceutil/trace.go:171","msg":"trace[2070984189] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"124.807663ms","start":"2026-06-15T19:12:14.367752Z","end":"2026-06-15T19:12:14.49256Z","steps":["trace[2070984189] 'process raft request' (duration: 124.566637ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:12:14.871062Z","caller":"traceutil/trace.go:171","msg":"trace[2093587669] transaction","detail":"{read_only:false; response_revision:5390; number_of_response:1; }","duration":"172.83703ms","start":"2026-06-15T19:12:14.698197Z","end":"2026-06-15T19:12:14.871034Z","steps":["trace[2093587669] 'process raft request' (duration: 172.665826ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:12:14.885564Z","caller":"traceutil/trace.go:171","msg":"trace[1597993582] transaction","detail":"{read_only:false; response_revision:5391; number_of_response:1; }","duration":"186.903622ms","start":"2026-06-15T19:12:14.69862Z","end":"2026-06-15T19:12:14.885524Z","steps":["trace[1597993582] 'process raft request' (duration: 186.634866ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:13:27.866409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2969} {"level":"info","ts":"2026-06-15T19:13:27.937704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2969,"took":"69.29148ms","hash":1090647404,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":34177024,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-15T19:13:27.937762Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1090647404,"revision":2969,"compact-revision":-1} {"level":"info","ts":"2026-06-15T19:18:04.720814Z","caller":"traceutil/trace.go:171","msg":"trace[1785369941] transaction","detail":"{read_only:false; response_revision:8002; number_of_response:1; }","duration":"126.908336ms","start":"2026-06-15T19:18:04.593872Z","end":"2026-06-15T19:18:04.72078Z","steps":["trace[1785369941] 'process raft request' (duration: 126.692321ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:18:11.944558Z","caller":"traceutil/trace.go:171","msg":"trace[1167843103] linearizableReadLoop","detail":"{readStateIndex:8460; appliedIndex:8459; }","duration":"136.337764ms","start":"2026-06-15T19:18:11.808194Z","end":"2026-06-15T19:18:11.944531Z","steps":["trace[1167843103] 'read index received' (duration: 136.14978ms)","trace[1167843103] 'applied index is now lower than readState.Index' (duration: 186.424µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:18:11.944721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.502849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:18:11.944787Z","caller":"traceutil/trace.go:171","msg":"trace[1494342999] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:8176; }","duration":"136.627562ms","start":"2026-06-15T19:18:11.808142Z","end":"2026-06-15T19:18:11.944769Z","steps":["trace[1494342999] 'agreement among raft nodes before linearized reading' (duration: 136.503569ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:18:11.94485Z","caller":"traceutil/trace.go:171","msg":"trace[388794229] transaction","detail":"{read_only:false; response_revision:8176; number_of_response:1; }","duration":"220.220876ms","start":"2026-06-15T19:18:11.724611Z","end":"2026-06-15T19:18:11.944831Z","steps":["trace[388794229] 'process raft request' (duration: 219.755334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:18:23.965201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.577822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T19:18:23.965293Z","caller":"traceutil/trace.go:171","msg":"trace[1711827296] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:8240; }","duration":"139.682285ms","start":"2026-06-15T19:18:23.825591Z","end":"2026-06-15T19:18:23.965274Z","steps":["trace[1711827296] 'count revisions from in-memory index tree' (duration: 139.49918ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:18:24.492787Z","caller":"traceutil/trace.go:171","msg":"trace[1167914086] transaction","detail":"{read_only:false; response_revision:8243; number_of_response:1; }","duration":"123.047385ms","start":"2026-06-15T19:18:24.369716Z","end":"2026-06-15T19:18:24.492764Z","steps":["trace[1167914086] 'process raft request' (duration: 66.884222ms)","trace[1167914086] 'compare' (duration: 55.991229ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:18:27.873312Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6075} {"level":"info","ts":"2026-06-15T19:18:27.966297Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6075,"took":"91.002193ms","hash":3892766226,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":22749184,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-15T19:18:27.966366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3892766226,"revision":6075,"compact-revision":2969} {"level":"info","ts":"2026-06-15T19:18:51.923529Z","caller":"traceutil/trace.go:171","msg":"trace[1209894209] transaction","detail":"{read_only:false; response_revision:8444; number_of_response:1; }","duration":"114.694493ms","start":"2026-06-15T19:18:51.808809Z","end":"2026-06-15T19:18:51.923503Z","steps":["trace[1209894209] 'process raft request' (duration: 114.442197ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:19:04.097084Z","caller":"traceutil/trace.go:171","msg":"trace[846739383] linearizableReadLoop","detail":"{readStateIndex:8849; appliedIndex:8848; }","duration":"102.91438ms","start":"2026-06-15T19:19:03.994138Z","end":"2026-06-15T19:19:04.097052Z","steps":["trace[846739383] 'read index received' (duration: 96.968087ms)","trace[846739383] 'applied index is now lower than readState.Index' (duration: 5.945063ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:19:04.097129Z","caller":"traceutil/trace.go:171","msg":"trace[1267330396] transaction","detail":"{read_only:false; response_revision:8548; number_of_response:1; }","duration":"105.557582ms","start":"2026-06-15T19:19:03.991547Z","end":"2026-06-15T19:19:04.097105Z","steps":["trace[1267330396] 'process raft request' (duration: 99.553158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:19:04.097323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.171236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-c4m4h\" ","response":"range_response_count:1 size:2803"} {"level":"info","ts":"2026-06-15T19:19:04.097396Z","caller":"traceutil/trace.go:171","msg":"trace[735853817] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-c4m4h; range_end:; response_count:1; response_revision:8548; }","duration":"103.282649ms","start":"2026-06-15T19:19:03.994089Z","end":"2026-06-15T19:19:04.097371Z","steps":["trace[735853817] 'agreement among raft nodes before linearized reading' (duration: 103.096754ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:19:04.265208Z","caller":"traceutil/trace.go:171","msg":"trace[703237948] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8550; }","duration":"165.293252ms","start":"2026-06-15T19:19:04.099895Z","end":"2026-06-15T19:19:04.265188Z","steps":["trace[703237948] 'process raft request' (duration: 165.19446ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:19:04.265239Z","caller":"traceutil/trace.go:171","msg":"trace[1566347915] transaction","detail":"{read_only:false; response_revision:8549; number_of_response:1; }","duration":"269.235126ms","start":"2026-06-15T19:19:03.995969Z","end":"2026-06-15T19:19:04.265204Z","steps":["trace[1566347915] 'process raft request' (duration: 248.279662ms)","trace[1566347915] 'compare' (duration: 20.635717ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:19:04.265665Z","caller":"traceutil/trace.go:171","msg":"trace[1194762096] linearizableReadLoop","detail":"{readStateIndex:8850; appliedIndex:8849; }","duration":"168.489209ms","start":"2026-06-15T19:19:04.097158Z","end":"2026-06-15T19:19:04.265648Z","steps":["trace[1194762096] 'read index received' (duration: 147.104754ms)","trace[1194762096] 'applied index is now lower than readState.Index' (duration: 21.382405ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:19:04.26582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.184234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:19:04.265898Z","caller":"traceutil/trace.go:171","msg":"trace[248452351] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8550; }","duration":"171.4245ms","start":"2026-06-15T19:19:04.094453Z","end":"2026-06-15T19:19:04.265877Z","steps":["trace[248452351] 'agreement among raft nodes before linearized reading' (duration: 171.295257ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:19:04.74292Z","caller":"traceutil/trace.go:171","msg":"trace[2103603425] transaction","detail":"{read_only:false; response_revision:8553; number_of_response:1; }","duration":"102.95283ms","start":"2026-06-15T19:19:04.639941Z","end":"2026-06-15T19:19:04.742894Z","steps":["trace[2103603425] 'process raft request' (duration: 102.757876ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:19:04.896194Z","caller":"traceutil/trace.go:171","msg":"trace[199538404] linearizableReadLoop","detail":"{readStateIndex:8857; appliedIndex:8854; }","duration":"117.988923ms","start":"2026-06-15T19:19:04.778178Z","end":"2026-06-15T19:19:04.896167Z","steps":["trace[199538404] 'read index received' (duration: 117.579933ms)","trace[199538404] 'applied index is now lower than readState.Index' (duration: 407.72µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:19:04.896658Z","caller":"traceutil/trace.go:171","msg":"trace[1221002088] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"245.423733ms","start":"2026-06-15T19:19:04.65121Z","end":"2026-06-15T19:19:04.896634Z","steps":["trace[1221002088] 'process raft request' (duration: 244.832318ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:19:04.896703Z","caller":"traceutil/trace.go:171","msg":"trace[1127185527] transaction","detail":"{read_only:false; response_revision:8556; number_of_response:1; }","duration":"237.785859ms","start":"2026-06-15T19:19:04.658875Z","end":"2026-06-15T19:19:04.896661Z","steps":["trace[1127185527] 'process raft request' (duration: 237.237305ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:19:04.896563Z","caller":"traceutil/trace.go:171","msg":"trace[963881995] transaction","detail":"{read_only:false; response_revision:8554; number_of_response:1; }","duration":"246.329435ms","start":"2026-06-15T19:19:04.650189Z","end":"2026-06-15T19:19:04.896518Z","steps":["trace[963881995] 'process raft request' (duration: 245.678439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:19:04.896609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.388254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:19:04.896956Z","caller":"traceutil/trace.go:171","msg":"trace[564886034] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:8556; }","duration":"118.814573ms","start":"2026-06-15T19:19:04.778128Z","end":"2026-06-15T19:19:04.896943Z","steps":["trace[564886034] 'agreement among raft nodes before linearized reading' (duration: 118.308141ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:19:05.879038Z","caller":"traceutil/trace.go:171","msg":"trace[1171920037] transaction","detail":"{read_only:false; response_revision:8562; number_of_response:1; }","duration":"111.962838ms","start":"2026-06-15T19:19:05.767046Z","end":"2026-06-15T19:19:05.879009Z","steps":["trace[1171920037] 'process raft request' (duration: 111.764773ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:19:56.017238Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024b0.wal"} {"level":"info","ts":"2026-06-15T19:21:04.965371Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f823adf772f78a4c","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T19:21:04.970556Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-15T19:21:04.970653Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-15T19:23:27.878222Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8267} {"level":"info","ts":"2026-06-15T19:23:27.95746Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8267,"took":"76.379617ms","hash":2667692965,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":25649152,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-15T19:23:27.957565Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2667692965,"revision":8267,"compact-revision":6075} {"level":"info","ts":"2026-06-15T19:23:56.218053Z","caller":"traceutil/trace.go:171","msg":"trace[1348897449] transaction","detail":"{read_only:false; response_revision:11143; number_of_response:1; }","duration":"190.050691ms","start":"2026-06-15T19:23:56.027972Z","end":"2026-06-15T19:23:56.218022Z","steps":["trace[1348897449] 'process raft request' (duration: 189.856267ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:23:56.375004Z","caller":"traceutil/trace.go:171","msg":"trace[1906179893] transaction","detail":"{read_only:false; response_revision:11145; number_of_response:1; }","duration":"286.44504ms","start":"2026-06-15T19:23:56.088525Z","end":"2026-06-15T19:23:56.37497Z","steps":["trace[1906179893] 'process raft request' (duration: 286.372038ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:23:56.375061Z","caller":"traceutil/trace.go:171","msg":"trace[1336496240] transaction","detail":"{read_only:false; response_revision:11144; number_of_response:1; }","duration":"345.738612ms","start":"2026-06-15T19:23:56.029264Z","end":"2026-06-15T19:23:56.375003Z","steps":["trace[1336496240] 'process raft request' (duration: 297.690537ms)","trace[1336496240] 'compare' (duration: 47.687186ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:23:56.375311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:23:56.029243Z","time spent":"345.923556ms","remote":"127.0.0.1:35798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415205,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:28:27.884028Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10802} {"level":"info","ts":"2026-06-15T19:28:27.966888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10802,"took":"80.343869ms","hash":669484429,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":28192768,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-15T19:28:27.966948Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":669484429,"revision":10802,"compact-revision":8267} {"level":"info","ts":"2026-06-15T19:29:43.461863Z","caller":"traceutil/trace.go:171","msg":"trace[115553143] transaction","detail":"{read_only:false; response_revision:13522; number_of_response:1; }","duration":"128.905995ms","start":"2026-06-15T19:29:43.33292Z","end":"2026-06-15T19:29:43.461826Z","steps":["trace[115553143] 'process raft request' (duration: 128.636729ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:02.136696Z","caller":"traceutil/trace.go:171","msg":"trace[408694023] linearizableReadLoop","detail":"{readStateIndex:14088; appliedIndex:14087; }","duration":"164.964534ms","start":"2026-06-15T19:30:01.971707Z","end":"2026-06-15T19:30:02.136672Z","steps":["trace[408694023] 'read index received' (duration: 164.80797ms)","trace[408694023] 'applied index is now lower than readState.Index' (duration: 155.674µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:30:02.136802Z","caller":"traceutil/trace.go:171","msg":"trace[2129457560] transaction","detail":"{read_only:false; response_revision:13624; number_of_response:1; }","duration":"192.191555ms","start":"2026-06-15T19:30:01.94457Z","end":"2026-06-15T19:30:02.136762Z","steps":["trace[2129457560] 'process raft request' (duration: 191.930029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:30:02.136987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.270391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xqkqw\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-06-15T19:30:02.13703Z","caller":"traceutil/trace.go:171","msg":"trace[2022426433] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xqkqw; range_end:; response_count:1; response_revision:13624; }","duration":"165.386253ms","start":"2026-06-15T19:30:01.971633Z","end":"2026-06-15T19:30:02.13702Z","steps":["trace[2022426433] 'agreement among raft nodes before linearized reading' (duration: 165.162418ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:08.766137Z","caller":"traceutil/trace.go:171","msg":"trace[46697866] transaction","detail":"{read_only:false; response_revision:13657; number_of_response:1; }","duration":"103.649316ms","start":"2026-06-15T19:30:08.662466Z","end":"2026-06-15T19:30:08.766115Z","steps":["trace[46697866] 'process raft request' (duration: 103.493862ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:08.793532Z","caller":"traceutil/trace.go:171","msg":"trace[70181329] transaction","detail":"{read_only:false; response_revision:13659; number_of_response:1; }","duration":"126.785207ms","start":"2026-06-15T19:30:08.666726Z","end":"2026-06-15T19:30:08.793511Z","steps":["trace[70181329] 'process raft request' (duration: 126.741336ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:08.793848Z","caller":"traceutil/trace.go:171","msg":"trace[1648699073] transaction","detail":"{read_only:false; response_revision:13658; number_of_response:1; }","duration":"127.193456ms","start":"2026-06-15T19:30:08.666647Z","end":"2026-06-15T19:30:08.79384Z","steps":["trace[1648699073] 'process raft request' (duration: 125.724261ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:30:15.785925Z","caller":"traceutil/trace.go:171","msg":"trace[1086902022] transaction","detail":"{read_only:false; response_revision:13708; number_of_response:1; }","duration":"143.991194ms","start":"2026-06-15T19:30:15.641903Z","end":"2026-06-15T19:30:15.785894Z","steps":["trace[1086902022] 'process raft request' (duration: 131.130333ms)","trace[1086902022] 'compare' (duration: 12.673927ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:30:38.095568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.583919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:30:38.095719Z","caller":"traceutil/trace.go:171","msg":"trace[1985762038] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14025; }","duration":"123.797674ms","start":"2026-06-15T19:30:37.971898Z","end":"2026-06-15T19:30:38.095695Z","steps":["trace[1985762038] 'range keys from in-memory index tree' (duration: 123.390695ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:33:27.890527Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13002} {"level":"info","ts":"2026-06-15T19:33:27.967689Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13002,"took":"74.442837ms","hash":2623288567,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":31039488,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-15T19:33:27.967778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2623288567,"revision":13002,"compact-revision":10802} {"level":"warn","ts":"2026-06-15T19:37:24.406348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.252875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-9dmzl\" ","response":"range_response_count:1 size:20759"} {"level":"info","ts":"2026-06-15T19:37:24.406419Z","caller":"traceutil/trace.go:171","msg":"trace[1382405265] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-9dmzl; range_end:; response_count:1; response_revision:17270; }","duration":"139.364928ms","start":"2026-06-15T19:37:24.267041Z","end":"2026-06-15T19:37:24.406406Z","steps":["trace[1382405265] 'range keys from in-memory index tree' (duration: 139.084451ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:37:24.936967Z","caller":"traceutil/trace.go:171","msg":"trace[504046535] transaction","detail":"{read_only:false; response_revision:17273; number_of_response:1; }","duration":"128.633867ms","start":"2026-06-15T19:37:24.808307Z","end":"2026-06-15T19:37:24.936941Z","steps":["trace[504046535] 'process raft request' (duration: 128.483043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:37:25.190183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.270648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-15T19:37:25.1903Z","caller":"traceutil/trace.go:171","msg":"trace[267158547] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17273; }","duration":"149.453413ms","start":"2026-06-15T19:37:25.04082Z","end":"2026-06-15T19:37:25.190273Z","steps":["trace[267158547] 'range keys from in-memory index tree' (duration: 149.080903ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:37:25.216352Z","caller":"traceutil/trace.go:171","msg":"trace[1566302393] linearizableReadLoop","detail":"{readStateIndex:17858; appliedIndex:17857; }","duration":"165.958893ms","start":"2026-06-15T19:37:25.050369Z","end":"2026-06-15T19:37:25.216328Z","steps":["trace[1566302393] 'read index received' (duration: 165.82763ms)","trace[1566302393] 'applied index is now lower than readState.Index' (duration: 130.223µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:37:25.216467Z","caller":"traceutil/trace.go:171","msg":"trace[1467249672] transaction","detail":"{read_only:false; response_revision:17274; number_of_response:1; }","duration":"174.912682ms","start":"2026-06-15T19:37:25.041542Z","end":"2026-06-15T19:37:25.216455Z","steps":["trace[1467249672] 'process raft request' (duration: 174.600825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:37:25.216727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.331132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-15T19:37:25.216794Z","caller":"traceutil/trace.go:171","msg":"trace[2121886349] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17274; }","duration":"166.444896ms","start":"2026-06-15T19:37:25.050329Z","end":"2026-06-15T19:37:25.216774Z","steps":["trace[2121886349] 'agreement among raft nodes before linearized reading' (duration: 166.256892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:37:25.23117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.382398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:37:25.231211Z","caller":"traceutil/trace.go:171","msg":"trace[343547412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17276; }","duration":"139.473001ms","start":"2026-06-15T19:37:25.091728Z","end":"2026-06-15T19:37:25.231201Z","steps":["trace[343547412] 'agreement among raft nodes before linearized reading' (duration: 139.413819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:37:25.23134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.606983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-15T19:37:25.231374Z","caller":"traceutil/trace.go:171","msg":"trace[1163332802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17276; }","duration":"176.663734ms","start":"2026-06-15T19:37:25.054701Z","end":"2026-06-15T19:37:25.231364Z","steps":["trace[1163332802] 'agreement among raft nodes before linearized reading' (duration: 176.381957ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:38:27.896463Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15391} {"level":"info","ts":"2026-06-15T19:38:27.99934Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15391,"took":"99.454347ms","hash":1985956467,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":33710080,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-15T19:38:27.999417Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1985956467,"revision":15391,"compact-revision":13002} {"level":"info","ts":"2026-06-15T19:41:25.695581Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f823adf772f78a4c","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T19:41:25.700658Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-15T19:41:25.700788Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"warn","ts":"2026-06-15T19:43:07.370059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.017762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:43:07.370209Z","caller":"traceutil/trace.go:171","msg":"trace[485597281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19932; }","duration":"272.203367ms","start":"2026-06-15T19:43:07.097979Z","end":"2026-06-15T19:43:07.370182Z","steps":["trace[485597281] 'range keys from in-memory index tree' (duration: 271.804886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:07.804237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.560891ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:43:07.804795Z","caller":"traceutil/trace.go:171","msg":"trace[2054567718] transaction","detail":"{read_only:false; response_revision:19934; number_of_response:1; }","duration":"249.413249ms","start":"2026-06-15T19:43:07.555351Z","end":"2026-06-15T19:43:07.804765Z","steps":["trace[2054567718] 'process raft request' (duration: 114.197711ms)","trace[2054567718] 'compare' (duration: 134.245334ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:43:07.80508Z","caller":"traceutil/trace.go:171","msg":"trace[1243699457] linearizableReadLoop","detail":"{readStateIndex:20606; appliedIndex:20605; }","duration":"118.493886ms","start":"2026-06-15T19:43:07.686545Z","end":"2026-06-15T19:43:07.805039Z","steps":["trace[1243699457] 'read index received' (duration: 38.611µs)","trace[1243699457] 'applied index is now lower than readState.Index' (duration: 118.452185ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:43:07.805243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.694001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:43:07.805318Z","caller":"traceutil/trace.go:171","msg":"trace[851520625] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:19934; }","duration":"118.790263ms","start":"2026-06-15T19:43:07.686484Z","end":"2026-06-15T19:43:07.805275Z","steps":["trace[851520625] 'agreement among raft nodes before linearized reading' (duration: 118.702791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:08.202835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.866628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-15T19:43:08.202988Z","caller":"traceutil/trace.go:171","msg":"trace[1592655211] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19934; }","duration":"202.059652ms","start":"2026-06-15T19:43:08.000894Z","end":"2026-06-15T19:43:08.202953Z","steps":["trace[1592655211] 'range keys from in-memory index tree' (duration: 201.688733ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:43:08.342143Z","caller":"traceutil/trace.go:171","msg":"trace[461045113] transaction","detail":"{read_only:false; response_revision:19935; number_of_response:1; }","duration":"166.60062ms","start":"2026-06-15T19:43:08.175506Z","end":"2026-06-15T19:43:08.342106Z","steps":["trace[461045113] 'process raft request' (duration: 166.342684ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:43:08.65085Z","caller":"traceutil/trace.go:171","msg":"trace[464179484] linearizableReadLoop","detail":"{readStateIndex:20608; appliedIndex:20606; }","duration":"431.562243ms","start":"2026-06-15T19:43:08.21925Z","end":"2026-06-15T19:43:08.650812Z","steps":["trace[464179484] 'read index received' (duration: 122.668445ms)","trace[464179484] 'applied index is now lower than readState.Index' (duration: 308.892148ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:43:08.650874Z","caller":"traceutil/trace.go:171","msg":"trace[410573579] transaction","detail":"{read_only:false; response_revision:19936; number_of_response:1; }","duration":"440.517659ms","start":"2026-06-15T19:43:08.210316Z","end":"2026-06-15T19:43:08.650833Z","steps":["trace[410573579] 'process raft request' (duration: 342.655319ms)","trace[410573579] 'compare' (duration: 97.669356ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:43:08.651078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.210286Z","time spent":"440.697293ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:43:08.651194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.909462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-15T19:43:08.651303Z","caller":"traceutil/trace.go:171","msg":"trace[86047606] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19936; }","duration":"432.093066ms","start":"2026-06-15T19:43:08.219185Z","end":"2026-06-15T19:43:08.651278Z","steps":["trace[86047606] 'agreement among raft nodes before linearized reading' (duration: 431.740017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:08.651351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.219175Z","time spent":"432.166377ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-15T19:43:09.011251Z","caller":"traceutil/trace.go:171","msg":"trace[150255056] linearizableReadLoop","detail":"{readStateIndex:20610; appliedIndex:20608; }","duration":"360.278ms","start":"2026-06-15T19:43:08.650942Z","end":"2026-06-15T19:43:09.01122Z","steps":["trace[150255056] 'read index received' (duration: 360.042025ms)","trace[150255056] 'applied index is now lower than readState.Index' (duration: 234.115µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:43:09.011312Z","caller":"traceutil/trace.go:171","msg":"trace[1128382062] transaction","detail":"{read_only:false; response_revision:19938; number_of_response:1; }","duration":"493.908119ms","start":"2026-06-15T19:43:08.517361Z","end":"2026-06-15T19:43:09.011269Z","steps":["trace[1128382062] 'process raft request' (duration: 493.799577ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:43:09.011399Z","caller":"traceutil/trace.go:171","msg":"trace[1327444790] transaction","detail":"{read_only:false; response_revision:19937; number_of_response:1; }","duration":"495.319003ms","start":"2026-06-15T19:43:08.516031Z","end":"2026-06-15T19:43:09.01135Z","steps":["trace[1327444790] 'process raft request' (duration: 494.903504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.011535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.736119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:43:09.01163Z","caller":"traceutil/trace.go:171","msg":"trace[293155070] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:19938; }","duration":"429.912173ms","start":"2026-06-15T19:43:08.581665Z","end":"2026-06-15T19:43:09.011577Z","steps":["trace[293155070] 'agreement among raft nodes before linearized reading' (duration: 429.700158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.011677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.746341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-15T19:43:09.011715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.581637Z","time spent":"430.061737ms","remote":"127.0.0.1:55782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:43:09.011752Z","caller":"traceutil/trace.go:171","msg":"trace[17647169] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:19938; }","duration":"746.904935ms","start":"2026-06-15T19:43:08.264832Z","end":"2026-06-15T19:43:09.011737Z","steps":["trace[17647169] 'agreement among raft nodes before linearized reading' (duration: 746.678629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.011804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.264782Z","time spent":"747.009718ms","remote":"127.0.0.1:46634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":8,"response size":30,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:43:09.0116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.51735Z","time spent":"494.058793ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:43:09.011868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.508942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-06-15T19:43:09.011826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.490144ms","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-06-15T19:43:09.011958Z","caller":"traceutil/trace.go:171","msg":"trace[759194139] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:19938; }","duration":"638.650675ms","start":"2026-06-15T19:43:08.37329Z","end":"2026-06-15T19:43:09.011941Z","steps":["trace[759194139] 'agreement among raft nodes before linearized reading' (duration: 638.278846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.01204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.373265Z","time spent":"638.763208ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-15T19:43:09.01211Z","caller":"traceutil/trace.go:171","msg":"trace[1742892012] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:19938; }","duration":"716.962686ms","start":"2026-06-15T19:43:08.295081Z","end":"2026-06-15T19:43:09.012044Z","steps":["trace[1742892012] 'agreement among raft nodes before linearized reading' (duration: 716.381951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.011956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.515998Z","time spent":"495.508008ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:43:09.012233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.295056Z","time spent":"717.158201ms","remote":"127.0.0.1:55740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:43:09.284795Z","caller":"traceutil/trace.go:171","msg":"trace[929431222] transaction","detail":"{read_only:false; response_revision:19939; number_of_response:1; }","duration":"629.283711ms","start":"2026-06-15T19:43:08.655466Z","end":"2026-06-15T19:43:09.28475Z","steps":["trace[929431222] 'process raft request' (duration: 534.819532ms)","trace[929431222] 'compare' (duration: 94.09671ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:43:09.284846Z","caller":"traceutil/trace.go:171","msg":"trace[1227596183] linearizableReadLoop","detail":"{readStateIndex:20612; appliedIndex:20610; }","duration":"273.485697ms","start":"2026-06-15T19:43:09.011329Z","end":"2026-06-15T19:43:09.284815Z","steps":["trace[1227596183] 'read index received' (duration: 178.846245ms)","trace[1227596183] 'applied index is now lower than readState.Index' (duration: 94.638092ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:43:09.284962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.655437Z","time spent":"629.436205ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:43:09.284973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.375343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T19:43:09.285054Z","caller":"traceutil/trace.go:171","msg":"trace[1728775337] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:19940; }","duration":"350.531327ms","start":"2026-06-15T19:43:08.934503Z","end":"2026-06-15T19:43:09.285035Z","steps":["trace[1728775337] 'agreement among raft nodes before linearized reading' (duration: 350.380603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.285087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.934475Z","time spent":"350.604789ms","remote":"127.0.0.1:32888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:43:09.285145Z","caller":"traceutil/trace.go:171","msg":"trace[1577938156] transaction","detail":"{read_only:false; response_revision:19940; number_of_response:1; }","duration":"598.480601ms","start":"2026-06-15T19:43:08.686628Z","end":"2026-06-15T19:43:09.285108Z","steps":["trace[1577938156] 'process raft request' (duration: 598.032761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.285179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.535322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-06-15T19:43:09.28525Z","caller":"traceutil/trace.go:171","msg":"trace[2130017510] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:19940; }","duration":"411.677645ms","start":"2026-06-15T19:43:08.873544Z","end":"2026-06-15T19:43:09.285222Z","steps":["trace[2130017510] 'agreement among raft nodes before linearized reading' (duration: 411.45114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.285278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.746905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"warn","ts":"2026-06-15T19:43:09.285293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.819364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-15T19:43:09.285305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.873518Z","time spent":"411.773728ms","remote":"127.0.0.1:60790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-06-15T19:43:09.285321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.6866Z","time spent":"598.623545ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:43:09.285339Z","caller":"traceutil/trace.go:171","msg":"trace[579485542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19940; }","duration":"189.041119ms","start":"2026-06-15T19:43:09.096287Z","end":"2026-06-15T19:43:09.285328Z","steps":["trace[579485542] 'agreement among raft nodes before linearized reading' (duration: 188.947066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.285337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.97225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-15T19:43:09.285342Z","caller":"traceutil/trace.go:171","msg":"trace[1036463228] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:19940; }","duration":"388.839517ms","start":"2026-06-15T19:43:08.896485Z","end":"2026-06-15T19:43:09.285325Z","steps":["trace[1036463228] 'agreement among raft nodes before linearized reading' (duration: 388.442798ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:43:09.28539Z","caller":"traceutil/trace.go:171","msg":"trace[566503967] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19940; }","duration":"267.058323ms","start":"2026-06-15T19:43:09.018315Z","end":"2026-06-15T19:43:09.285373Z","steps":["trace[566503967] 'agreement among raft nodes before linearized reading' (duration: 266.862708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.285395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:43:08.89647Z","time spent":"388.913949ms","remote":"127.0.0.1:60728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":379,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"warn","ts":"2026-06-15T19:43:09.285404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.592893ms","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-06-15T19:43:09.285432Z","caller":"traceutil/trace.go:171","msg":"trace[381212570] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:19940; }","duration":"269.639694ms","start":"2026-06-15T19:43:09.015786Z","end":"2026-06-15T19:43:09.285426Z","steps":["trace[381212570] 'agreement among raft nodes before linearized reading' (duration: 269.560492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.285518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.096525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-15T19:43:09.285596Z","caller":"traceutil/trace.go:171","msg":"trace[1021910734] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19940; }","duration":"270.219368ms","start":"2026-06-15T19:43:09.015351Z","end":"2026-06-15T19:43:09.285571Z","steps":["trace[1021910734] 'agreement among raft nodes before linearized reading' (duration: 270.033414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:43:09.285805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.277829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-15T19:43:09.286099Z","caller":"traceutil/trace.go:171","msg":"trace[64080964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:19940; }","duration":"270.812052ms","start":"2026-06-15T19:43:09.015262Z","end":"2026-06-15T19:43:09.286074Z","steps":["trace[64080964] 'agreement among raft nodes before linearized reading' (duration: 269.897501ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:43:27.903661Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17970} {"level":"info","ts":"2026-06-15T19:43:28.036722Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17970,"took":"125.999286ms","hash":3115292536,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":29016064,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-15T19:43:28.03681Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3115292536,"revision":17970,"compact-revision":15391} {"level":"info","ts":"2026-06-15T19:47:01.563015Z","caller":"traceutil/trace.go:171","msg":"trace[1134379035] transaction","detail":"{read_only:false; response_revision:22350; number_of_response:1; }","duration":"132.450111ms","start":"2026-06-15T19:47:01.430546Z","end":"2026-06-15T19:47:01.562997Z","steps":["trace[1134379035] 'process raft request' (duration: 132.333048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:47:01.879192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.846567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:47:01.879279Z","caller":"traceutil/trace.go:171","msg":"trace[1636053917] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:22351; }","duration":"231.989161ms","start":"2026-06-15T19:47:01.647269Z","end":"2026-06-15T19:47:01.879258Z","steps":["trace[1636053917] 'count revisions from in-memory index tree' (duration: 231.728374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:47:01.880056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.204304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-15T19:47:01.880126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.648074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:47:01.880157Z","caller":"traceutil/trace.go:171","msg":"trace[299661529] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:22351; }","duration":"164.355167ms","start":"2026-06-15T19:47:01.715776Z","end":"2026-06-15T19:47:01.880131Z","steps":["trace[299661529] 'count revisions from in-memory index tree' (duration: 164.092351ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:47:01.880185Z","caller":"traceutil/trace.go:171","msg":"trace[1376465161] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:22351; }","duration":"124.727305ms","start":"2026-06-15T19:47:01.755428Z","end":"2026-06-15T19:47:01.880155Z","steps":["trace[1376465161] 'count revisions from in-memory index tree' (duration: 124.565742ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:47:02.006596Z","caller":"traceutil/trace.go:171","msg":"trace[624555384] transaction","detail":"{read_only:false; response_revision:22352; number_of_response:1; }","duration":"101.761043ms","start":"2026-06-15T19:47:01.904796Z","end":"2026-06-15T19:47:02.006557Z","steps":["trace[624555384] 'process raft request' (duration: 101.532507ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:48:27.912674Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20036} {"level":"info","ts":"2026-06-15T19:48:28.014365Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20036,"took":"98.112167ms","hash":1907709989,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":41005056,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-06-15T19:48:28.014435Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1907709989,"revision":20036,"compact-revision":17970} {"level":"info","ts":"2026-06-15T19:50:20.915366Z","caller":"traceutil/trace.go:171","msg":"trace[378368328] transaction","detail":"{read_only:false; response_revision:24407; number_of_response:1; }","duration":"149.122931ms","start":"2026-06-15T19:50:20.766216Z","end":"2026-06-15T19:50:20.915339Z","steps":["trace[378368328] 'process raft request' (duration: 144.867438ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:25.769926Z","caller":"traceutil/trace.go:171","msg":"trace[871176203] transaction","detail":"{read_only:false; response_revision:24448; number_of_response:1; }","duration":"130.235426ms","start":"2026-06-15T19:50:25.639666Z","end":"2026-06-15T19:50:25.769901Z","steps":["trace[871176203] 'process raft request' (duration: 130.046791ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:25.982965Z","caller":"traceutil/trace.go:171","msg":"trace[1235374433] linearizableReadLoop","detail":"{readStateIndex:25249; appliedIndex:25248; }","duration":"310.705196ms","start":"2026-06-15T19:50:25.672241Z","end":"2026-06-15T19:50:25.982946Z","steps":["trace[1235374433] 'read index received' (duration: 97.700217ms)","trace[1235374433] 'applied index is now lower than readState.Index' (duration: 213.004139ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:25.983189Z","caller":"traceutil/trace.go:171","msg":"trace[101089220] transaction","detail":"{read_only:false; response_revision:24449; number_of_response:1; }","duration":"341.247816ms","start":"2026-06-15T19:50:25.64193Z","end":"2026-06-15T19:50:25.983178Z","steps":["trace[101089220] 'process raft request' (duration: 340.910588ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:25.983284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:25.641914Z","time spent":"341.306837ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:50:25.983517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.273549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-15T19:50:25.983556Z","caller":"traceutil/trace.go:171","msg":"trace[780631609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24449; }","duration":"311.340911ms","start":"2026-06-15T19:50:25.672204Z","end":"2026-06-15T19:50:25.983545Z","steps":["trace[780631609] 'agreement among raft nodes before linearized reading' (duration: 311.230978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:25.983589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:25.672187Z","time spent":"311.395462ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:50:25.988966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.536496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:25.989034Z","caller":"traceutil/trace.go:171","msg":"trace[1567788976] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:24450; }","duration":"254.618528ms","start":"2026-06-15T19:50:25.734397Z","end":"2026-06-15T19:50:25.989016Z","steps":["trace[1567788976] 'agreement among raft nodes before linearized reading' (duration: 254.487324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:25.989135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.59781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T19:50:25.98917Z","caller":"traceutil/trace.go:171","msg":"trace[1121292848] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:24450; }","duration":"236.660732ms","start":"2026-06-15T19:50:25.752501Z","end":"2026-06-15T19:50:25.989162Z","steps":["trace[1121292848] 'agreement among raft nodes before linearized reading' (duration: 236.603911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:26.238293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.032426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:50:26.238392Z","caller":"traceutil/trace.go:171","msg":"trace[1886137493] linearizableReadLoop","detail":"{readStateIndex:25251; appliedIndex:25250; }","duration":"146.243223ms","start":"2026-06-15T19:50:26.092135Z","end":"2026-06-15T19:50:26.238378Z","steps":["trace[1886137493] 'read index received' (duration: 24.041383ms)","trace[1886137493] 'applied index is now lower than readState.Index' (duration: 122.20065ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:26.238475Z","caller":"traceutil/trace.go:171","msg":"trace[563962740] transaction","detail":"{read_only:false; response_revision:24451; number_of_response:1; }","duration":"242.74059ms","start":"2026-06-15T19:50:25.995722Z","end":"2026-06-15T19:50:26.238462Z","steps":["trace[563962740] 'process raft request' (duration: 120.463758ms)","trace[563962740] 'compare' (duration: 121.924943ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:26.238706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.56639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-15T19:50:26.238742Z","caller":"traceutil/trace.go:171","msg":"trace[687562827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24451; }","duration":"146.631311ms","start":"2026-06-15T19:50:26.092098Z","end":"2026-06-15T19:50:26.23873Z","steps":["trace[687562827] 'agreement among raft nodes before linearized reading' (duration: 146.509138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:26.238713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.430247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:26.238793Z","caller":"traceutil/trace.go:171","msg":"trace[387371624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24451; }","duration":"146.55918ms","start":"2026-06-15T19:50:26.092212Z","end":"2026-06-15T19:50:26.238771Z","steps":["trace[387371624] 'agreement among raft nodes before linearized reading' (duration: 146.415187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:26.62975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.667827ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T19:50:26.630009Z","caller":"traceutil/trace.go:171","msg":"trace[1522381911] transaction","detail":"{read_only:false; response_revision:24453; number_of_response:1; }","duration":"287.573086ms","start":"2026-06-15T19:50:26.342421Z","end":"2026-06-15T19:50:26.629994Z","steps":["trace[1522381911] 'process raft request' (duration: 287.415682ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:26.936469Z","caller":"traceutil/trace.go:171","msg":"trace[593738390] linearizableReadLoop","detail":"{readStateIndex:25255; appliedIndex:25254; }","duration":"277.319597ms","start":"2026-06-15T19:50:26.659095Z","end":"2026-06-15T19:50:26.936414Z","steps":["trace[593738390] 'read index received' (duration: 259.129457ms)","trace[593738390] 'applied index is now lower than readState.Index' (duration: 18.18871ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:26.93648Z","caller":"traceutil/trace.go:171","msg":"trace[1570775407] transaction","detail":"{read_only:false; response_revision:24454; number_of_response:1; }","duration":"281.914058ms","start":"2026-06-15T19:50:26.654522Z","end":"2026-06-15T19:50:26.936436Z","steps":["trace[1570775407] 'process raft request' (duration: 263.593034ms)","trace[1570775407] 'compare' (duration: 17.968335ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:26.936626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.513152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:26.936673Z","caller":"traceutil/trace.go:171","msg":"trace[968443678] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24454; }","duration":"277.605014ms","start":"2026-06-15T19:50:26.659053Z","end":"2026-06-15T19:50:26.936658Z","steps":["trace[968443678] 'agreement among raft nodes before linearized reading' (duration: 277.498211ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:26.937025Z","caller":"traceutil/trace.go:171","msg":"trace[1569582898] transaction","detail":"{read_only:false; response_revision:24455; number_of_response:1; }","duration":"171.011083ms","start":"2026-06-15T19:50:26.765989Z","end":"2026-06-15T19:50:26.937Z","steps":["trace[1569582898] 'process raft request' (duration: 170.90848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:27.316673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.483003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:50:27.316815Z","caller":"traceutil/trace.go:171","msg":"trace[787946640] linearizableReadLoop","detail":"{readStateIndex:25258; appliedIndex:25257; }","duration":"223.824022ms","start":"2026-06-15T19:50:27.092967Z","end":"2026-06-15T19:50:27.316791Z","steps":["trace[787946640] 'read index received' (duration: 83.017432ms)","trace[787946640] 'applied index is now lower than readState.Index' (duration: 140.8044ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:27.316863Z","caller":"traceutil/trace.go:171","msg":"trace[221801384] transaction","detail":"{read_only:false; response_revision:24457; number_of_response:1; }","duration":"311.229209ms","start":"2026-06-15T19:50:27.005593Z","end":"2026-06-15T19:50:27.316822Z","steps":["trace[221801384] 'process raft request' (duration: 170.473039ms)","trace[221801384] 'compare' (duration: 139.957331ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:27.317052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:27.005569Z","time spent":"311.382222ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:50:27.317232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.266732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:27.317292Z","caller":"traceutil/trace.go:171","msg":"trace[1740455251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24457; }","duration":"224.377724ms","start":"2026-06-15T19:50:27.092896Z","end":"2026-06-15T19:50:27.317274Z","steps":["trace[1740455251] 'agreement among raft nodes before linearized reading' (duration: 223.996725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:27.394289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.612204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-15T19:50:27.394384Z","caller":"traceutil/trace.go:171","msg":"trace[1544914665] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24458; }","duration":"291.749297ms","start":"2026-06-15T19:50:27.102607Z","end":"2026-06-15T19:50:27.394356Z","steps":["trace[1544914665] 'agreement among raft nodes before linearized reading' (duration: 291.504491ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:27.551657Z","caller":"traceutil/trace.go:171","msg":"trace[647308742] transaction","detail":"{read_only:false; response_revision:24459; number_of_response:1; }","duration":"152.872283ms","start":"2026-06-15T19:50:27.39875Z","end":"2026-06-15T19:50:27.551622Z","steps":["trace[647308742] 'process raft request' (duration: 138.079985ms)","trace[647308742] 'compare' (duration: 14.384628ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:27.843784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.575483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:50:27.843902Z","caller":"traceutil/trace.go:171","msg":"trace[1162267166] linearizableReadLoop","detail":"{readStateIndex:25262; appliedIndex:25261; }","duration":"273.546566ms","start":"2026-06-15T19:50:27.570336Z","end":"2026-06-15T19:50:27.843882Z","steps":["trace[1162267166] 'read index received' (duration: 123.790279ms)","trace[1162267166] 'applied index is now lower than readState.Index' (duration: 149.754837ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:27.844009Z","caller":"traceutil/trace.go:171","msg":"trace[1396046251] transaction","detail":"{read_only:false; response_revision:24461; number_of_response:1; }","duration":"287.81687ms","start":"2026-06-15T19:50:27.556176Z","end":"2026-06-15T19:50:27.843992Z","steps":["trace[1396046251] 'process raft request' (duration: 137.94004ms)","trace[1396046251] 'compare' (duration: 149.179604ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:27.844264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.925695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-06-15T19:50:27.844301Z","caller":"traceutil/trace.go:171","msg":"trace[2661865] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24461; }","duration":"273.993276ms","start":"2026-06-15T19:50:27.570298Z","end":"2026-06-15T19:50:27.844292Z","steps":["trace[2661865] 'agreement among raft nodes before linearized reading' (duration: 273.854942ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:28.00307Z","caller":"traceutil/trace.go:171","msg":"trace[1096447637] transaction","detail":"{read_only:false; response_revision:24462; number_of_response:1; }","duration":"153.747334ms","start":"2026-06-15T19:50:27.849303Z","end":"2026-06-15T19:50:28.00305Z","steps":["trace[1096447637] 'process raft request' (duration: 138.332681ms)","trace[1096447637] 'compare' (duration: 15.014344ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:28.002982Z","caller":"traceutil/trace.go:171","msg":"trace[579051999] linearizableReadLoop","detail":"{readStateIndex:25263; appliedIndex:25262; }","duration":"150.26319ms","start":"2026-06-15T19:50:27.852689Z","end":"2026-06-15T19:50:28.002952Z","steps":["trace[579051999] 'read index received' (duration: 134.876128ms)","trace[579051999] 'applied index is now lower than readState.Index' (duration: 15.385342ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:28.00345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.611629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-06-15T19:50:28.003526Z","caller":"traceutil/trace.go:171","msg":"trace[281959253] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24462; }","duration":"150.889185ms","start":"2026-06-15T19:50:27.852618Z","end":"2026-06-15T19:50:28.003507Z","steps":["trace[281959253] 'agreement among raft nodes before linearized reading' (duration: 150.507766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:28.003821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.789603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:28.00387Z","caller":"traceutil/trace.go:171","msg":"trace[1880909091] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24463; }","duration":"129.892347ms","start":"2026-06-15T19:50:27.873962Z","end":"2026-06-15T19:50:28.003855Z","steps":["trace[1880909091] 'agreement among raft nodes before linearized reading' (duration: 129.789134ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:28.296424Z","caller":"traceutil/trace.go:171","msg":"trace[522100017] transaction","detail":"{read_only:false; response_revision:24465; number_of_response:1; }","duration":"127.618712ms","start":"2026-06-15T19:50:28.168773Z","end":"2026-06-15T19:50:28.296391Z","steps":["trace[522100017] 'process raft request' (duration: 127.53457ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:28.29694Z","caller":"traceutil/trace.go:171","msg":"trace[1819270335] transaction","detail":"{read_only:false; response_revision:24464; number_of_response:1; }","duration":"288.675802ms","start":"2026-06-15T19:50:28.008249Z","end":"2026-06-15T19:50:28.296924Z","steps":["trace[1819270335] 'process raft request' (duration: 250.21153ms)","trace[1819270335] 'compare' (duration: 36.980576ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:28.297076Z","caller":"traceutil/trace.go:171","msg":"trace[1790122628] linearizableReadLoop","detail":"{readStateIndex:25265; appliedIndex:25264; }","duration":"139.209492ms","start":"2026-06-15T19:50:28.157821Z","end":"2026-06-15T19:50:28.29703Z","steps":["trace[1790122628] 'read index received' (duration: 100.653368ms)","trace[1790122628] 'applied index is now lower than readState.Index' (duration: 38.549834ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:28.297355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.52381ms","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-06-15T19:50:28.297387Z","caller":"traceutil/trace.go:171","msg":"trace[643607459] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24465; }","duration":"139.625382ms","start":"2026-06-15T19:50:28.157753Z","end":"2026-06-15T19:50:28.297378Z","steps":["trace[643607459] 'agreement among raft nodes before linearized reading' (duration: 139.448448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:28.632216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.600847ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:50:28.632302Z","caller":"traceutil/trace.go:171","msg":"trace[1230952734] linearizableReadLoop","detail":"{readStateIndex:25268; appliedIndex:25267; }","duration":"226.787843ms","start":"2026-06-15T19:50:28.405502Z","end":"2026-06-15T19:50:28.63229Z","steps":["trace[1230952734] 'read index received' (duration: 93.077014ms)","trace[1230952734] 'applied index is now lower than readState.Index' (duration: 133.709989ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:28.632512Z","caller":"traceutil/trace.go:171","msg":"trace[2108003742] transaction","detail":"{read_only:false; response_revision:24467; number_of_response:1; }","duration":"326.736065ms","start":"2026-06-15T19:50:28.305762Z","end":"2026-06-15T19:50:28.632498Z","steps":["trace[2108003742] 'process raft request' (duration: 192.78872ms)","trace[2108003742] 'compare' (duration: 133.288779ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:28.632567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:28.305741Z","time spent":"326.800036ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:50:28.632726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.200414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:28.632839Z","caller":"traceutil/trace.go:171","msg":"trace[1113280068] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24467; }","duration":"227.362168ms","start":"2026-06-15T19:50:28.405451Z","end":"2026-06-15T19:50:28.632813Z","steps":["trace[1113280068] 'agreement among raft nodes before linearized reading' (duration: 227.165183ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:29.154584Z","caller":"traceutil/trace.go:171","msg":"trace[779465607] transaction","detail":"{read_only:false; response_revision:24470; number_of_response:1; }","duration":"212.792514ms","start":"2026-06-15T19:50:28.941759Z","end":"2026-06-15T19:50:29.154551Z","steps":["trace[779465607] 'process raft request' (duration: 212.18971ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:29.154651Z","caller":"traceutil/trace.go:171","msg":"trace[251367501] transaction","detail":"{read_only:false; response_revision:24471; number_of_response:1; }","duration":"211.879433ms","start":"2026-06-15T19:50:28.942726Z","end":"2026-06-15T19:50:29.154605Z","steps":["trace[251367501] 'process raft request' (duration: 211.401891ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:29.449988Z","caller":"traceutil/trace.go:171","msg":"trace[1715010390] transaction","detail":"{read_only:false; response_revision:24472; number_of_response:1; }","duration":"127.100849ms","start":"2026-06-15T19:50:29.322849Z","end":"2026-06-15T19:50:29.44995Z","steps":["trace[1715010390] 'process raft request' (duration: 79.574308ms)","trace[1715010390] 'compare' (duration: 47.375857ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:29.673363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.477811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-15T19:50:29.673951Z","caller":"traceutil/trace.go:171","msg":"trace[897512911] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24472; }","duration":"117.103356ms","start":"2026-06-15T19:50:29.556818Z","end":"2026-06-15T19:50:29.673922Z","steps":["trace[897512911] 'range keys from in-memory index tree' (duration: 116.298976ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:29.674068Z","caller":"traceutil/trace.go:171","msg":"trace[1016709123] transaction","detail":"{read_only:false; response_revision:24473; number_of_response:1; }","duration":"117.171958ms","start":"2026-06-15T19:50:29.556879Z","end":"2026-06-15T19:50:29.674051Z","steps":["trace[1016709123] 'process raft request' (duration: 116.317327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:30.010405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.393646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-15T19:50:30.010482Z","caller":"traceutil/trace.go:171","msg":"trace[1632826548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24474; }","duration":"160.516259ms","start":"2026-06-15T19:50:29.849949Z","end":"2026-06-15T19:50:30.010465Z","steps":["trace[1632826548] 'range keys from in-memory index tree' (duration: 160.221272ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:30.181847Z","caller":"traceutil/trace.go:171","msg":"trace[1099144204] transaction","detail":"{read_only:false; response_revision:24475; number_of_response:1; }","duration":"173.375799ms","start":"2026-06-15T19:50:30.008448Z","end":"2026-06-15T19:50:30.181824Z","steps":["trace[1099144204] 'process raft request' (duration: 173.235446ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:30.200865Z","caller":"traceutil/trace.go:171","msg":"trace[1882054847] linearizableReadLoop","detail":"{readStateIndex:25278; appliedIndex:25275; }","duration":"107.809732ms","start":"2026-06-15T19:50:30.093036Z","end":"2026-06-15T19:50:30.200845Z","steps":["trace[1882054847] 'read index received' (duration: 88.696239ms)","trace[1882054847] 'applied index is now lower than readState.Index' (duration: 19.112683ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:30.201002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.952705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:30.201029Z","caller":"traceutil/trace.go:171","msg":"trace[1463782981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24477; }","duration":"108.030597ms","start":"2026-06-15T19:50:30.092991Z","end":"2026-06-15T19:50:30.201022Z","steps":["trace[1463782981] 'agreement among raft nodes before linearized reading' (duration: 107.931245ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:30.201301Z","caller":"traceutil/trace.go:171","msg":"trace[1529417046] transaction","detail":"{read_only:false; response_revision:24476; number_of_response:1; }","duration":"188.140937ms","start":"2026-06-15T19:50:30.013149Z","end":"2026-06-15T19:50:30.20129Z","steps":["trace[1529417046] 'process raft request' (duration: 187.540132ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:30.201438Z","caller":"traceutil/trace.go:171","msg":"trace[1671998087] transaction","detail":"{read_only:false; response_revision:24477; number_of_response:1; }","duration":"187.745827ms","start":"2026-06-15T19:50:30.013681Z","end":"2026-06-15T19:50:30.201427Z","steps":["trace[1671998087] 'process raft request' (duration: 187.123922ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:30.495076Z","caller":"traceutil/trace.go:171","msg":"trace[426310062] transaction","detail":"{read_only:false; response_revision:24478; number_of_response:1; }","duration":"142.257316ms","start":"2026-06-15T19:50:30.352796Z","end":"2026-06-15T19:50:30.495054Z","steps":["trace[426310062] 'process raft request' (duration: 142.072882ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:30.656007Z","caller":"traceutil/trace.go:171","msg":"trace[284528822] linearizableReadLoop","detail":"{readStateIndex:25280; appliedIndex:25278; }","duration":"198.249642ms","start":"2026-06-15T19:50:30.457732Z","end":"2026-06-15T19:50:30.655981Z","steps":["trace[284528822] 'read index received' (duration: 37.170381ms)","trace[284528822] 'applied index is now lower than readState.Index' (duration: 161.078171ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:30.656039Z","caller":"traceutil/trace.go:171","msg":"trace[1425958445] transaction","detail":"{read_only:false; response_revision:24479; number_of_response:1; }","duration":"299.974885ms","start":"2026-06-15T19:50:30.356028Z","end":"2026-06-15T19:50:30.656003Z","steps":["trace[1425958445] 'process raft request' (duration: 256.051671ms)","trace[1425958445] 'compare' (duration: 43.701489ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:30.656083Z","caller":"traceutil/trace.go:171","msg":"trace[1152351239] transaction","detail":"{read_only:false; response_revision:24480; number_of_response:1; }","duration":"196.274103ms","start":"2026-06-15T19:50:30.459777Z","end":"2026-06-15T19:50:30.656052Z","steps":["trace[1152351239] 'process raft request' (duration: 196.13681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:30.656175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:30.356018Z","time spent":"300.086678ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:50:30.656232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.477988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:30.656321Z","caller":"traceutil/trace.go:171","msg":"trace[642517847] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0; response_count:0; response_revision:24480; }","duration":"198.623211ms","start":"2026-06-15T19:50:30.457676Z","end":"2026-06-15T19:50:30.656299Z","steps":["trace[642517847] 'agreement among raft nodes before linearized reading' (duration: 198.426077ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:30.925911Z","caller":"traceutil/trace.go:171","msg":"trace[1099611780] transaction","detail":"{read_only:false; response_revision:24481; number_of_response:1; }","duration":"266.085465ms","start":"2026-06-15T19:50:30.659789Z","end":"2026-06-15T19:50:30.925875Z","steps":["trace[1099611780] 'process raft request' (duration: 183.528206ms)","trace[1099611780] 'compare' (duration: 82.318703ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:30.925977Z","caller":"traceutil/trace.go:171","msg":"trace[289475024] transaction","detail":"{read_only:false; response_revision:24482; number_of_response:1; }","duration":"239.064711ms","start":"2026-06-15T19:50:30.686885Z","end":"2026-06-15T19:50:30.925949Z","steps":["trace[289475024] 'process raft request' (duration: 238.925867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:31.379828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.302211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T19:50:31.379893Z","caller":"traceutil/trace.go:171","msg":"trace[907510326] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:24486; }","duration":"112.420083ms","start":"2026-06-15T19:50:31.267457Z","end":"2026-06-15T19:50:31.379877Z","steps":["trace[907510326] 'count revisions from in-memory index tree' (duration: 112.195637ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:36.879269Z","caller":"traceutil/trace.go:171","msg":"trace[76576980] transaction","detail":"{read_only:false; response_revision:24524; number_of_response:1; }","duration":"194.741028ms","start":"2026-06-15T19:50:36.684498Z","end":"2026-06-15T19:50:36.879239Z","steps":["trace[76576980] 'process raft request' (duration: 194.569563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:41.643482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.493586ms","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":"info","ts":"2026-06-15T19:50:41.643567Z","caller":"traceutil/trace.go:171","msg":"trace[533715854] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:24559; }","duration":"323.624788ms","start":"2026-06-15T19:50:41.319922Z","end":"2026-06-15T19:50:41.643547Z","steps":["trace[533715854] 'count revisions from in-memory index tree' (duration: 323.421843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:41.643644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:41.319905Z","time spent":"323.69756ms","remote":"127.0.0.1:32946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":54,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:50:41.643886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.713451ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:50:41.643998Z","caller":"traceutil/trace.go:171","msg":"trace[2119178522] linearizableReadLoop","detail":"{readStateIndex:25364; appliedIndex:25363; }","duration":"117.842584ms","start":"2026-06-15T19:50:41.526138Z","end":"2026-06-15T19:50:41.64398Z","steps":["trace[2119178522] 'read index received' (duration: 48.081µs)","trace[2119178522] 'applied index is now lower than readState.Index' (duration: 117.793373ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:41.644064Z","caller":"traceutil/trace.go:171","msg":"trace[2068254740] transaction","detail":"{read_only:false; response_revision:24560; number_of_response:1; }","duration":"138.568156ms","start":"2026-06-15T19:50:41.50547Z","end":"2026-06-15T19:50:41.644038Z","steps":["trace[2068254740] 'process raft request' (duration: 20.622729ms)","trace[2068254740] 'compare' (duration: 117.431664ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:41.644104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.961637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:41.644135Z","caller":"traceutil/trace.go:171","msg":"trace[115209354] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:24560; }","duration":"118.032079ms","start":"2026-06-15T19:50:41.526093Z","end":"2026-06-15T19:50:41.644125Z","steps":["trace[115209354] 'agreement among raft nodes before linearized reading' (duration: 117.973957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:43.578171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.792243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:43.578247Z","caller":"traceutil/trace.go:171","msg":"trace[221493848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24572; }","duration":"484.915916ms","start":"2026-06-15T19:50:43.093312Z","end":"2026-06-15T19:50:43.578228Z","steps":["trace[221493848] 'range keys from in-memory index tree' (duration: 484.68419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:43.578285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:43.09329Z","time spent":"484.986248ms","remote":"127.0.0.1:60630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T19:50:43.578347Z","caller":"traceutil/trace.go:171","msg":"trace[310661919] transaction","detail":"{read_only:false; response_revision:24573; number_of_response:1; }","duration":"379.893022ms","start":"2026-06-15T19:50:43.198444Z","end":"2026-06-15T19:50:43.578337Z","steps":["trace[310661919] 'process raft request' (duration: 332.214307ms)","trace[310661919] 'compare' (duration: 47.414619ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:43.578424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:43.198417Z","time spent":"379.955744ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:50:43.578502Z","caller":"traceutil/trace.go:171","msg":"trace[2119902651] transaction","detail":"{read_only:false; response_revision:24574; number_of_response:1; }","duration":"348.540862ms","start":"2026-06-15T19:50:43.229935Z","end":"2026-06-15T19:50:43.578476Z","steps":["trace[2119902651] 'process raft request' (duration: 348.345217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:43.578627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:43.229901Z","time spent":"348.680425ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:50:43.899765Z","caller":"traceutil/trace.go:171","msg":"trace[64274853] transaction","detail":"{read_only:false; response_revision:24575; number_of_response:1; }","duration":"250.18711ms","start":"2026-06-15T19:50:43.649539Z","end":"2026-06-15T19:50:43.899726Z","steps":["trace[64274853] 'process raft request' (duration: 242.35359ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:43.899954Z","caller":"traceutil/trace.go:171","msg":"trace[1882599903] linearizableReadLoop","detail":"{readStateIndex:25380; appliedIndex:25378; }","duration":"129.310902ms","start":"2026-06-15T19:50:43.770614Z","end":"2026-06-15T19:50:43.899925Z","steps":["trace[1882599903] 'read index received' (duration: 121.294418ms)","trace[1882599903] 'applied index is now lower than readState.Index' (duration: 8.015264ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:43.900068Z","caller":"traceutil/trace.go:171","msg":"trace[717117693] transaction","detail":"{read_only:false; response_revision:24576; number_of_response:1; }","duration":"176.510616ms","start":"2026-06-15T19:50:43.723527Z","end":"2026-06-15T19:50:43.900038Z","steps":["trace[717117693] 'process raft request' (duration: 176.006144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:43.900119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.488776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:43.900168Z","caller":"traceutil/trace.go:171","msg":"trace[1827999187] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:24576; }","duration":"129.590858ms","start":"2026-06-15T19:50:43.770564Z","end":"2026-06-15T19:50:43.900155Z","steps":["trace[1827999187] 'agreement among raft nodes before linearized reading' (duration: 129.492006ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:43.900279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.77362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-15T19:50:43.900321Z","caller":"traceutil/trace.go:171","msg":"trace[663814291] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24576; }","duration":"126.875083ms","start":"2026-06-15T19:50:43.773435Z","end":"2026-06-15T19:50:43.90031Z","steps":["trace[663814291] 'agreement among raft nodes before linearized reading' (duration: 126.636277ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:44.185372Z","caller":"traceutil/trace.go:171","msg":"trace[1180813004] linearizableReadLoop","detail":"{readStateIndex:25381; appliedIndex:25380; }","duration":"235.135825ms","start":"2026-06-15T19:50:43.950214Z","end":"2026-06-15T19:50:44.18535Z","steps":["trace[1180813004] 'read index received' (duration: 234.949851ms)","trace[1180813004] 'applied index is now lower than readState.Index' (duration: 185.324µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:44.185619Z","caller":"traceutil/trace.go:171","msg":"trace[628709886] transaction","detail":"{read_only:false; response_revision:24577; number_of_response:1; }","duration":"279.637614ms","start":"2026-06-15T19:50:43.90597Z","end":"2026-06-15T19:50:44.185607Z","steps":["trace[628709886] 'process raft request' (duration: 279.268535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:44.185835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.623707ms","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-06-15T19:50:44.185859Z","caller":"traceutil/trace.go:171","msg":"trace[1587300418] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24577; }","duration":"235.706269ms","start":"2026-06-15T19:50:43.950144Z","end":"2026-06-15T19:50:44.185851Z","steps":["trace[1587300418] 'agreement among raft nodes before linearized reading' (duration: 235.603327ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:44.48576Z","caller":"traceutil/trace.go:171","msg":"trace[386462241] linearizableReadLoop","detail":"{readStateIndex:25382; appliedIndex:25381; }","duration":"228.920825ms","start":"2026-06-15T19:50:44.256818Z","end":"2026-06-15T19:50:44.485739Z","steps":["trace[386462241] 'read index received' (duration: 227.166202ms)","trace[386462241] 'applied index is now lower than readState.Index' (duration: 1.753543ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:44.485885Z","caller":"traceutil/trace.go:171","msg":"trace[1146829705] transaction","detail":"{read_only:false; response_revision:24578; number_of_response:1; }","duration":"255.421216ms","start":"2026-06-15T19:50:44.230451Z","end":"2026-06-15T19:50:44.485873Z","steps":["trace[1146829705] 'process raft request' (duration: 253.549231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:44.486126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.010184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-15T19:50:44.486186Z","caller":"traceutil/trace.go:171","msg":"trace[1195579566] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24578; }","duration":"221.102535ms","start":"2026-06-15T19:50:44.265066Z","end":"2026-06-15T19:50:44.486168Z","steps":["trace[1195579566] 'agreement among raft nodes before linearized reading' (duration: 220.917221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:44.486332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.490259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:44.48642Z","caller":"traceutil/trace.go:171","msg":"trace[383497243] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24578; }","duration":"229.623582ms","start":"2026-06-15T19:50:44.256771Z","end":"2026-06-15T19:50:44.486394Z","steps":["trace[383497243] 'agreement among raft nodes before linearized reading' (duration: 229.493469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:44.486372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.187374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-15T19:50:44.486513Z","caller":"traceutil/trace.go:171","msg":"trace[623653550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24578; }","duration":"220.325197ms","start":"2026-06-15T19:50:44.266153Z","end":"2026-06-15T19:50:44.486478Z","steps":["trace[623653550] 'agreement among raft nodes before linearized reading' (duration: 220.171773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:45.074438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.69384ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:50:45.074544Z","caller":"traceutil/trace.go:171","msg":"trace[525405246] linearizableReadLoop","detail":"{readStateIndex:25385; appliedIndex:25384; }","duration":"370.659368ms","start":"2026-06-15T19:50:44.703868Z","end":"2026-06-15T19:50:45.074528Z","steps":["trace[525405246] 'read index received' (duration: 96.730112ms)","trace[525405246] 'applied index is now lower than readState.Index' (duration: 273.927786ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:45.074642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.76892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:45.074614Z","caller":"traceutil/trace.go:171","msg":"trace[8592870] transaction","detail":"{read_only:false; response_revision:24581; number_of_response:1; }","duration":"517.504575ms","start":"2026-06-15T19:50:44.557052Z","end":"2026-06-15T19:50:45.074557Z","steps":["trace[8592870] 'process raft request' (duration: 243.59806ms)","trace[8592870] 'compare' (duration: 273.341042ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:45.074673Z","caller":"traceutil/trace.go:171","msg":"trace[935331943] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:24581; }","duration":"370.827692ms","start":"2026-06-15T19:50:44.703834Z","end":"2026-06-15T19:50:45.074662Z","steps":["trace[935331943] 'agreement among raft nodes before linearized reading' (duration: 370.7618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:45.074709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:44.703815Z","time spent":"370.884493ms","remote":"127.0.0.1:60870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":142,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:50:45.074774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:44.557037Z","time spent":"517.653738ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:50:45.390469Z","caller":"traceutil/trace.go:171","msg":"trace[1256506470] transaction","detail":"{read_only:false; response_revision:24582; number_of_response:1; }","duration":"401.780352ms","start":"2026-06-15T19:50:44.988667Z","end":"2026-06-15T19:50:45.390447Z","steps":["trace[1256506470] 'process raft request' (duration: 348.205294ms)","trace[1256506470] 'compare' (duration: 53.488686ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:45.390587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:44.988644Z","time spent":"401.881665ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:50:46.006684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.654525ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:50:46.006798Z","caller":"traceutil/trace.go:171","msg":"trace[505449139] transaction","detail":"{read_only:false; response_revision:24583; number_of_response:1; }","duration":"965.741112ms","start":"2026-06-15T19:50:45.04103Z","end":"2026-06-15T19:50:46.006771Z","steps":["trace[505449139] 'process raft request' (duration: 616.919443ms)","trace[505449139] 'compare' (duration: 348.529132ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:46.006878Z","caller":"traceutil/trace.go:171","msg":"trace[1956875547] transaction","detail":"{read_only:false; response_revision:24585; number_of_response:1; }","duration":"419.497722ms","start":"2026-06-15T19:50:45.587371Z","end":"2026-06-15T19:50:46.006869Z","steps":["trace[1956875547] 'process raft request' (duration: 419.462401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.006891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:45.041009Z","time spent":"965.834065ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:50:46.006926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:45.587345Z","time spent":"419.557593ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:50:46.0071Z","caller":"traceutil/trace.go:171","msg":"trace[2007787073] transaction","detail":"{read_only:false; response_revision:24584; number_of_response:1; }","duration":"420.591648ms","start":"2026-06-15T19:50:45.586497Z","end":"2026-06-15T19:50:46.007088Z","steps":["trace[2007787073] 'process raft request' (duration: 420.26869ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:46.007107Z","caller":"traceutil/trace.go:171","msg":"trace[1166351605] linearizableReadLoop","detail":"{readStateIndex:25387; appliedIndex:25385; }","duration":"932.498646ms","start":"2026-06-15T19:50:45.074568Z","end":"2026-06-15T19:50:46.007067Z","steps":["trace[1166351605] 'read index received' (duration: 262.320954ms)","trace[1166351605] 'applied index is now lower than readState.Index' (duration: 670.173592ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:46.007158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:45.586478Z","time spent":"420.650139ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:50:46.007364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014975504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-15T19:50:46.007404Z","caller":"traceutil/trace.go:171","msg":"trace[1300740348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24585; }","duration":"1.015070896s","start":"2026-06-15T19:50:44.992323Z","end":"2026-06-15T19:50:46.007394Z","steps":["trace[1300740348] 'agreement among raft nodes before linearized reading' (duration: 1.014884742s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.007441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:44.992301Z","time spent":"1.015132158s","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:50:46.007504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.094507672s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-15T19:50:46.007544Z","caller":"traceutil/trace.go:171","msg":"trace[664418251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24585; }","duration":"1.094578913s","start":"2026-06-15T19:50:44.912955Z","end":"2026-06-15T19:50:46.007534Z","steps":["trace[664418251] 'agreement among raft nodes before linearized reading' (duration: 1.09445295s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.007577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:44.912935Z","time spent":"1.094635634s","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T19:50:46.007882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.010426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-15T19:50:46.008109Z","caller":"traceutil/trace.go:171","msg":"trace[264227165] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:24585; }","duration":"989.314473ms","start":"2026-06-15T19:50:45.018693Z","end":"2026-06-15T19:50:46.008008Z","steps":["trace[264227165] 'agreement among raft nodes before linearized reading' (duration: 988.437322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.008221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:45.01867Z","time spent":"989.526868ms","remote":"127.0.0.1:35374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":161,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:50:46.009066Z","caller":"traceutil/trace.go:171","msg":"trace[318054977] transaction","detail":"{read_only:false; response_revision:24586; number_of_response:1; }","duration":"338.401117ms","start":"2026-06-15T19:50:45.670652Z","end":"2026-06-15T19:50:46.009053Z","steps":["trace[318054977] 'process raft request' (duration: 337.019973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.009168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:45.670616Z","time spent":"338.492839ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:50:46.140523Z","caller":"traceutil/trace.go:171","msg":"trace[1199750138] transaction","detail":"{read_only:false; response_revision:24587; number_of_response:1; }","duration":"235.477324ms","start":"2026-06-15T19:50:45.905012Z","end":"2026-06-15T19:50:46.140489Z","steps":["trace[1199750138] 'process raft request' (duration: 234.768656ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:46.140643Z","caller":"traceutil/trace.go:171","msg":"trace[21475589] linearizableReadLoop","detail":"{readStateIndex:25392; appliedIndex:25389; }","duration":"133.443703ms","start":"2026-06-15T19:50:46.007178Z","end":"2026-06-15T19:50:46.140621Z","steps":["trace[21475589] 'read index received' (duration: 1.691911ms)","trace[21475589] 'applied index is now lower than readState.Index' (duration: 131.750772ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:46.140691Z","caller":"traceutil/trace.go:171","msg":"trace[963995460] transaction","detail":"{read_only:false; response_revision:24588; number_of_response:1; }","duration":"233.077546ms","start":"2026-06-15T19:50:45.907582Z","end":"2026-06-15T19:50:46.14066Z","steps":["trace[963995460] 'process raft request' (duration: 232.83792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.140894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.580213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:46.141872Z","caller":"traceutil/trace.go:171","msg":"trace[1830144030] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:24588; }","duration":"735.601658ms","start":"2026-06-15T19:50:45.406256Z","end":"2026-06-15T19:50:46.141858Z","steps":["trace[1830144030] 'agreement among raft nodes before linearized reading' (duration: 734.568733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.14192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:45.406241Z","time spent":"735.663879ms","remote":"127.0.0.1:54380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:50:46.141127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.701294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T19:50:46.14202Z","caller":"traceutil/trace.go:171","msg":"trace[1506296759] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:24588; }","duration":"557.623237ms","start":"2026-06-15T19:50:45.584384Z","end":"2026-06-15T19:50:46.142007Z","steps":["trace[1506296759] 'agreement among raft nodes before linearized reading' (duration: 556.534431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.141123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047470732s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:46.142125Z","caller":"traceutil/trace.go:171","msg":"trace[1427692394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24588; }","duration":"1.048526097s","start":"2026-06-15T19:50:45.093575Z","end":"2026-06-15T19:50:46.142101Z","steps":["trace[1427692394] 'agreement among raft nodes before linearized reading' (duration: 1.047480232s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.142184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:45.093548Z","time spent":"1.048617139s","remote":"127.0.0.1:60618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T19:50:46.142055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:45.584368Z","time spent":"557.677168ms","remote":"127.0.0.1:32884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":54,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:50:46.141192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.050427143s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:50:46.142334Z","caller":"traceutil/trace.go:171","msg":"trace[1870799579] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:24588; }","duration":"1.05154597s","start":"2026-06-15T19:50:45.090754Z","end":"2026-06-15T19:50:46.1423Z","steps":["trace[1870799579] 'agreement among raft nodes before linearized reading' (duration: 1.050408553s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:46.142433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:45.090683Z","time spent":"1.051715714s","remote":"127.0.0.1:46634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-06-15T19:50:46.142604Z","caller":"traceutil/trace.go:171","msg":"trace[1971331081] transaction","detail":"{read_only:false; response_revision:24589; number_of_response:1; }","duration":"128.999984ms","start":"2026-06-15T19:50:46.013581Z","end":"2026-06-15T19:50:46.142581Z","steps":["trace[1971331081] 'process raft request' (duration: 128.726308ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:46.142803Z","caller":"traceutil/trace.go:171","msg":"trace[1951896639] transaction","detail":"{read_only:false; response_revision:24590; number_of_response:1; }","duration":"128.779889ms","start":"2026-06-15T19:50:46.014009Z","end":"2026-06-15T19:50:46.142789Z","steps":["trace[1951896639] 'process raft request' (duration: 128.462622ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:47.526993Z","caller":"traceutil/trace.go:171","msg":"trace[448992275] linearizableReadLoop","detail":"{readStateIndex:25459; appliedIndex:25458; }","duration":"104.84683ms","start":"2026-06-15T19:50:47.422122Z","end":"2026-06-15T19:50:47.526969Z","steps":["trace[448992275] 'read index received' (duration: 104.782348ms)","trace[448992275] 'applied index is now lower than readState.Index' (duration: 63.622µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:47.527111Z","caller":"traceutil/trace.go:171","msg":"trace[506237075] transaction","detail":"{read_only:false; response_revision:24654; number_of_response:1; }","duration":"130.143042ms","start":"2026-06-15T19:50:47.39692Z","end":"2026-06-15T19:50:47.527063Z","steps":["trace[506237075] 'process raft request' (duration: 129.914946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:47.527184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.038625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d4587f61-4a76-490a-bf29-68ab26e5bca0\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-06-15T19:50:47.527252Z","caller":"traceutil/trace.go:171","msg":"trace[91303730] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d4587f61-4a76-490a-bf29-68ab26e5bca0; range_end:; response_count:1; response_revision:24654; }","duration":"105.161438ms","start":"2026-06-15T19:50:47.422074Z","end":"2026-06-15T19:50:47.527236Z","steps":["trace[91303730] 'agreement among raft nodes before linearized reading' (duration: 105.022494ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:47.650398Z","caller":"traceutil/trace.go:171","msg":"trace[2086197957] linearizableReadLoop","detail":"{readStateIndex:25460; appliedIndex:25459; }","duration":"123.307417ms","start":"2026-06-15T19:50:47.527064Z","end":"2026-06-15T19:50:47.650371Z","steps":["trace[2086197957] 'read index received' (duration: 120.629283ms)","trace[2086197957] 'applied index is now lower than readState.Index' (duration: 2.677074ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:47.650537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.763332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d4587f61-4a76-490a-bf29-68ab26e5bca0\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-06-15T19:50:47.65058Z","caller":"traceutil/trace.go:171","msg":"trace[562963189] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d4587f61-4a76-490a-bf29-68ab26e5bca0; range_end:; response_count:1; response_revision:24655; }","duration":"157.851054ms","start":"2026-06-15T19:50:47.492716Z","end":"2026-06-15T19:50:47.650567Z","steps":["trace[562963189] 'agreement among raft nodes before linearized reading' (duration: 157.750172ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:47.650595Z","caller":"traceutil/trace.go:171","msg":"trace[1299420277] transaction","detail":"{read_only:false; response_revision:24655; number_of_response:1; }","duration":"227.510832ms","start":"2026-06-15T19:50:47.423038Z","end":"2026-06-15T19:50:47.650549Z","steps":["trace[1299420277] 'process raft request' (duration: 224.589421ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:47.65732Z","caller":"traceutil/trace.go:171","msg":"trace[752485857] transaction","detail":"{read_only:false; response_revision:24656; number_of_response:1; }","duration":"122.938768ms","start":"2026-06-15T19:50:47.534364Z","end":"2026-06-15T19:50:47.657302Z","steps":["trace[752485857] 'process raft request' (duration: 122.842416ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:52.623477Z","caller":"traceutil/trace.go:171","msg":"trace[1944456005] transaction","detail":"{read_only:false; response_revision:24714; number_of_response:1; }","duration":"111.504561ms","start":"2026-06-15T19:50:52.511946Z","end":"2026-06-15T19:50:52.62345Z","steps":["trace[1944456005] 'process raft request' (duration: 111.358668ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:52.923825Z","caller":"traceutil/trace.go:171","msg":"trace[332067148] linearizableReadLoop","detail":"{readStateIndex:25522; appliedIndex:25521; }","duration":"390.022717ms","start":"2026-06-15T19:50:52.533752Z","end":"2026-06-15T19:50:52.923775Z","steps":["trace[332067148] 'read index received' (duration: 89.742324ms)","trace[332067148] 'applied index is now lower than readState.Index' (duration: 300.278753ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:52.924091Z","caller":"traceutil/trace.go:171","msg":"trace[530611528] transaction","detail":"{read_only:false; response_revision:24715; number_of_response:1; }","duration":"410.75891ms","start":"2026-06-15T19:50:52.513289Z","end":"2026-06-15T19:50:52.924048Z","steps":["trace[530611528] 'process raft request' (duration: 396.353891ms)","trace[530611528] 'compare' (duration: 13.843845ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:50:52.92425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:52.513264Z","time spent":"410.915584ms","remote":"127.0.0.1:54228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7681,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:50:52.924246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.439177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10361"} {"level":"info","ts":"2026-06-15T19:50:52.92462Z","caller":"traceutil/trace.go:171","msg":"trace[1529533297] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24715; }","duration":"390.913438ms","start":"2026-06-15T19:50:52.533691Z","end":"2026-06-15T19:50:52.924604Z","steps":["trace[1529533297] 'agreement among raft nodes before linearized reading' (duration: 390.322504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:52.924681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:52.533673Z","time spent":"390.994831ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10383,"request content":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" "} {"level":"info","ts":"2026-06-15T19:50:52.927137Z","caller":"traceutil/trace.go:171","msg":"trace[73106357] transaction","detail":"{read_only:false; response_revision:24716; number_of_response:1; }","duration":"271.669251ms","start":"2026-06-15T19:50:52.655447Z","end":"2026-06-15T19:50:52.927116Z","steps":["trace[73106357] 'process raft request' (duration: 271.555588ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:52.927421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.324926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-15T19:50:52.927505Z","caller":"traceutil/trace.go:171","msg":"trace[1082236775] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24716; }","duration":"376.442138ms","start":"2026-06-15T19:50:52.551043Z","end":"2026-06-15T19:50:52.927485Z","steps":["trace[1082236775] 'agreement among raft nodes before linearized reading' (duration: 376.10553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:52.927577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:52.55101Z","time spent":"376.53227ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-15T19:50:52.927705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.164988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-15T19:50:52.927737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.974353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-06-15T19:50:52.927753Z","caller":"traceutil/trace.go:171","msg":"trace[794427070] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24716; }","duration":"375.25579ms","start":"2026-06-15T19:50:52.552486Z","end":"2026-06-15T19:50:52.927742Z","steps":["trace[794427070] 'agreement among raft nodes before linearized reading' (duration: 375.149617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:52.927781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:52.552475Z","time spent":"375.301871ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-15T19:50:52.927785Z","caller":"traceutil/trace.go:171","msg":"trace[1655936542] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24716; }","duration":"302.058916ms","start":"2026-06-15T19:50:52.625713Z","end":"2026-06-15T19:50:52.927772Z","steps":["trace[1655936542] 'agreement among raft nodes before linearized reading' (duration: 301.855551ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:52.927811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:50:52.625692Z","time spent":"302.113387ms","remote":"127.0.0.1:60790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1882,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "} {"level":"info","ts":"2026-06-15T19:50:53.047243Z","caller":"traceutil/trace.go:171","msg":"trace[1748682427] linearizableReadLoop","detail":"{readStateIndex:25526; appliedIndex:25524; }","duration":"100.258548ms","start":"2026-06-15T19:50:52.946959Z","end":"2026-06-15T19:50:53.047218Z","steps":["trace[1748682427] 'read index received' (duration: 99.972121ms)","trace[1748682427] 'applied index is now lower than readState.Index' (duration: 285.227µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:50:53.047414Z","caller":"traceutil/trace.go:171","msg":"trace[1545216947] transaction","detail":"{read_only:false; response_revision:24718; number_of_response:1; }","duration":"113.905719ms","start":"2026-06-15T19:50:52.933444Z","end":"2026-06-15T19:50:53.047349Z","steps":["trace[1545216947] 'process raft request' (duration: 113.560961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:50:53.047452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.971844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T19:50:53.04751Z","caller":"traceutil/trace.go:171","msg":"trace[1562409771] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:24719; }","duration":"110.066026ms","start":"2026-06-15T19:50:52.937429Z","end":"2026-06-15T19:50:53.047495Z","steps":["trace[1562409771] 'agreement among raft nodes before linearized reading' (duration: 109.949353ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:50:53.047682Z","caller":"traceutil/trace.go:171","msg":"trace[340558144] transaction","detail":"{read_only:false; response_revision:24719; number_of_response:1; }","duration":"111.718517ms","start":"2026-06-15T19:50:52.935856Z","end":"2026-06-15T19:50:53.047575Z","steps":["trace[340558144] 'process raft request' (duration: 111.296687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:22.86796Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965514677340517762,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T19:51:23.131647Z","caller":"traceutil/trace.go:171","msg":"trace[1935138317] transaction","detail":"{read_only:false; response_revision:24957; number_of_response:1; }","duration":"802.864166ms","start":"2026-06-15T19:51:22.32876Z","end":"2026-06-15T19:51:23.131625Z","steps":["trace[1935138317] 'process raft request' (duration: 802.700172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:23.131767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:22.328743Z","time spent":"802.967029ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:23.396264Z","caller":"traceutil/trace.go:171","msg":"trace[311137571] transaction","detail":"{read_only:false; response_revision:24958; number_of_response:1; }","duration":"1.047251637s","start":"2026-06-15T19:51:22.348976Z","end":"2026-06-15T19:51:23.396227Z","steps":["trace[311137571] 'process raft request' (duration: 1.017848964s)","trace[311137571] 'compare' (duration: 29.202468ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:23.396411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:22.348945Z","time spent":"1.047395809s","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:23.396414Z","caller":"traceutil/trace.go:171","msg":"trace[1233276015] transaction","detail":"{read_only:false; response_revision:24959; number_of_response:1; }","duration":"636.009085ms","start":"2026-06-15T19:51:22.760372Z","end":"2026-06-15T19:51:23.396381Z","steps":["trace[1233276015] 'process raft request' (duration: 635.816751ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:23.396416Z","caller":"traceutil/trace.go:171","msg":"trace[632101448] transaction","detail":"{read_only:false; response_revision:24960; number_of_response:1; }","duration":"566.946893ms","start":"2026-06-15T19:51:22.829442Z","end":"2026-06-15T19:51:23.396388Z","steps":["trace[632101448] 'process raft request' (duration: 566.846331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:23.396563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:22.829419Z","time spent":"567.069296ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:51:23.396898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:22.760356Z","time spent":"636.456166ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:23.396694Z","caller":"traceutil/trace.go:171","msg":"trace[418222789] transaction","detail":"{read_only:false; response_revision:24961; number_of_response:1; }","duration":"538.7331ms","start":"2026-06-15T19:51:22.857932Z","end":"2026-06-15T19:51:23.396665Z","steps":["trace[418222789] 'process raft request' (duration: 538.401922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:23.397116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:22.857907Z","time spent":"539.17024ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:23.396699Z","caller":"traceutil/trace.go:171","msg":"trace[586441736] transaction","detail":"{read_only:false; response_revision:24962; number_of_response:1; }","duration":"431.317097ms","start":"2026-06-15T19:51:22.965355Z","end":"2026-06-15T19:51:23.396672Z","steps":["trace[586441736] 'process raft request' (duration: 431.155953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:23.39682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029540637s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-15T19:51:23.397236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:22.965331Z","time spent":"431.85024ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:23.397312Z","caller":"traceutil/trace.go:171","msg":"trace[872379003] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:24962; }","duration":"1.03004726s","start":"2026-06-15T19:51:22.36723Z","end":"2026-06-15T19:51:23.397277Z","steps":["trace[872379003] 'agreement among raft nodes before linearized reading' (duration: 1.029512487s)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:23.396618Z","caller":"traceutil/trace.go:171","msg":"trace[1619656193] linearizableReadLoop","detail":"{readStateIndex:25775; appliedIndex:25771; }","duration":"1.029337352s","start":"2026-06-15T19:51:22.367259Z","end":"2026-06-15T19:51:23.396597Z","steps":["trace[1619656193] 'read index received' (duration: 764.445976ms)","trace[1619656193] 'applied index is now lower than readState.Index' (duration: 264.890616ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:23.39739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:22.367217Z","time spent":"1.030143022s","remote":"127.0.0.1:50738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:51:23.397773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.058125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:51:23.397806Z","caller":"traceutil/trace.go:171","msg":"trace[1941281334] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:24962; }","duration":"394.093826ms","start":"2026-06-15T19:51:23.003705Z","end":"2026-06-15T19:51:23.397799Z","steps":["trace[1941281334] 'agreement among raft nodes before linearized reading' (duration: 394.030015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:23.397802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.822868ms","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":"warn","ts":"2026-06-15T19:51:23.397826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:23.003638Z","time spent":"394.182948ms","remote":"127.0.0.1:33726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:51:23.397817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.347725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-15T19:51:23.397818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.256353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-15T19:51:23.397854Z","caller":"traceutil/trace.go:171","msg":"trace[1339979934] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:24962; }","duration":"317.9093ms","start":"2026-06-15T19:51:23.07993Z","end":"2026-06-15T19:51:23.39784Z","steps":["trace[1339979934] 'agreement among raft nodes before linearized reading' (duration: 317.831858ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:23.397861Z","caller":"traceutil/trace.go:171","msg":"trace[2017735352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24962; }","duration":"132.418657ms","start":"2026-06-15T19:51:23.265431Z","end":"2026-06-15T19:51:23.397849Z","steps":["trace[2017735352] 'agreement among raft nodes before linearized reading' (duration: 132.281044ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:23.39788Z","caller":"traceutil/trace.go:171","msg":"trace[259419613] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24962; }","duration":"319.343675ms","start":"2026-06-15T19:51:23.078521Z","end":"2026-06-15T19:51:23.397865Z","steps":["trace[259419613] 'agreement among raft nodes before linearized reading' (duration: 319.197561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:23.397874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01478527s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-06-15T19:51:23.397916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:23.078503Z","time spent":"319.406417ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-15T19:51:23.397959Z","caller":"traceutil/trace.go:171","msg":"trace[1857344242] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24962; }","duration":"1.014907353s","start":"2026-06-15T19:51:22.383029Z","end":"2026-06-15T19:51:23.397936Z","steps":["trace[1857344242] 'agreement among raft nodes before linearized reading' (duration: 1.014604065s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:23.398014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:22.383018Z","time spent":"1.014986525s","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-15T19:51:23.398016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.904353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-15T19:51:23.397903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:23.079907Z","time spent":"317.976141ms","remote":"127.0.0.1:55740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:51:23.398054Z","caller":"traceutil/trace.go:171","msg":"trace[1361872726] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24962; }","duration":"216.940014ms","start":"2026-06-15T19:51:23.181104Z","end":"2026-06-15T19:51:23.398044Z","steps":["trace[1361872726] 'agreement among raft nodes before linearized reading' (duration: 216.821491ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:23.67428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.234666ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:51:23.674562Z","caller":"traceutil/trace.go:171","msg":"trace[748787230] transaction","detail":"{read_only:false; response_revision:24963; number_of_response:1; }","duration":"273.169657ms","start":"2026-06-15T19:51:23.401323Z","end":"2026-06-15T19:51:23.674492Z","steps":["trace[748787230] 'process raft request' (duration: 130.624315ms)","trace[748787230] 'compare' (duration: 141.986859ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:23.674831Z","caller":"traceutil/trace.go:171","msg":"trace[330616520] transaction","detail":"{read_only:false; response_revision:24965; number_of_response:1; }","duration":"272.276004ms","start":"2026-06-15T19:51:23.402544Z","end":"2026-06-15T19:51:23.67482Z","steps":["trace[330616520] 'process raft request' (duration: 271.898675ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:23.674584Z","caller":"traceutil/trace.go:171","msg":"trace[143726014] transaction","detail":"{read_only:false; response_revision:24966; number_of_response:1; }","duration":"271.431574ms","start":"2026-06-15T19:51:23.40313Z","end":"2026-06-15T19:51:23.674562Z","steps":["trace[143726014] 'process raft request' (duration: 271.348602ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:23.674624Z","caller":"traceutil/trace.go:171","msg":"trace[665335590] transaction","detail":"{read_only:false; response_revision:24964; number_of_response:1; }","duration":"272.135651ms","start":"2026-06-15T19:51:23.402481Z","end":"2026-06-15T19:51:23.674616Z","steps":["trace[665335590] 'process raft request' (duration: 271.898306ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:23.676134Z","caller":"traceutil/trace.go:171","msg":"trace[1816901658] transaction","detail":"{read_only:false; response_revision:24967; number_of_response:1; }","duration":"133.177966ms","start":"2026-06-15T19:51:23.542935Z","end":"2026-06-15T19:51:23.676113Z","steps":["trace[1816901658] 'process raft request' (duration: 133.029261ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:23.832101Z","caller":"traceutil/trace.go:171","msg":"trace[268306402] transaction","detail":"{read_only:false; response_revision:24968; number_of_response:1; }","duration":"149.029429ms","start":"2026-06-15T19:51:23.683048Z","end":"2026-06-15T19:51:23.832078Z","steps":["trace[268306402] 'process raft request' (duration: 148.897176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:24.51124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.103619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:51:24.511425Z","caller":"traceutil/trace.go:171","msg":"trace[774004334] transaction","detail":"{read_only:false; response_revision:24971; number_of_response:1; }","duration":"337.065205ms","start":"2026-06-15T19:51:24.174346Z","end":"2026-06-15T19:51:24.511411Z","steps":["trace[774004334] 'process raft request' (duration: 336.984773ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:24.511425Z","caller":"traceutil/trace.go:171","msg":"trace[204041428] transaction","detail":"{read_only:false; response_revision:24970; number_of_response:1; }","duration":"341.495932ms","start":"2026-06-15T19:51:24.169895Z","end":"2026-06-15T19:51:24.511391Z","steps":["trace[204041428] 'process raft request' (duration: 202.137616ms)","trace[204041428] 'compare' (duration: 138.933416ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:24.51152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:24.174337Z","time spent":"337.118066ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:24.511563Z","caller":"traceutil/trace.go:171","msg":"trace[702982596] linearizableReadLoop","detail":"{readStateIndex:25786; appliedIndex:25783; }","duration":"222.879169ms","start":"2026-06-15T19:51:24.288654Z","end":"2026-06-15T19:51:24.511534Z","steps":["trace[702982596] 'read index received' (duration: 83.412101ms)","trace[702982596] 'applied index is now lower than readState.Index' (duration: 139.465088ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:24.511577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:24.16988Z","time spent":"341.617684ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:24.511594Z","caller":"traceutil/trace.go:171","msg":"trace[600702933] transaction","detail":"{read_only:false; response_revision:24972; number_of_response:1; }","duration":"227.337116ms","start":"2026-06-15T19:51:24.284229Z","end":"2026-06-15T19:51:24.511566Z","steps":["trace[600702933] 'process raft request' (duration: 227.154721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:24.511695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.029472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:51:24.511757Z","caller":"traceutil/trace.go:171","msg":"trace[680991086] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/ports/; range_end:/registry/openstack.k-orc.cloud/ports0; response_count:0; response_revision:24972; }","duration":"223.138805ms","start":"2026-06-15T19:51:24.288602Z","end":"2026-06-15T19:51:24.511741Z","steps":["trace[680991086] 'agreement among raft nodes before linearized reading' (duration: 223.035143ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:25.282135Z","caller":"traceutil/trace.go:171","msg":"trace[777957598] transaction","detail":"{read_only:false; response_revision:24973; number_of_response:1; }","duration":"143.644799ms","start":"2026-06-15T19:51:25.138466Z","end":"2026-06-15T19:51:25.282111Z","steps":["trace[777957598] 'process raft request' (duration: 143.497815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:25.461559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.569786ms","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-06-15T19:51:25.461645Z","caller":"traceutil/trace.go:171","msg":"trace[1911271624] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:24973; }","duration":"119.684399ms","start":"2026-06-15T19:51:25.341942Z","end":"2026-06-15T19:51:25.461627Z","steps":["trace[1911271624] 'count revisions from in-memory index tree' (duration: 119.496655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:25.461587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.696122ms","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-06-15T19:51:25.461729Z","caller":"traceutil/trace.go:171","msg":"trace[280529572] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24973; }","duration":"155.860646ms","start":"2026-06-15T19:51:25.305843Z","end":"2026-06-15T19:51:25.461703Z","steps":["trace[280529572] 'range keys from in-memory index tree' (duration: 155.594639ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:25.578373Z","caller":"traceutil/trace.go:171","msg":"trace[684135247] transaction","detail":"{read_only:false; response_revision:24974; number_of_response:1; }","duration":"176.064015ms","start":"2026-06-15T19:51:25.402282Z","end":"2026-06-15T19:51:25.578346Z","steps":["trace[684135247] 'process raft request' (duration: 175.89712ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:25.602116Z","caller":"traceutil/trace.go:171","msg":"trace[2133863326] linearizableReadLoop","detail":"{readStateIndex:25789; appliedIndex:25787; }","duration":"137.167813ms","start":"2026-06-15T19:51:25.464909Z","end":"2026-06-15T19:51:25.602077Z","steps":["trace[2133863326] 'read index received' (duration: 113.394738ms)","trace[2133863326] 'applied index is now lower than readState.Index' (duration: 23.772395ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:25.602197Z","caller":"traceutil/trace.go:171","msg":"trace[1559112123] transaction","detail":"{read_only:false; response_revision:24975; number_of_response:1; }","duration":"198.889517ms","start":"2026-06-15T19:51:25.40326Z","end":"2026-06-15T19:51:25.602149Z","steps":["trace[1559112123] 'process raft request' (duration: 198.55813ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:25.602206Z","caller":"traceutil/trace.go:171","msg":"trace[85165488] transaction","detail":"{read_only:false; response_revision:24976; number_of_response:1; }","duration":"136.897536ms","start":"2026-06-15T19:51:25.465273Z","end":"2026-06-15T19:51:25.60217Z","steps":["trace[85165488] 'process raft request' (duration: 136.769373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:25.602422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.49405ms","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-06-15T19:51:25.602481Z","caller":"traceutil/trace.go:171","msg":"trace[65015538] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24976; }","duration":"137.613973ms","start":"2026-06-15T19:51:25.464858Z","end":"2026-06-15T19:51:25.602472Z","steps":["trace[65015538] 'agreement among raft nodes before linearized reading' (duration: 137.332876ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:25.893137Z","caller":"traceutil/trace.go:171","msg":"trace[1303449991] linearizableReadLoop","detail":"{readStateIndex:25791; appliedIndex:25790; }","duration":"134.295192ms","start":"2026-06-15T19:51:25.758822Z","end":"2026-06-15T19:51:25.893117Z","steps":["trace[1303449991] 'read index received' (duration: 134.147189ms)","trace[1303449991] 'applied index is now lower than readState.Index' (duration: 147.083µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:25.893189Z","caller":"traceutil/trace.go:171","msg":"trace[406113182] transaction","detail":"{read_only:false; response_revision:24977; number_of_response:1; }","duration":"134.761364ms","start":"2026-06-15T19:51:25.758407Z","end":"2026-06-15T19:51:25.893168Z","steps":["trace[406113182] 'process raft request' (duration: 134.563399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:25.893266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.429957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:51:25.89332Z","caller":"traceutil/trace.go:171","msg":"trace[296977259] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24977; }","duration":"134.514708ms","start":"2026-06-15T19:51:25.758794Z","end":"2026-06-15T19:51:25.893309Z","steps":["trace[296977259] 'agreement among raft nodes before linearized reading' (duration: 134.394465ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:26.249579Z","caller":"traceutil/trace.go:171","msg":"trace[886918406] transaction","detail":"{read_only:false; response_revision:24978; number_of_response:1; }","duration":"489.969978ms","start":"2026-06-15T19:51:25.759588Z","end":"2026-06-15T19:51:26.249558Z","steps":["trace[886918406] 'process raft request' (duration: 408.507195ms)","trace[886918406] 'compare' (duration: 80.965001ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:26.249701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:25.759574Z","time spent":"490.06479ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:26.249718Z","caller":"traceutil/trace.go:171","msg":"trace[1928836018] transaction","detail":"{read_only:false; response_revision:24979; number_of_response:1; }","duration":"489.992009ms","start":"2026-06-15T19:51:25.75969Z","end":"2026-06-15T19:51:26.249682Z","steps":["trace[1928836018] 'process raft request' (duration: 489.725652ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:26.249755Z","caller":"traceutil/trace.go:171","msg":"trace[250959951] linearizableReadLoop","detail":"{readStateIndex:25795; appliedIndex:25791; }","duration":"353.899292ms","start":"2026-06-15T19:51:25.89583Z","end":"2026-06-15T19:51:26.24973Z","steps":["trace[250959951] 'read index received' (duration: 272.281665ms)","trace[250959951] 'applied index is now lower than readState.Index' (duration: 81.616627ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:26.249833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:25.759465Z","time spent":"490.311606ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:26.249812Z","caller":"traceutil/trace.go:171","msg":"trace[1727152743] transaction","detail":"{read_only:false; response_revision:24981; number_of_response:1; }","duration":"413.041584ms","start":"2026-06-15T19:51:25.83673Z","end":"2026-06-15T19:51:26.249772Z","steps":["trace[1727152743] 'process raft request' (duration: 412.952262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:26.24997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:25.836711Z","time spent":"413.175478ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:51:26.250002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.158478ms","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-06-15T19:51:26.250072Z","caller":"traceutil/trace.go:171","msg":"trace[1154134055] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24981; }","duration":"354.24558ms","start":"2026-06-15T19:51:25.895807Z","end":"2026-06-15T19:51:26.250053Z","steps":["trace[1154134055] 'agreement among raft nodes before linearized reading' (duration: 354.008994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:26.250129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:25.895797Z","time spent":"354.319921ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-15T19:51:26.25049Z","caller":"traceutil/trace.go:171","msg":"trace[1055025680] transaction","detail":"{read_only:false; response_revision:24980; number_of_response:1; }","duration":"489.643199ms","start":"2026-06-15T19:51:25.760823Z","end":"2026-06-15T19:51:26.250466Z","steps":["trace[1055025680] 'process raft request' (duration: 488.729628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:26.250598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:25.760811Z","time spent":"489.735071ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:51:26.322235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.79524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:51:26.322316Z","caller":"traceutil/trace.go:171","msg":"trace[1938148444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24982; }","duration":"230.916333ms","start":"2026-06-15T19:51:26.09138Z","end":"2026-06-15T19:51:26.322296Z","steps":["trace[1938148444] 'agreement among raft nodes before linearized reading' (duration: 230.771429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:26.32235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.95763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T19:51:26.322424Z","caller":"traceutil/trace.go:171","msg":"trace[555396427] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:24982; }","duration":"223.081612ms","start":"2026-06-15T19:51:26.099326Z","end":"2026-06-15T19:51:26.322408Z","steps":["trace[555396427] 'agreement among raft nodes before linearized reading' (duration: 222.930399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:26.844185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.933644ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T19:51:26.844464Z","caller":"traceutil/trace.go:171","msg":"trace[1869632980] transaction","detail":"{read_only:false; response_revision:24983; number_of_response:1; }","duration":"327.988854ms","start":"2026-06-15T19:51:26.516454Z","end":"2026-06-15T19:51:26.844443Z","steps":["trace[1869632980] 'process raft request' (duration: 327.826461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:26.844671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:26.51643Z","time spent":"328.077547ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:26.908009Z","caller":"traceutil/trace.go:171","msg":"trace[694509207] transaction","detail":"{read_only:false; response_revision:24985; number_of_response:1; }","duration":"390.041347ms","start":"2026-06-15T19:51:26.517941Z","end":"2026-06-15T19:51:26.907983Z","steps":["trace[694509207] 'process raft request' (duration: 389.987366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:26.908164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:26.517919Z","time spent":"390.16503ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:26.908164Z","caller":"traceutil/trace.go:171","msg":"trace[929922695] transaction","detail":"{read_only:false; response_revision:24984; number_of_response:1; }","duration":"391.167084ms","start":"2026-06-15T19:51:26.516865Z","end":"2026-06-15T19:51:26.908032Z","steps":["trace[929922695] 'process raft request' (duration: 390.849926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:26.908394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:26.516854Z","time spent":"391.43081ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:51:27.097049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.437374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:51:27.09713Z","caller":"traceutil/trace.go:171","msg":"trace[1372393885] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:24985; }","duration":"138.569458ms","start":"2026-06-15T19:51:26.958538Z","end":"2026-06-15T19:51:27.097107Z","steps":["trace[1372393885] 'count revisions from in-memory index tree' (duration: 138.326741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:27.563843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.52763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-15T19:51:27.563929Z","caller":"traceutil/trace.go:171","msg":"trace[1912619956] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:24986; }","duration":"139.674454ms","start":"2026-06-15T19:51:27.424232Z","end":"2026-06-15T19:51:27.563906Z","steps":["trace[1912619956] 'count revisions from in-memory index tree' (duration: 139.362775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:27.819857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.020994ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:51:27.820073Z","caller":"traceutil/trace.go:171","msg":"trace[2142627187] linearizableReadLoop","detail":"{readStateIndex:25803; appliedIndex:25801; }","duration":"212.989258ms","start":"2026-06-15T19:51:27.60707Z","end":"2026-06-15T19:51:27.820059Z","steps":["trace[2142627187] 'read index received' (duration: 12.623455ms)","trace[2142627187] 'applied index is now lower than readState.Index' (duration: 200.364383ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:27.820265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.200804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-15T19:51:27.820313Z","caller":"traceutil/trace.go:171","msg":"trace[1993447068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24988; }","duration":"213.276885ms","start":"2026-06-15T19:51:27.607028Z","end":"2026-06-15T19:51:27.820305Z","steps":["trace[1993447068] 'agreement among raft nodes before linearized reading' (duration: 213.088381ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:27.820389Z","caller":"traceutil/trace.go:171","msg":"trace[776113966] transaction","detail":"{read_only:false; response_revision:24988; number_of_response:1; }","duration":"213.549913ms","start":"2026-06-15T19:51:27.606808Z","end":"2026-06-15T19:51:27.820358Z","steps":["trace[776113966] 'process raft request' (duration: 74.968665ms)","trace[776113966] 'compare' (duration: 137.803219ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:28.165191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.852098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:51:28.165295Z","caller":"traceutil/trace.go:171","msg":"trace[288981846] linearizableReadLoop","detail":"{readStateIndex:25804; appliedIndex:25803; }","duration":"267.683434ms","start":"2026-06-15T19:51:27.897596Z","end":"2026-06-15T19:51:28.16528Z","steps":["trace[288981846] 'read index received' (duration: 63.600081ms)","trace[288981846] 'applied index is now lower than readState.Index' (duration: 204.082283ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:28.16538Z","caller":"traceutil/trace.go:171","msg":"trace[1607583749] transaction","detail":"{read_only:false; response_revision:24989; number_of_response:1; }","duration":"340.260181ms","start":"2026-06-15T19:51:27.825109Z","end":"2026-06-15T19:51:28.165369Z","steps":["trace[1607583749] 'process raft request' (duration: 136.159887ms)","trace[1607583749] 'compare' (duration: 203.748766ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:28.165431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:27.825092Z","time spent":"340.310462ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:51:28.165592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.033292ms","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":"warn","ts":"2026-06-15T19:51:28.165588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.2965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-15T19:51:28.165625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.026652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-15T19:51:28.165671Z","caller":"traceutil/trace.go:171","msg":"trace[1316017682] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24989; }","duration":"268.095134ms","start":"2026-06-15T19:51:27.897558Z","end":"2026-06-15T19:51:28.165653Z","steps":["trace[1316017682] 'agreement among raft nodes before linearized reading' (duration: 267.977031ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:28.165669Z","caller":"traceutil/trace.go:171","msg":"trace[1528877410] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:24989; }","duration":"254.402432ms","start":"2026-06-15T19:51:27.911247Z","end":"2026-06-15T19:51:28.165649Z","steps":["trace[1528877410] 'agreement among raft nodes before linearized reading' (duration: 254.275069ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:28.165676Z","caller":"traceutil/trace.go:171","msg":"trace[280654948] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:24989; }","duration":"261.134105ms","start":"2026-06-15T19:51:27.904506Z","end":"2026-06-15T19:51:28.16564Z","steps":["trace[280654948] 'agreement among raft nodes before linearized reading' (duration: 261.005432ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:28.399904Z","caller":"traceutil/trace.go:171","msg":"trace[2136189272] linearizableReadLoop","detail":"{readStateIndex:25805; appliedIndex:25804; }","duration":"144.813728ms","start":"2026-06-15T19:51:28.255058Z","end":"2026-06-15T19:51:28.399872Z","steps":["trace[2136189272] 'read index received' (duration: 81.283249ms)","trace[2136189272] 'applied index is now lower than readState.Index' (duration: 63.529229ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:28.400191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.125276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-15T19:51:28.400203Z","caller":"traceutil/trace.go:171","msg":"trace[1885035646] transaction","detail":"{read_only:false; response_revision:24990; number_of_response:1; }","duration":"231.265762ms","start":"2026-06-15T19:51:28.168913Z","end":"2026-06-15T19:51:28.400179Z","steps":["trace[1885035646] 'process raft request' (duration: 167.345954ms)","trace[1885035646] 'compare' (duration: 63.18454ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:28.400225Z","caller":"traceutil/trace.go:171","msg":"trace[1998521465] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24990; }","duration":"145.234408ms","start":"2026-06-15T19:51:28.25498Z","end":"2026-06-15T19:51:28.400215Z","steps":["trace[1998521465] 'agreement among raft nodes before linearized reading' (duration: 145.128715ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:28.449181Z","caller":"traceutil/trace.go:171","msg":"trace[1547109788] transaction","detail":"{read_only:false; response_revision:24992; number_of_response:1; }","duration":"122.318842ms","start":"2026-06-15T19:51:28.32684Z","end":"2026-06-15T19:51:28.449159Z","steps":["trace[1547109788] 'process raft request' (duration: 122.23718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:28.449316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.956068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-15T19:51:28.449389Z","caller":"traceutil/trace.go:171","msg":"trace[2043114730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24992; }","duration":"194.100761ms","start":"2026-06-15T19:51:28.255267Z","end":"2026-06-15T19:51:28.449367Z","steps":["trace[2043114730] 'agreement among raft nodes before linearized reading' (duration: 193.878836ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:28.449446Z","caller":"traceutil/trace.go:171","msg":"trace[581122000] transaction","detail":"{read_only:false; response_revision:24991; number_of_response:1; }","duration":"193.916347ms","start":"2026-06-15T19:51:28.255524Z","end":"2026-06-15T19:51:28.449441Z","steps":["trace[581122000] 'process raft request' (duration: 193.428415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:28.449893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.504142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-15T19:51:28.449967Z","caller":"traceutil/trace.go:171","msg":"trace[2065560092] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24992; }","duration":"194.561773ms","start":"2026-06-15T19:51:28.255375Z","end":"2026-06-15T19:51:28.449937Z","steps":["trace[2065560092] 'agreement among raft nodes before linearized reading' (duration: 194.224914ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:28.685587Z","caller":"traceutil/trace.go:171","msg":"trace[574600693] transaction","detail":"{read_only:false; response_revision:24995; number_of_response:1; }","duration":"232.779738ms","start":"2026-06-15T19:51:28.452786Z","end":"2026-06-15T19:51:28.685566Z","steps":["trace[574600693] 'process raft request' (duration: 206.963343ms)","trace[574600693] 'compare' (duration: 25.63807ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:28.685891Z","caller":"traceutil/trace.go:171","msg":"trace[19438020] transaction","detail":"{read_only:false; response_revision:24996; number_of_response:1; }","duration":"231.567699ms","start":"2026-06-15T19:51:28.454303Z","end":"2026-06-15T19:51:28.685871Z","steps":["trace[19438020] 'process raft request' (duration: 231.233171ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:28.685838Z","caller":"traceutil/trace.go:171","msg":"trace[391534674] linearizableReadLoop","detail":"{readStateIndex:25811; appliedIndex:25809; }","duration":"114.272998ms","start":"2026-06-15T19:51:28.571498Z","end":"2026-06-15T19:51:28.685771Z","steps":["trace[391534674] 'read index received' (duration: 88.265699ms)","trace[391534674] 'applied index is now lower than readState.Index' (duration: 26.003369ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:28.686122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.606556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:51:28.686417Z","caller":"traceutil/trace.go:171","msg":"trace[1129717597] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:24996; }","duration":"114.940204ms","start":"2026-06-15T19:51:28.571449Z","end":"2026-06-15T19:51:28.686389Z","steps":["trace[1129717597] 'agreement among raft nodes before linearized reading' (duration: 114.587336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:29.191375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.479226ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-15T19:51:29.191465Z","caller":"traceutil/trace.go:171","msg":"trace[466490432] transaction","detail":"{read_only:false; response_revision:24998; number_of_response:1; }","duration":"277.776168ms","start":"2026-06-15T19:51:28.913671Z","end":"2026-06-15T19:51:29.191448Z","steps":["trace[466490432] 'process raft request' (duration: 96.152979ms)","trace[466490432] 'compare' (duration: 181.147878ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:29.228297Z","caller":"traceutil/trace.go:171","msg":"trace[988488298] linearizableReadLoop","detail":"{readStateIndex:25814; appliedIndex:25812; }","duration":"250.567369ms","start":"2026-06-15T19:51:28.977686Z","end":"2026-06-15T19:51:29.228253Z","steps":["trace[988488298] 'read index received' (duration: 32.116087ms)","trace[988488298] 'applied index is now lower than readState.Index' (duration: 218.449722ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:29.228383Z","caller":"traceutil/trace.go:171","msg":"trace[362920102] transaction","detail":"{read_only:false; response_revision:24999; number_of_response:1; }","duration":"314.581599ms","start":"2026-06-15T19:51:28.913776Z","end":"2026-06-15T19:51:29.228358Z","steps":["trace[362920102] 'process raft request' (duration: 314.320933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:29.228488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.777935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-15T19:51:29.228494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:51:28.913742Z","time spent":"314.691753ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:51:29.228539Z","caller":"traceutil/trace.go:171","msg":"trace[1928213748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:24999; }","duration":"250.888637ms","start":"2026-06-15T19:51:28.977636Z","end":"2026-06-15T19:51:29.228525Z","steps":["trace[1928213748] 'agreement among raft nodes before linearized reading' (duration: 250.784135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:29.228768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.320335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:51:29.228855Z","caller":"traceutil/trace.go:171","msg":"trace[1234468888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24999; }","duration":"139.447128ms","start":"2026-06-15T19:51:29.089388Z","end":"2026-06-15T19:51:29.228835Z","steps":["trace[1234468888] 'agreement among raft nodes before linearized reading' (duration: 139.288654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:29.525885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.852971ms","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":"warn","ts":"2026-06-15T19:51:29.525976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.453739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-15T19:51:29.525984Z","caller":"traceutil/trace.go:171","msg":"trace[2040413584] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:24999; }","duration":"174.028505ms","start":"2026-06-15T19:51:29.351928Z","end":"2026-06-15T19:51:29.525956Z","steps":["trace[2040413584] 'count revisions from in-memory index tree' (duration: 173.772579ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:29.526022Z","caller":"traceutil/trace.go:171","msg":"trace[25184456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24999; }","duration":"132.543011ms","start":"2026-06-15T19:51:29.393467Z","end":"2026-06-15T19:51:29.52601Z","steps":["trace[25184456] 'range keys from in-memory index tree' (duration: 132.226173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:29.526249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.110427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:127595"} {"level":"info","ts":"2026-06-15T19:51:29.526346Z","caller":"traceutil/trace.go:171","msg":"trace[741735658] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:24999; }","duration":"226.24387ms","start":"2026-06-15T19:51:29.300077Z","end":"2026-06-15T19:51:29.526321Z","steps":["trace[741735658] 'range keys from in-memory index tree' (duration: 225.858311ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:29.731421Z","caller":"traceutil/trace.go:171","msg":"trace[1951360280] linearizableReadLoop","detail":"{readStateIndex:25815; appliedIndex:25814; }","duration":"202.072924ms","start":"2026-06-15T19:51:29.529316Z","end":"2026-06-15T19:51:29.731389Z","steps":["trace[1951360280] 'read index received' (duration: 201.938731ms)","trace[1951360280] 'applied index is now lower than readState.Index' (duration: 133.243µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:29.731594Z","caller":"traceutil/trace.go:171","msg":"trace[1090970800] transaction","detail":"{read_only:false; response_revision:25000; number_of_response:1; }","duration":"291.0566ms","start":"2026-06-15T19:51:29.440498Z","end":"2026-06-15T19:51:29.731554Z","steps":["trace[1090970800] 'process raft request' (duration: 290.693011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:29.732213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.876333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:92 size:121465"} {"level":"info","ts":"2026-06-15T19:51:29.732261Z","caller":"traceutil/trace.go:171","msg":"trace[1905074701] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:92; response_revision:25000; }","duration":"202.969546ms","start":"2026-06-15T19:51:29.52928Z","end":"2026-06-15T19:51:29.73225Z","steps":["trace[1905074701] 'agreement among raft nodes before linearized reading' (duration: 202.259489ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:29.818708Z","caller":"traceutil/trace.go:171","msg":"trace[1332611633] transaction","detail":"{read_only:false; response_revision:25001; number_of_response:1; }","duration":"288.973809ms","start":"2026-06-15T19:51:29.529694Z","end":"2026-06-15T19:51:29.818667Z","steps":["trace[1332611633] 'process raft request' (duration: 288.728723ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:29.818697Z","caller":"traceutil/trace.go:171","msg":"trace[1479409267] transaction","detail":"{read_only:false; response_revision:25002; number_of_response:1; }","duration":"193.789144ms","start":"2026-06-15T19:51:29.62488Z","end":"2026-06-15T19:51:29.818669Z","steps":["trace[1479409267] 'process raft request' (duration: 193.695982ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:29.991104Z","caller":"traceutil/trace.go:171","msg":"trace[93750581] transaction","detail":"{read_only:false; response_revision:25003; number_of_response:1; }","duration":"166.192636ms","start":"2026-06-15T19:51:29.824875Z","end":"2026-06-15T19:51:29.991067Z","steps":["trace[93750581] 'process raft request' (duration: 149.999534ms)","trace[93750581] 'compare' (duration: 15.798153ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:30.239419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.356995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:51:30.239505Z","caller":"traceutil/trace.go:171","msg":"trace[846207805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25003; }","duration":"146.503308ms","start":"2026-06-15T19:51:30.092982Z","end":"2026-06-15T19:51:30.239485Z","steps":["trace[846207805] 'range keys from in-memory index tree' (duration: 146.222031ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:30.706479Z","caller":"traceutil/trace.go:171","msg":"trace[2143250919] linearizableReadLoop","detail":"{readStateIndex:25822; appliedIndex:25819; }","duration":"241.632613ms","start":"2026-06-15T19:51:30.464821Z","end":"2026-06-15T19:51:30.706454Z","steps":["trace[2143250919] 'read index received' (duration: 66.617118ms)","trace[2143250919] 'applied index is now lower than readState.Index' (duration: 175.014645ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:30.70653Z","caller":"traceutil/trace.go:171","msg":"trace[1971274405] transaction","detail":"{read_only:false; response_revision:25006; number_of_response:1; }","duration":"250.60673ms","start":"2026-06-15T19:51:30.45589Z","end":"2026-06-15T19:51:30.706497Z","steps":["trace[1971274405] 'process raft request' (duration: 250.395855ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:30.706573Z","caller":"traceutil/trace.go:171","msg":"trace[1333648129] transaction","detail":"{read_only:false; response_revision:25007; number_of_response:1; }","duration":"250.515918ms","start":"2026-06-15T19:51:30.45602Z","end":"2026-06-15T19:51:30.706536Z","steps":["trace[1333648129] 'process raft request' (duration: 250.399095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:51:30.706695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.852179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-15T19:51:30.706739Z","caller":"traceutil/trace.go:171","msg":"trace[705173960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25007; }","duration":"241.954161ms","start":"2026-06-15T19:51:30.464775Z","end":"2026-06-15T19:51:30.706729Z","steps":["trace[705173960] 'agreement among raft nodes before linearized reading' (duration: 241.801627ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:30.852928Z","caller":"traceutil/trace.go:171","msg":"trace[1915119543] transaction","detail":"{read_only:false; response_revision:25010; number_of_response:1; }","duration":"142.177262ms","start":"2026-06-15T19:51:30.710731Z","end":"2026-06-15T19:51:30.852908Z","steps":["trace[1915119543] 'process raft request' (duration: 141.958937ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:30.852937Z","caller":"traceutil/trace.go:171","msg":"trace[848626527] transaction","detail":"{read_only:false; response_revision:25009; number_of_response:1; }","duration":"142.461089ms","start":"2026-06-15T19:51:30.71044Z","end":"2026-06-15T19:51:30.852901Z","steps":["trace[848626527] 'process raft request' (duration: 112.354172ms)","trace[848626527] 'compare' (duration: 29.537753ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:31.127792Z","caller":"traceutil/trace.go:171","msg":"trace[1592292413] linearizableReadLoop","detail":"{readStateIndex:25826; appliedIndex:25825; }","duration":"127.309924ms","start":"2026-06-15T19:51:31.00045Z","end":"2026-06-15T19:51:31.12776Z","steps":["trace[1592292413] 'read index received' (duration: 87.000791ms)","trace[1592292413] 'applied index is now lower than readState.Index' (duration: 40.308243ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:31.128032Z","caller":"traceutil/trace.go:171","msg":"trace[370641885] transaction","detail":"{read_only:false; response_revision:25011; number_of_response:1; }","duration":"260.474589ms","start":"2026-06-15T19:51:30.867544Z","end":"2026-06-15T19:51:31.128019Z","steps":["trace[370641885] 'process raft request' (duration: 220.015031ms)","trace[370641885] 'compare' (duration: 39.74498ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:51:31.128311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.847157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.84\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-06-15T19:51:31.128338Z","caller":"traceutil/trace.go:171","msg":"trace[1098911009] range","detail":"{range_begin:/registry/masterleases/199.19.213.84; range_end:; response_count:1; response_revision:25011; }","duration":"127.932409ms","start":"2026-06-15T19:51:31.000398Z","end":"2026-06-15T19:51:31.128331Z","steps":["trace[1098911009] 'agreement among raft nodes before linearized reading' (duration: 127.790916ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:31.316913Z","caller":"traceutil/trace.go:171","msg":"trace[28015342] transaction","detail":"{read_only:false; response_revision:25013; number_of_response:1; }","duration":"121.190346ms","start":"2026-06-15T19:51:31.195699Z","end":"2026-06-15T19:51:31.316889Z","steps":["trace[28015342] 'process raft request' (duration: 121.106584ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:31.317332Z","caller":"traceutil/trace.go:171","msg":"trace[2035704187] transaction","detail":"{read_only:false; response_revision:25012; number_of_response:1; }","duration":"135.509811ms","start":"2026-06-15T19:51:31.181807Z","end":"2026-06-15T19:51:31.317316Z","steps":["trace[2035704187] 'process raft request' (duration: 116.683566ms)","trace[2035704187] 'compare' (duration: 17.833242ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:51:31.362284Z","caller":"traceutil/trace.go:171","msg":"trace[568342646] transaction","detail":"{read_only:false; response_revision:25014; number_of_response:1; }","duration":"146.697961ms","start":"2026-06-15T19:51:31.21556Z","end":"2026-06-15T19:51:31.362258Z","steps":["trace[568342646] 'process raft request' (duration: 146.099727ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:51:31.362898Z","caller":"traceutil/trace.go:171","msg":"trace[642427779] transaction","detail":"{read_only:false; response_revision:25015; number_of_response:1; }","duration":"130.141791ms","start":"2026-06-15T19:51:31.232743Z","end":"2026-06-15T19:51:31.362884Z","steps":["trace[642427779] 'process raft request' (duration: 129.109877ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:52:04.240127Z","caller":"traceutil/trace.go:171","msg":"trace[1122098205] linearizableReadLoop","detail":"{readStateIndex:26230; appliedIndex:26229; }","duration":"113.926951ms","start":"2026-06-15T19:52:04.126179Z","end":"2026-06-15T19:52:04.240106Z","steps":["trace[1122098205] 'read index received' (duration: 113.824997ms)","trace[1122098205] 'applied index is now lower than readState.Index' (duration: 100.774µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:52:04.240235Z","caller":"traceutil/trace.go:171","msg":"trace[1484534337] transaction","detail":"{read_only:false; response_revision:25407; number_of_response:1; }","duration":"135.507382ms","start":"2026-06-15T19:52:04.104691Z","end":"2026-06-15T19:52:04.240198Z","steps":["trace[1484534337] 'process raft request' (duration: 135.252895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:52:04.240274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.063024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T19:52:04.240331Z","caller":"traceutil/trace.go:171","msg":"trace[957124590] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:25407; }","duration":"114.174617ms","start":"2026-06-15T19:52:04.126141Z","end":"2026-06-15T19:52:04.240315Z","steps":["trace[957124590] 'agreement among raft nodes before linearized reading' (duration: 114.062674ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:52:04.412082Z","caller":"traceutil/trace.go:171","msg":"trace[527440058] linearizableReadLoop","detail":"{readStateIndex:26232; appliedIndex:26230; }","duration":"150.409852ms","start":"2026-06-15T19:52:04.261654Z","end":"2026-06-15T19:52:04.412063Z","steps":["trace[527440058] 'read index received' (duration: 150.184797ms)","trace[527440058] 'applied index is now lower than readState.Index' (duration: 224.395µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:52:04.412159Z","caller":"traceutil/trace.go:171","msg":"trace[1583547784] transaction","detail":"{read_only:false; response_revision:25408; number_of_response:1; }","duration":"266.650128ms","start":"2026-06-15T19:52:04.145481Z","end":"2026-06-15T19:52:04.412131Z","steps":["trace[1583547784] 'process raft request' (duration: 266.407632ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:52:04.412327Z","caller":"traceutil/trace.go:171","msg":"trace[1813694486] transaction","detail":"{read_only:false; response_revision:25409; number_of_response:1; }","duration":"178.676494ms","start":"2026-06-15T19:52:04.233643Z","end":"2026-06-15T19:52:04.41232Z","steps":["trace[1813694486] 'process raft request' (duration: 178.363097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:52:04.412383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.708379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T19:52:04.412466Z","caller":"traceutil/trace.go:171","msg":"trace[15940378] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:25409; }","duration":"150.842002ms","start":"2026-06-15T19:52:04.261604Z","end":"2026-06-15T19:52:04.412446Z","steps":["trace[15940378] 'agreement among raft nodes before linearized reading' (duration: 150.676528ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:53:27.918132Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23257} {"level":"info","ts":"2026-06-15T19:53:28.057335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23257,"took":"135.886531ms","hash":1520670596,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":35844096,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-06-15T19:53:28.057385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1520670596,"revision":23257,"compact-revision":20036} {"level":"info","ts":"2026-06-15T19:53:57.625835Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a7f.wal"} {"level":"info","ts":"2026-06-15T19:58:27.924988Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26150} {"level":"info","ts":"2026-06-15T19:58:28.123793Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26150,"took":"195.433483ms","hash":2462747807,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":33230848,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-15T19:58:28.123864Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2462747807,"revision":26150,"compact-revision":23257} {"level":"info","ts":"2026-06-15T19:59:13.758031Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f823adf772f78a4c","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T19:59:13.763216Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-15T19:59:13.763338Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-15T20:03:27.93637Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28743} {"level":"info","ts":"2026-06-15T20:03:28.080671Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28743,"took":"141.103192ms","hash":1148313709,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":30359552,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-15T20:03:28.080761Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1148313709,"revision":28743,"compact-revision":26150} {"level":"info","ts":"2026-06-15T20:08:27.943784Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31027} {"level":"info","ts":"2026-06-15T20:08:28.06521Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31027,"took":"118.229651ms","hash":2457383116,"current-db-size-bytes":58114048,"current-db-size":"58 MB","current-db-size-in-use-bytes":31186944,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-15T20:08:28.0653Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2457383116,"revision":31027,"compact-revision":28743} {"level":"info","ts":"2026-06-15T20:13:27.953242Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33325} {"level":"info","ts":"2026-06-15T20:13:28.107221Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33325,"took":"148.777889ms","hash":617486066,"current-db-size-bytes":59158528,"current-db-size":"59 MB","current-db-size-in-use-bytes":32141312,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T20:13:28.107327Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":617486066,"revision":33325,"compact-revision":31027} {"level":"info","ts":"2026-06-15T20:18:27.965977Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35621} {"level":"info","ts":"2026-06-15T20:18:28.109919Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35621,"took":"140.718069ms","hash":3462056632,"current-db-size-bytes":60878848,"current-db-size":"61 MB","current-db-size-in-use-bytes":32002048,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-15T20:18:28.110023Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3462056632,"revision":35621,"compact-revision":33325} {"level":"info","ts":"2026-06-15T20:18:50.094044Z","caller":"traceutil/trace.go:171","msg":"trace[166053734] linearizableReadLoop","detail":"{readStateIndex:39196; appliedIndex:39195; }","duration":"289.992845ms","start":"2026-06-15T20:18:49.804029Z","end":"2026-06-15T20:18:50.094022Z","steps":["trace[166053734] 'read index received' (duration: 286.265485ms)","trace[166053734] 'applied index is now lower than readState.Index' (duration: 3.72403ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:18:50.094204Z","caller":"traceutil/trace.go:171","msg":"trace[1790335419] transaction","detail":"{read_only:false; response_revision:38017; number_of_response:1; }","duration":"397.193554ms","start":"2026-06-15T20:18:49.696994Z","end":"2026-06-15T20:18:50.094187Z","steps":["trace[1790335419] 'process raft request' (duration: 393.433473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:18:50.094326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:18:49.69697Z","time spent":"397.265705ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:18:50.09436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.724014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-15T20:18:50.094429Z","caller":"traceutil/trace.go:171","msg":"trace[1022661671] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:38017; }","duration":"139.837307ms","start":"2026-06-15T20:18:49.954572Z","end":"2026-06-15T20:18:50.09441Z","steps":["trace[1022661671] 'agreement among raft nodes before linearized reading' (duration: 139.683173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:18:50.094532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.499557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-15T20:18:50.094571Z","caller":"traceutil/trace.go:171","msg":"trace[536803795] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:38017; }","duration":"290.564178ms","start":"2026-06-15T20:18:49.803986Z","end":"2026-06-15T20:18:50.09455Z","steps":["trace[536803795] 'agreement among raft nodes before linearized reading' (duration: 290.519937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:18:50.097701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.331832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-15T20:18:50.097751Z","caller":"traceutil/trace.go:171","msg":"trace[1179858976] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:38017; }","duration":"107.429304ms","start":"2026-06-15T20:18:49.99031Z","end":"2026-06-15T20:18:50.09774Z","steps":["trace[1179858976] 'agreement among raft nodes before linearized reading' (duration: 104.396011ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:20:25.801475Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f823adf772f78a4c","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-15T20:20:25.806236Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-15T20:20:25.806337Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}