{"level":"warn","ts":"2026-04-19T11:06:54.820445Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-19T11:06:54.820585Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.134: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.134:2380","--initial-cluster=instance=https://199.19.213.134:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.134:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.134: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-04-19T11:06:54.820707Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-19T11:06:54.820724Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-04-19T11:06:54.820749Z","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-04-19T11:06:54.821704Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"]} {"level":"info","ts":"2026-04-19T11:06:54.821836Z","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.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.134: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-04-19T11:06:54.828802Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.566722ms"} {"level":"info","ts":"2026-04-19T11:06:54.847136Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"92da22d3868c86fb","cluster-id":"84450b28e935eb90"} {"level":"info","ts":"2026-04-19T11:06:54.847342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=()"} {"level":"info","ts":"2026-04-19T11:06:54.847385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 0"} {"level":"info","ts":"2026-04-19T11:06:54.847425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 92da22d3868c86fb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-19T11:06:54.84744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became follower at term 1"} {"level":"info","ts":"2026-04-19T11:06:54.847515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"warn","ts":"2026-04-19T11:06:54.862063Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-19T11:06:54.864574Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-19T11:06:54.866086Z","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-04-19T11:06:54.870776Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"92da22d3868c86fb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-19T11:06:54.871018Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"92da22d3868c86fb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-19T11:06:54.870955Z","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-04-19T11:06:54.871209Z","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-04-19T11:06:54.871234Z","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-04-19T11:06:54.87448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb switched to configuration voters=(10581808566351202043)"} {"level":"info","ts":"2026-04-19T11:06:54.874669Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","added-peer-id":"92da22d3868c86fb","added-peer-peer-urls":["https://199.19.213.134:2380"]} {"level":"info","ts":"2026-04-19T11:06:54.875994Z","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-04-19T11:06:54.876076Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-04-19T11:06:54.876118Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.134:2380"} {"level":"info","ts":"2026-04-19T11:06:54.876292Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"92da22d3868c86fb","initial-advertise-peer-urls":["https://199.19.213.134:2380"],"listen-peer-urls":["https://199.19.213.134:2380"],"advertise-client-urls":["https://199.19.213.134:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.134:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-19T11:06:54.876348Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-19T11:06:55.548108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb is starting a new election at term 1"} {"level":"info","ts":"2026-04-19T11:06:55.548194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-19T11:06:55.548228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgPreVoteResp from 92da22d3868c86fb at term 1"} {"level":"info","ts":"2026-04-19T11:06:55.548243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became candidate at term 2"} {"level":"info","ts":"2026-04-19T11:06:55.548251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb received MsgVoteResp from 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-04-19T11:06:55.548263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"92da22d3868c86fb became leader at term 2"} {"level":"info","ts":"2026-04-19T11:06:55.548275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 92da22d3868c86fb elected leader 92da22d3868c86fb at term 2"} {"level":"info","ts":"2026-04-19T11:06:55.551481Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T11:06:55.552368Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"92da22d3868c86fb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.134:2379]}","request-path":"/0/members/92da22d3868c86fb/attributes","cluster-id":"84450b28e935eb90","publish-timeout":"7s"} {"level":"info","ts":"2026-04-19T11:06:55.552382Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T11:06:55.552433Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T11:06:55.552809Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-19T11:06:55.552923Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-19T11:06:55.553825Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"84450b28e935eb90","local-member-id":"92da22d3868c86fb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T11:06:55.553917Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T11:06:55.553944Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T11:06:55.555661Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-19T11:06:55.556492Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.134:2379"} {"level":"info","ts":"2026-04-19T11:07:11.468095Z","caller":"traceutil/trace.go:171","msg":"trace[159978092] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"122.474071ms","start":"2026-04-19T11:07:11.345602Z","end":"2026-04-19T11:07:11.468076Z","steps":["trace[159978092] 'process raft request' (duration: 122.188033ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:07:33.488066Z","caller":"traceutil/trace.go:171","msg":"trace[304365608] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"105.721756ms","start":"2026-04-19T11:07:33.382323Z","end":"2026-04-19T11:07:33.488045Z","steps":["trace[304365608] 'read index received' (duration: 104.905613ms)","trace[304365608] 'applied index is now lower than readState.Index' (duration: 815.193µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:07:33.488168Z","caller":"traceutil/trace.go:171","msg":"trace[62222042] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"207.138327ms","start":"2026-04-19T11:07:33.280967Z","end":"2026-04-19T11:07:33.488105Z","steps":["trace[62222042] 'process raft request' (duration: 206.528389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:33.488282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.941033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:07:33.488475Z","caller":"traceutil/trace.go:171","msg":"trace[665822410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"106.18185ms","start":"2026-04-19T11:07:33.382274Z","end":"2026-04-19T11:07:33.488456Z","steps":["trace[665822410] 'agreement among raft nodes before linearized reading' (duration: 105.897581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:34.096043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.107102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:07:34.096088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.4702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:07:34.096146Z","caller":"traceutil/trace.go:171","msg":"trace[2058881106] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"231.272967ms","start":"2026-04-19T11:07:33.864853Z","end":"2026-04-19T11:07:34.096126Z","steps":["trace[2058881106] 'range keys from in-memory index tree' (duration: 231.02216ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:07:34.096179Z","caller":"traceutil/trace.go:171","msg":"trace[585209550] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"204.616644ms","start":"2026-04-19T11:07:33.891543Z","end":"2026-04-19T11:07:34.09616Z","steps":["trace[585209550] 'range keys from in-memory index tree' (duration: 204.399698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:34.096195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.263807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:07:34.096224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.130944ms","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:5"} {"level":"info","ts":"2026-04-19T11:07:34.096271Z","caller":"traceutil/trace.go:171","msg":"trace[505968349] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"247.394052ms","start":"2026-04-19T11:07:33.848861Z","end":"2026-04-19T11:07:34.096255Z","steps":["trace[505968349] 'range keys from in-memory index tree' (duration: 247.188815ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:07:34.096285Z","caller":"traceutil/trace.go:171","msg":"trace[568224437] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"247.200726ms","start":"2026-04-19T11:07:33.849069Z","end":"2026-04-19T11:07:34.09627Z","steps":["trace[568224437] 'count revisions from in-memory index tree' (duration: 247.037142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:34.096066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.168324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:07:34.096422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.014541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:07:34.096455Z","caller":"traceutil/trace.go:171","msg":"trace[1757302671] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"231.070832ms","start":"2026-04-19T11:07:33.865376Z","end":"2026-04-19T11:07:34.096447Z","steps":["trace[1757302671] 'range keys from in-memory index tree' (duration: 230.98051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:34.09646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.808349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:07:34.096477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.536731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:07:34.096496Z","caller":"traceutil/trace.go:171","msg":"trace[51244453] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"205.887102ms","start":"2026-04-19T11:07:33.890598Z","end":"2026-04-19T11:07:34.096485Z","steps":["trace[51244453] 'count revisions from in-memory index tree' (duration: 205.721017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:34.096508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.818929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-td2sh\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-19T11:07:34.096512Z","caller":"traceutil/trace.go:171","msg":"trace[598410174] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"231.594537ms","start":"2026-04-19T11:07:33.864824Z","end":"2026-04-19T11:07:34.096419Z","steps":["trace[598410174] 'count revisions from in-memory index tree' (duration: 231.03368ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:07:34.096541Z","caller":"traceutil/trace.go:171","msg":"trace[711826717] range","detail":"{range_begin:/registry/pods/kube-system/cilium-td2sh; range_end:; response_count:1; response_revision:624; }","duration":"369.889142ms","start":"2026-04-19T11:07:33.726642Z","end":"2026-04-19T11:07:34.096531Z","steps":["trace[711826717] 'range keys from in-memory index tree' (duration: 369.676395ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:07:34.096525Z","caller":"traceutil/trace.go:171","msg":"trace[1823094063] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"205.618614ms","start":"2026-04-19T11:07:33.890887Z","end":"2026-04-19T11:07:34.096505Z","steps":["trace[1823094063] 'range keys from in-memory index tree' (duration: 205.48175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:34.096571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:07:33.726624Z","time spent":"369.937783ms","remote":"127.0.0.1:60910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-td2sh\" "} {"level":"info","ts":"2026-04-19T11:07:34.100825Z","caller":"traceutil/trace.go:171","msg":"trace[407051402] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"170.340867ms","start":"2026-04-19T11:07:33.930469Z","end":"2026-04-19T11:07:34.10081Z","steps":["trace[407051402] 'read index received' (duration: 136.542204ms)","trace[407051402] 'applied index is now lower than readState.Index' (duration: 33.796863ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:07:34.10093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.45307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:07:34.100957Z","caller":"traceutil/trace.go:171","msg":"trace[1243321548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:624; }","duration":"170.511282ms","start":"2026-04-19T11:07:33.930438Z","end":"2026-04-19T11:07:34.100949Z","steps":["trace[1243321548] 'agreement among raft nodes before linearized reading' (duration: 170.45842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:34.101913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.384318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:07:34.102069Z","caller":"traceutil/trace.go:171","msg":"trace[1730094633] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"171.587854ms","start":"2026-04-19T11:07:33.930465Z","end":"2026-04-19T11:07:34.102053Z","steps":["trace[1730094633] 'agreement among raft nodes before linearized reading' (duration: 171.362597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:34.106258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.701553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:07:34.106315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.999173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:07:34.106367Z","caller":"traceutil/trace.go:171","msg":"trace[1865491068] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:625; }","duration":"110.837538ms","start":"2026-04-19T11:07:33.995507Z","end":"2026-04-19T11:07:34.106344Z","steps":["trace[1865491068] 'agreement among raft nodes before linearized reading' (duration: 110.652062ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:07:34.106383Z","caller":"traceutil/trace.go:171","msg":"trace[1951363875] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"175.072295ms","start":"2026-04-19T11:07:33.931279Z","end":"2026-04-19T11:07:34.106352Z","steps":["trace[1951363875] 'agreement among raft nodes before linearized reading' (duration: 174.973282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:07:34.106327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.893499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:07:34.106264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.799166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:07:34.106526Z","caller":"traceutil/trace.go:171","msg":"trace[1773234759] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:625; }","duration":"111.102815ms","start":"2026-04-19T11:07:33.995365Z","end":"2026-04-19T11:07:34.106468Z","steps":["trace[1773234759] 'agreement among raft nodes before linearized reading' (duration: 110.854628ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:07:34.106679Z","caller":"traceutil/trace.go:171","msg":"trace[2145469347] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:625; }","duration":"111.108505ms","start":"2026-04-19T11:07:33.99542Z","end":"2026-04-19T11:07:34.106528Z","steps":["trace[2145469347] 'agreement among raft nodes before linearized reading' (duration: 110.780976ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:08:17.938865Z","caller":"traceutil/trace.go:171","msg":"trace[1376654741] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"108.139078ms","start":"2026-04-19T11:08:17.830688Z","end":"2026-04-19T11:08:17.938827Z","steps":["trace[1376654741] 'process raft request' (duration: 107.84654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:09:09.189594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.126686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-19T11:09:09.189766Z","caller":"traceutil/trace.go:171","msg":"trace[17803414] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1871; }","duration":"132.401744ms","start":"2026-04-19T11:09:09.057326Z","end":"2026-04-19T11:09:09.189728Z","steps":["trace[17803414] 'range keys from in-memory index tree' (duration: 131.757525ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:09:20.879972Z","caller":"traceutil/trace.go:171","msg":"trace[1378490768] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"114.85375ms","start":"2026-04-19T11:09:20.765077Z","end":"2026-04-19T11:09:20.87993Z","steps":["trace[1378490768] 'process raft request' (duration: 114.681835ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:09:57.303621Z","caller":"traceutil/trace.go:171","msg":"trace[1635902718] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"108.89107ms","start":"2026-04-19T11:09:57.194703Z","end":"2026-04-19T11:09:57.303594Z","steps":["trace[1635902718] 'process raft request' (duration: 108.724925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:09:57.590107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.72972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-04-19T11:09:57.590174Z","caller":"traceutil/trace.go:171","msg":"trace[1199984600] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2182; }","duration":"243.839994ms","start":"2026-04-19T11:09:57.346319Z","end":"2026-04-19T11:09:57.590159Z","steps":["trace[1199984600] 'range keys from in-memory index tree' (duration: 243.576736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:09:57.590082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.414897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:09:57.590334Z","caller":"traceutil/trace.go:171","msg":"trace[760660845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2182; }","duration":"206.757877ms","start":"2026-04-19T11:09:57.383564Z","end":"2026-04-19T11:09:57.590322Z","steps":["trace[760660845] 'range keys from in-memory index tree' (duration: 206.197452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:09:57.591019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.756227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:09:57.5913Z","caller":"traceutil/trace.go:171","msg":"trace[18423342] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"143.196545ms","start":"2026-04-19T11:09:57.448034Z","end":"2026-04-19T11:09:57.591231Z","steps":["trace[18423342] 'process raft request' (duration: 19.314986ms)","trace[18423342] 'compare' (duration: 122.55269ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:09:57.812043Z","caller":"traceutil/trace.go:171","msg":"trace[1327754482] linearizableReadLoop","detail":"{readStateIndex:2270; appliedIndex:2269; }","duration":"213.645769ms","start":"2026-04-19T11:09:57.598359Z","end":"2026-04-19T11:09:57.812005Z","steps":["trace[1327754482] 'read index received' (duration: 140.419013ms)","trace[1327754482] 'applied index is now lower than readState.Index' (duration: 73.225206ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:09:57.812322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.943238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:09:57.81242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.397304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-19T11:09:57.812335Z","caller":"traceutil/trace.go:171","msg":"trace[74874065] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"217.481111ms","start":"2026-04-19T11:09:57.59462Z","end":"2026-04-19T11:09:57.812101Z","steps":["trace[74874065] 'process raft request' (duration: 144.168114ms)","trace[74874065] 'compare' (duration: 73.05909ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:09:57.812438Z","caller":"traceutil/trace.go:171","msg":"trace[372932094] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2184; }","duration":"214.103373ms","start":"2026-04-19T11:09:57.598311Z","end":"2026-04-19T11:09:57.812414Z","steps":["trace[372932094] 'agreement among raft nodes before linearized reading' (duration: 213.877946ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:09:57.812467Z","caller":"traceutil/trace.go:171","msg":"trace[1337077711] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2184; }","duration":"153.516688ms","start":"2026-04-19T11:09:57.658937Z","end":"2026-04-19T11:09:57.812454Z","steps":["trace[1337077711] 'agreement among raft nodes before linearized reading' (duration: 153.26409ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:13:49.878618Z","caller":"traceutil/trace.go:171","msg":"trace[2058768227] linearizableReadLoop","detail":"{readStateIndex:3966; appliedIndex:3965; }","duration":"140.804302ms","start":"2026-04-19T11:13:49.737781Z","end":"2026-04-19T11:13:49.878586Z","steps":["trace[2058768227] 'read index received' (duration: 140.576766ms)","trace[2058768227] 'applied index is now lower than readState.Index' (duration: 226.266µs)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:13:49.878769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.957677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-19T11:13:49.878813Z","caller":"traceutil/trace.go:171","msg":"trace[1989525652] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:3816; }","duration":"141.059579ms","start":"2026-04-19T11:13:49.737741Z","end":"2026-04-19T11:13:49.8788Z","steps":["trace[1989525652] 'agreement among raft nodes before linearized reading' (duration: 140.964007ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:13:49.878714Z","caller":"traceutil/trace.go:171","msg":"trace[787417751] transaction","detail":"{read_only:false; response_revision:3816; number_of_response:1; }","duration":"145.761755ms","start":"2026-04-19T11:13:49.732918Z","end":"2026-04-19T11:13:49.87868Z","steps":["trace[787417751] 'process raft request' (duration: 145.520338ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:13:55.160665Z","caller":"traceutil/trace.go:171","msg":"trace[1517431933] linearizableReadLoop","detail":"{readStateIndex:3992; appliedIndex:3991; }","duration":"100.861997ms","start":"2026-04-19T11:13:55.059769Z","end":"2026-04-19T11:13:55.160631Z","steps":["trace[1517431933] 'read index received' (duration: 100.529148ms)","trace[1517431933] 'applied index is now lower than readState.Index' (duration: 331.309µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:13:55.160749Z","caller":"traceutil/trace.go:171","msg":"trace[1977508236] transaction","detail":"{read_only:false; response_revision:3841; number_of_response:1; }","duration":"118.589579ms","start":"2026-04-19T11:13:55.0421Z","end":"2026-04-19T11:13:55.16069Z","steps":["trace[1977508236] 'process raft request' (duration: 118.294491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:13:55.161041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.246938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-19T11:13:55.1611Z","caller":"traceutil/trace.go:171","msg":"trace[1105943772] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3841; }","duration":"101.371172ms","start":"2026-04-19T11:13:55.059716Z","end":"2026-04-19T11:13:55.161087Z","steps":["trace[1105943772] 'agreement among raft nodes before linearized reading' (duration: 101.031442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:25.46981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.577696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:15:25.469951Z","caller":"traceutil/trace.go:171","msg":"trace[1667398318] linearizableReadLoop","detail":"{readStateIndex:5242; appliedIndex:5240; }","duration":"296.205934ms","start":"2026-04-19T11:15:25.173732Z","end":"2026-04-19T11:15:25.469938Z","steps":["trace[1667398318] 'read index received' (duration: 159.367171ms)","trace[1667398318] 'applied index is now lower than readState.Index' (duration: 136.837703ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:15:25.470165Z","caller":"traceutil/trace.go:171","msg":"trace[1741729691] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"352.521287ms","start":"2026-04-19T11:15:25.117632Z","end":"2026-04-19T11:15:25.470153Z","steps":["trace[1741729691] 'process raft request' (duration: 215.54427ms)","trace[1741729691] 'compare' (duration: 136.469613ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:15:25.470217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:15:25.1176Z","time spent":"352.596539ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T11:15:25.470361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.616227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6d362dcf-c577-4859-87b0-168d6b34aa4a\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-04-19T11:15:25.470432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.861029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6d362dcf-c577-4859-87b0-168d6b34aa4a\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-19T11:15:25.470439Z","caller":"traceutil/trace.go:171","msg":"trace[1433430336] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6d362dcf-c577-4859-87b0-168d6b34aa4a; range_end:; response_count:1; response_revision:5046; }","duration":"296.74086ms","start":"2026-04-19T11:15:25.173682Z","end":"2026-04-19T11:15:25.470422Z","steps":["trace[1433430336] 'agreement among raft nodes before linearized reading' (duration: 296.516594ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:25.47046Z","caller":"traceutil/trace.go:171","msg":"trace[1531146482] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6d362dcf-c577-4859-87b0-168d6b34aa4a; range_end:; response_count:1; response_revision:5046; }","duration":"167.925761ms","start":"2026-04-19T11:15:25.302525Z","end":"2026-04-19T11:15:25.470451Z","steps":["trace[1531146482] 'agreement among raft nodes before linearized reading' (duration: 167.823258ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:25.470499Z","caller":"traceutil/trace.go:171","msg":"trace[1435756824] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"351.304332ms","start":"2026-04-19T11:15:25.11917Z","end":"2026-04-19T11:15:25.470475Z","steps":["trace[1435756824] 'process raft request' (duration: 350.718926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:25.470622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:15:25.119143Z","time spent":"351.421706ms","remote":"127.0.0.1:32944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4833,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:15:25.671181Z","caller":"traceutil/trace.go:171","msg":"trace[572082919] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"113.967786ms","start":"2026-04-19T11:15:25.557179Z","end":"2026-04-19T11:15:25.671146Z","steps":["trace[572082919] 'process raft request' (duration: 113.747449ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:25.671318Z","caller":"traceutil/trace.go:171","msg":"trace[1833583639] transaction","detail":"{read_only:false; response_revision:5053; number_of_response:1; }","duration":"111.33945ms","start":"2026-04-19T11:15:25.559936Z","end":"2026-04-19T11:15:25.671275Z","steps":["trace[1833583639] 'process raft request' (duration: 111.126323ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:25.878378Z","caller":"traceutil/trace.go:171","msg":"trace[651202386] transaction","detail":"{read_only:false; response_revision:5054; number_of_response:1; }","duration":"233.350919ms","start":"2026-04-19T11:15:25.644988Z","end":"2026-04-19T11:15:25.878339Z","steps":["trace[651202386] 'process raft request' (duration: 193.141766ms)","trace[651202386] 'compare' (duration: 39.74408ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:15:25.878503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.348872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-19T11:15:25.878526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.216927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-19T11:15:25.878574Z","caller":"traceutil/trace.go:171","msg":"trace[201257506] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5054; }","duration":"219.458505ms","start":"2026-04-19T11:15:25.6591Z","end":"2026-04-19T11:15:25.878558Z","steps":["trace[201257506] 'agreement among raft nodes before linearized reading' (duration: 219.241447ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:25.878595Z","caller":"traceutil/trace.go:171","msg":"trace[2090413841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5054; }","duration":"233.33566ms","start":"2026-04-19T11:15:25.645242Z","end":"2026-04-19T11:15:25.878578Z","steps":["trace[2090413841] 'agreement among raft nodes before linearized reading' (duration: 233.142894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:25.878635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.544105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-19T11:15:25.878708Z","caller":"traceutil/trace.go:171","msg":"trace[1993343834] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5054; }","duration":"235.675769ms","start":"2026-04-19T11:15:25.643018Z","end":"2026-04-19T11:15:25.878694Z","steps":["trace[1993343834] 'agreement among raft nodes before linearized reading' (duration: 235.456442ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:25.879015Z","caller":"traceutil/trace.go:171","msg":"trace[583701082] linearizableReadLoop","detail":"{readStateIndex:5250; appliedIndex:5249; }","duration":"207.200437ms","start":"2026-04-19T11:15:25.671115Z","end":"2026-04-19T11:15:25.878315Z","steps":["trace[583701082] 'read index received' (duration: 167.155388ms)","trace[583701082] 'applied index is now lower than readState.Index' (duration: 40.043719ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:15:25.894517Z","caller":"traceutil/trace.go:171","msg":"trace[423201422] transaction","detail":"{read_only:false; response_revision:5055; number_of_response:1; }","duration":"218.750474ms","start":"2026-04-19T11:15:25.67574Z","end":"2026-04-19T11:15:25.89449Z","steps":["trace[423201422] 'process raft request' (duration: 218.660781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:25.895032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.618312ms","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-04-19T11:15:25.895098Z","caller":"traceutil/trace.go:171","msg":"trace[528396205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5055; }","duration":"141.727955ms","start":"2026-04-19T11:15:25.753358Z","end":"2026-04-19T11:15:25.895086Z","steps":["trace[528396205] 'agreement among raft nodes before linearized reading' (duration: 141.54792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:25.895314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.204072ms","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-04-19T11:15:25.895354Z","caller":"traceutil/trace.go:171","msg":"trace[1515681103] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5055; }","duration":"140.261573ms","start":"2026-04-19T11:15:25.75508Z","end":"2026-04-19T11:15:25.895342Z","steps":["trace[1515681103] 'agreement among raft nodes before linearized reading' (duration: 140.16768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:25.895341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.996654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/monitoring/vector\" ","response":"range_response_count:1 size:5083"} {"level":"info","ts":"2026-04-19T11:15:25.895479Z","caller":"traceutil/trace.go:171","msg":"trace[1721928202] range","detail":"{range_begin:/registry/daemonsets/monitoring/vector; range_end:; response_count:1; response_revision:5055; }","duration":"216.116327ms","start":"2026-04-19T11:15:25.679325Z","end":"2026-04-19T11:15:25.895441Z","steps":["trace[1721928202] 'agreement among raft nodes before linearized reading' (duration: 215.949833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:25.895661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.428635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/vector-vmzkh\" ","response":"range_response_count:1 size:4949"} {"level":"info","ts":"2026-04-19T11:15:25.895688Z","caller":"traceutil/trace.go:171","msg":"trace[1245367717] range","detail":"{range_begin:/registry/pods/monitoring/vector-vmzkh; range_end:; response_count:1; response_revision:5055; }","duration":"217.454876ms","start":"2026-04-19T11:15:25.678225Z","end":"2026-04-19T11:15:25.89568Z","steps":["trace[1245367717] 'agreement among raft nodes before linearized reading' (duration: 217.388704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:36.818386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.641788ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:15:36.81869Z","caller":"traceutil/trace.go:171","msg":"trace[902358820] transaction","detail":"{read_only:false; response_revision:5274; number_of_response:1; }","duration":"343.398142ms","start":"2026-04-19T11:15:36.475237Z","end":"2026-04-19T11:15:36.818636Z","steps":["trace[902358820] 'process raft request' (duration: 96.412834ms)","trace[902358820] 'compare' (duration: 246.082191ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:15:36.818837Z","caller":"traceutil/trace.go:171","msg":"trace[1508028630] transaction","detail":"{read_only:false; response_revision:5275; number_of_response:1; }","duration":"343.479224ms","start":"2026-04-19T11:15:36.475332Z","end":"2026-04-19T11:15:36.818811Z","steps":["trace[1508028630] 'process raft request' (duration: 343.181575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:36.818971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:15:36.475218Z","time spent":"343.582517ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1329,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:15:36.819244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:15:36.475307Z","time spent":"343.625418ms","remote":"127.0.0.1:32944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8196,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:15:36.819436Z","caller":"traceutil/trace.go:171","msg":"trace[750663202] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"337.592991ms","start":"2026-04-19T11:15:36.481822Z","end":"2026-04-19T11:15:36.819415Z","steps":["trace[750663202] 'process raft request' (duration: 336.832699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:36.819548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:15:36.481804Z","time spent":"337.691214ms","remote":"127.0.0.1:60910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8041,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:15:36.819563Z","caller":"traceutil/trace.go:171","msg":"trace[1802793721] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"318.721641ms","start":"2026-04-19T11:15:36.500823Z","end":"2026-04-19T11:15:36.819544Z","steps":["trace[1802793721] 'process raft request' (duration: 318.528786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:36.819669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:15:36.500799Z","time spent":"318.807974ms","remote":"127.0.0.1:60994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:15:36.823443Z","caller":"traceutil/trace.go:171","msg":"trace[1623531216] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"193.984581ms","start":"2026-04-19T11:15:36.629438Z","end":"2026-04-19T11:15:36.823423Z","steps":["trace[1623531216] 'process raft request' (duration: 193.877698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:50.394805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.752885ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:15:50.394986Z","caller":"traceutil/trace.go:171","msg":"trace[422852055] linearizableReadLoop","detail":"{readStateIndex:5735; appliedIndex:5733; }","duration":"160.458082ms","start":"2026-04-19T11:15:50.234512Z","end":"2026-04-19T11:15:50.39497Z","steps":["trace[422852055] 'read index received' (duration: 15.544783ms)","trace[422852055] 'applied index is now lower than readState.Index' (duration: 144.912149ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:15:50.395077Z","caller":"traceutil/trace.go:171","msg":"trace[66261186] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"215.18583ms","start":"2026-04-19T11:15:50.179881Z","end":"2026-04-19T11:15:50.395067Z","steps":["trace[66261186] 'process raft request' (duration: 215.027215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:50.395415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.198888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a849b01a-0db3-40f6-8024-e57ae2f769fe\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-19T11:15:50.395453Z","caller":"traceutil/trace.go:171","msg":"trace[1899953551] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a849b01a-0db3-40f6-8024-e57ae2f769fe; range_end:; response_count:1; response_revision:5528; }","duration":"193.28944ms","start":"2026-04-19T11:15:50.202152Z","end":"2026-04-19T11:15:50.395442Z","steps":["trace[1899953551] 'agreement among raft nodes before linearized reading' (duration: 193.171717ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:50.395548Z","caller":"traceutil/trace.go:171","msg":"trace[945687416] transaction","detail":"{read_only:false; response_revision:5527; number_of_response:1; }","duration":"241.767966ms","start":"2026-04-19T11:15:50.153752Z","end":"2026-04-19T11:15:50.39552Z","steps":["trace[945687416] 'process raft request' (duration: 96.225928ms)","trace[945687416] 'compare' (duration: 144.612001ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:15:50.593815Z","caller":"traceutil/trace.go:171","msg":"trace[238333405] linearizableReadLoop","detail":"{readStateIndex:5736; appliedIndex:5735; }","duration":"109.421263ms","start":"2026-04-19T11:15:50.484375Z","end":"2026-04-19T11:15:50.593796Z","steps":["trace[238333405] 'read index received' (duration: 109.069993ms)","trace[238333405] 'applied index is now lower than readState.Index' (duration: 350.67µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:15:50.594233Z","caller":"traceutil/trace.go:171","msg":"trace[1724800767] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"114.947895ms","start":"2026-04-19T11:15:50.479249Z","end":"2026-04-19T11:15:50.594197Z","steps":["trace[1724800767] 'process raft request' (duration: 114.241204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:15:50.594262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.861706ms","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:2082"} {"level":"info","ts":"2026-04-19T11:15:50.594392Z","caller":"traceutil/trace.go:171","msg":"trace[1559970965] 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:5529; }","duration":"110.021931ms","start":"2026-04-19T11:15:50.484351Z","end":"2026-04-19T11:15:50.594373Z","steps":["trace[1559970965] 'agreement among raft nodes before linearized reading' (duration: 109.65252ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:50.933829Z","caller":"traceutil/trace.go:171","msg":"trace[814140670] transaction","detail":"{read_only:false; response_revision:5534; number_of_response:1; }","duration":"143.138547ms","start":"2026-04-19T11:15:50.790651Z","end":"2026-04-19T11:15:50.93379Z","steps":["trace[814140670] 'process raft request' (duration: 142.89492ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:50.933894Z","caller":"traceutil/trace.go:171","msg":"trace[1919974330] transaction","detail":"{read_only:false; response_revision:5536; number_of_response:1; }","duration":"142.23957ms","start":"2026-04-19T11:15:50.791626Z","end":"2026-04-19T11:15:50.933866Z","steps":["trace[1919974330] 'process raft request' (duration: 142.108026ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:50.933922Z","caller":"traceutil/trace.go:171","msg":"trace[1070422872] transaction","detail":"{read_only:false; response_revision:5535; number_of_response:1; }","duration":"142.901271ms","start":"2026-04-19T11:15:50.790991Z","end":"2026-04-19T11:15:50.933892Z","steps":["trace[1070422872] 'process raft request' (duration: 142.715985ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:50.934017Z","caller":"traceutil/trace.go:171","msg":"trace[1275257203] transaction","detail":"{read_only:false; response_revision:5537; number_of_response:1; }","duration":"134.099693ms","start":"2026-04-19T11:15:50.799908Z","end":"2026-04-19T11:15:50.934007Z","steps":["trace[1275257203] 'process raft request' (duration: 133.869536ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:15:50.93423Z","caller":"traceutil/trace.go:171","msg":"trace[1309403266] linearizableReadLoop","detail":"{readStateIndex:5743; appliedIndex:5739; }","duration":"142.484949ms","start":"2026-04-19T11:15:50.791685Z","end":"2026-04-19T11:15:50.93417Z","steps":["trace[1309403266] 'read index received' (duration: 92.86849ms)","trace[1309403266] 'applied index is now lower than readState.Index' (duration: 49.614699ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:15:50.934471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.764896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13664"} {"level":"info","ts":"2026-04-19T11:15:50.934511Z","caller":"traceutil/trace.go:171","msg":"trace[1274676424] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5538; }","duration":"142.848779ms","start":"2026-04-19T11:15:50.79165Z","end":"2026-04-19T11:15:50.934499Z","steps":["trace[1274676424] 'agreement among raft nodes before linearized reading' (duration: 142.698875ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:16:55.582794Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3022} {"level":"info","ts":"2026-04-19T11:16:55.665305Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3022,"took":"81.225498ms","hash":2710617543,"current-db-size-bytes":56549376,"current-db-size":"56 MB","current-db-size-in-use-bytes":31305728,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-19T11:16:55.665462Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2710617543,"revision":3022,"compact-revision":-1} {"level":"info","ts":"2026-04-19T11:21:49.212326Z","caller":"traceutil/trace.go:171","msg":"trace[1829385294] transaction","detail":"{read_only:false; response_revision:8266; number_of_response:1; }","duration":"383.006721ms","start":"2026-04-19T11:21:48.829281Z","end":"2026-04-19T11:21:49.212288Z","steps":["trace[1829385294] 'process raft request' (duration: 349.934817ms)","trace[1829385294] 'compare' (duration: 32.92275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:21:49.212545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:21:48.829256Z","time spent":"383.178917ms","remote":"127.0.0.1:60834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1114,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:21:55.590264Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6079} {"level":"info","ts":"2026-04-19T11:21:55.680233Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6079,"took":"88.325615ms","hash":1944392046,"current-db-size-bytes":56549376,"current-db-size":"56 MB","current-db-size-in-use-bytes":23654400,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-19T11:21:55.680308Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1944392046,"revision":6079,"compact-revision":3022} {"level":"info","ts":"2026-04-19T11:22:00.391207Z","caller":"traceutil/trace.go:171","msg":"trace[1456089817] transaction","detail":"{read_only:false; response_revision:8325; number_of_response:1; }","duration":"104.832547ms","start":"2026-04-19T11:22:00.286353Z","end":"2026-04-19T11:22:00.391185Z","steps":["trace[1456089817] 'process raft request' (duration: 104.693693ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:22:01.058497Z","caller":"traceutil/trace.go:171","msg":"trace[448514245] transaction","detail":"{read_only:false; response_revision:8330; number_of_response:1; }","duration":"162.795208ms","start":"2026-04-19T11:22:00.895677Z","end":"2026-04-19T11:22:01.058472Z","steps":["trace[448514245] 'process raft request' (duration: 162.623573ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:22:02.087378Z","caller":"traceutil/trace.go:171","msg":"trace[205765445] transaction","detail":"{read_only:false; response_revision:8332; number_of_response:1; }","duration":"104.485077ms","start":"2026-04-19T11:22:01.982857Z","end":"2026-04-19T11:22:02.087342Z","steps":["trace[205765445] 'process raft request' (duration: 53.021306ms)","trace[205765445] 'compare' (duration: 51.242065ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:22:02.638298Z","caller":"traceutil/trace.go:171","msg":"trace[390359166] linearizableReadLoop","detail":"{readStateIndex:8633; appliedIndex:8632; }","duration":"232.097951ms","start":"2026-04-19T11:22:02.406176Z","end":"2026-04-19T11:22:02.638274Z","steps":["trace[390359166] 'read index received' (duration: 231.963137ms)","trace[390359166] 'applied index is now lower than readState.Index' (duration: 133.334µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:22:02.638397Z","caller":"traceutil/trace.go:171","msg":"trace[1407216752] transaction","detail":"{read_only:false; response_revision:8335; number_of_response:1; }","duration":"238.60545ms","start":"2026-04-19T11:22:02.399774Z","end":"2026-04-19T11:22:02.638379Z","steps":["trace[1407216752] 'process raft request' (duration: 238.345412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:02.638543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.360318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-7b4tz\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-19T11:22:02.638576Z","caller":"traceutil/trace.go:171","msg":"trace[148610305] range","detail":"{range_begin:/registry/pods/openstack/keepalived-7b4tz; range_end:; response_count:1; response_revision:8335; }","duration":"232.454621ms","start":"2026-04-19T11:22:02.406112Z","end":"2026-04-19T11:22:02.638566Z","steps":["trace[148610305] 'agreement among raft nodes before linearized reading' (duration: 232.279596ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:22:02.780651Z","caller":"traceutil/trace.go:171","msg":"trace[1284020848] transaction","detail":"{read_only:false; response_revision:8336; number_of_response:1; }","duration":"352.734239ms","start":"2026-04-19T11:22:02.427877Z","end":"2026-04-19T11:22:02.780611Z","steps":["trace[1284020848] 'process raft request' (duration: 328.079349ms)","trace[1284020848] 'compare' (duration: 24.287029ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:22:02.780739Z","caller":"traceutil/trace.go:171","msg":"trace[199953877] transaction","detail":"{read_only:false; response_revision:8337; number_of_response:1; }","duration":"337.241646ms","start":"2026-04-19T11:22:02.443467Z","end":"2026-04-19T11:22:02.780708Z","steps":["trace[199953877] 'process raft request' (duration: 337.056441ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:22:02.780819Z","caller":"traceutil/trace.go:171","msg":"trace[1825722014] linearizableReadLoop","detail":"{readStateIndex:8636; appliedIndex:8633; }","duration":"142.426455ms","start":"2026-04-19T11:22:02.638363Z","end":"2026-04-19T11:22:02.78079Z","steps":["trace[1825722014] 'read index received' (duration: 117.502668ms)","trace[1825722014] 'applied index is now lower than readState.Index' (duration: 24.922387ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:22:02.780856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:02.42786Z","time spent":"352.872813ms","remote":"127.0.0.1:60994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:22:02.780958Z","caller":"traceutil/trace.go:171","msg":"trace[1519260559] transaction","detail":"{read_only:false; response_revision:8338; number_of_response:1; }","duration":"332.866069ms","start":"2026-04-19T11:22:02.44808Z","end":"2026-04-19T11:22:02.780946Z","steps":["trace[1519260559] 'process raft request' (duration: 332.586741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:02.780971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:02.443448Z","time spent":"337.397541ms","remote":"127.0.0.1:60994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:22:02.781071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:02.448055Z","time spent":"332.939202ms","remote":"127.0.0.1:60994","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-04-19T11:22:02.781154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.780841ms","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-04-19T11:22:02.781212Z","caller":"traceutil/trace.go:171","msg":"trace[1184269372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8338; }","duration":"182.887824ms","start":"2026-04-19T11:22:02.598306Z","end":"2026-04-19T11:22:02.781194Z","steps":["trace[1184269372] 'agreement among raft nodes before linearized reading' (duration: 182.691819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:02.781278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.679944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:223819"} {"level":"info","ts":"2026-04-19T11:22:02.78132Z","caller":"traceutil/trace.go:171","msg":"trace[1816090895] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8338; }","duration":"138.744507ms","start":"2026-04-19T11:22:02.642566Z","end":"2026-04-19T11:22:02.78131Z","steps":["trace[1816090895] 'agreement among raft nodes before linearized reading' (duration: 138.386136ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:22:31.040751Z","caller":"traceutil/trace.go:171","msg":"trace[1887973020] transaction","detail":"{read_only:false; response_revision:8542; number_of_response:1; }","duration":"153.376321ms","start":"2026-04-19T11:22:30.887248Z","end":"2026-04-19T11:22:31.040625Z","steps":["trace[1887973020] 'process raft request' (duration: 153.224897ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:22:31.051221Z","caller":"traceutil/trace.go:171","msg":"trace[1115582941] linearizableReadLoop","detail":"{readStateIndex:8849; appliedIndex:8847; }","duration":"132.312577ms","start":"2026-04-19T11:22:30.918885Z","end":"2026-04-19T11:22:31.051198Z","steps":["trace[1115582941] 'read index received' (duration: 121.568402ms)","trace[1115582941] 'applied index is now lower than readState.Index' (duration: 10.742895ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:22:31.051335Z","caller":"traceutil/trace.go:171","msg":"trace[1255726756] transaction","detail":"{read_only:false; response_revision:8543; number_of_response:1; }","duration":"163.996482ms","start":"2026-04-19T11:22:30.887318Z","end":"2026-04-19T11:22:31.051315Z","steps":["trace[1255726756] 'process raft request' (duration: 163.742474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:31.051454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.284307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-7b4tz\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-19T11:22:31.051503Z","caller":"traceutil/trace.go:171","msg":"trace[916469747] range","detail":"{range_begin:/registry/pods/openstack/keepalived-7b4tz; range_end:; response_count:1; response_revision:8543; }","duration":"105.381899ms","start":"2026-04-19T11:22:30.94611Z","end":"2026-04-19T11:22:31.051492Z","steps":["trace[916469747] 'agreement among raft nodes before linearized reading' (duration: 105.241425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:31.051537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.600945ms","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-04-19T11:22:31.051619Z","caller":"traceutil/trace.go:171","msg":"trace[232020303] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8543; }","duration":"132.75173ms","start":"2026-04-19T11:22:30.918849Z","end":"2026-04-19T11:22:31.051601Z","steps":["trace[232020303] 'agreement among raft nodes before linearized reading' (duration: 132.481372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:44.614695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.708653ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-19T11:22:44.61486Z","caller":"traceutil/trace.go:171","msg":"trace[1696886853] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8653; }","duration":"233.683177ms","start":"2026-04-19T11:22:44.38115Z","end":"2026-04-19T11:22:44.614834Z","steps":["trace[1696886853] 'process raft request' (duration: 108.725397ms)","trace[1696886853] 'compare' (duration: 124.627891ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:22:44.614996Z","caller":"traceutil/trace.go:171","msg":"trace[1188273898] linearizableReadLoop","detail":"{readStateIndex:8965; appliedIndex:8963; }","duration":"140.621788ms","start":"2026-04-19T11:22:44.474362Z","end":"2026-04-19T11:22:44.614984Z","steps":["trace[1188273898] 'read index received' (duration: 15.530494ms)","trace[1188273898] 'applied index is now lower than readState.Index' (duration: 125.089984ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:22:44.6152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.834924ms","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-04-19T11:22:44.615229Z","caller":"traceutil/trace.go:171","msg":"trace[769356319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8654; }","duration":"140.896496ms","start":"2026-04-19T11:22:44.474325Z","end":"2026-04-19T11:22:44.615222Z","steps":["trace[769356319] 'agreement among raft nodes before linearized reading' (duration: 140.70723ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:22:44.61523Z","caller":"traceutil/trace.go:171","msg":"trace[2133164310] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"233.41729ms","start":"2026-04-19T11:22:44.381801Z","end":"2026-04-19T11:22:44.615218Z","steps":["trace[2133164310] 'process raft request' (duration: 232.978467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:45.448569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.797593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:22:45.448676Z","caller":"traceutil/trace.go:171","msg":"trace[1947590005] linearizableReadLoop","detail":"{readStateIndex:8972; appliedIndex:8970; }","duration":"323.635016ms","start":"2026-04-19T11:22:45.125027Z","end":"2026-04-19T11:22:45.448662Z","steps":["trace[1947590005] 'read index received' (duration: 36.63197ms)","trace[1947590005] 'applied index is now lower than readState.Index' (duration: 287.002016ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:22:45.448815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.788621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-19T11:22:45.448842Z","caller":"traceutil/trace.go:171","msg":"trace[320607374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8661; }","duration":"323.863413ms","start":"2026-04-19T11:22:45.124971Z","end":"2026-04-19T11:22:45.448834Z","steps":["trace[320607374] 'agreement among raft nodes before linearized reading' (duration: 323.751639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:45.448866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:45.12495Z","time spent":"323.910924ms","remote":"127.0.0.1:60994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-19T11:22:45.448832Z","caller":"traceutil/trace.go:171","msg":"trace[186763764] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"340.190179ms","start":"2026-04-19T11:22:45.108584Z","end":"2026-04-19T11:22:45.448774Z","steps":["trace[186763764] 'process raft request' (duration: 211.110407ms)","trace[186763764] 'compare' (duration: 128.689171ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:22:45.449098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:45.108574Z","time spent":"340.391585ms","remote":"127.0.0.1:60994","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-04-19T11:22:45.454443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.143618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-19T11:22:45.454514Z","caller":"traceutil/trace.go:171","msg":"trace[2050612807] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8662; }","duration":"314.261002ms","start":"2026-04-19T11:22:45.140238Z","end":"2026-04-19T11:22:45.454499Z","steps":["trace[2050612807] 'agreement among raft nodes before linearized reading' (duration: 314.065386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:45.454545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:45.140223Z","time spent":"314.316413ms","remote":"127.0.0.1:60994","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-04-19T11:22:45.454567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.793495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-7b4tz\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-19T11:22:45.454656Z","caller":"traceutil/trace.go:171","msg":"trace[543541648] range","detail":"{range_begin:/registry/pods/openstack/keepalived-7b4tz; range_end:; response_count:1; response_revision:8662; }","duration":"304.919749ms","start":"2026-04-19T11:22:45.149714Z","end":"2026-04-19T11:22:45.454634Z","steps":["trace[543541648] 'agreement among raft nodes before linearized reading' (duration: 304.693062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:22:45.454744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:22:45.1497Z","time spent":"305.031413ms","remote":"127.0.0.1:60910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-7b4tz\" "} {"level":"info","ts":"2026-04-19T11:23:21.647567Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000246f.wal"} {"level":"info","ts":"2026-04-19T11:23:45.787668Z","caller":"traceutil/trace.go:171","msg":"trace[519723153] transaction","detail":"{read_only:false; response_revision:9308; number_of_response:1; }","duration":"131.972172ms","start":"2026-04-19T11:23:45.655673Z","end":"2026-04-19T11:23:45.787645Z","steps":["trace[519723153] 'process raft request' (duration: 44.51628ms)","trace[519723153] 'compare' (duration: 87.237005ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:23:45.824222Z","caller":"traceutil/trace.go:171","msg":"trace[167654384] transaction","detail":"{read_only:false; response_revision:9309; number_of_response:1; }","duration":"131.204519ms","start":"2026-04-19T11:23:45.693Z","end":"2026-04-19T11:23:45.824205Z","steps":["trace[167654384] 'process raft request' (duration: 130.88161ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:24:35.046159Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"92da22d3868c86fb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-19T11:24:35.059468Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-19T11:24:35.059578Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-19T11:26:55.598246Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8296} {"level":"info","ts":"2026-04-19T11:26:55.677083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8296,"took":"76.342053ms","hash":2931314435,"current-db-size-bytes":56549376,"current-db-size":"56 MB","current-db-size-in-use-bytes":25976832,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-19T11:26:55.677163Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2931314435,"revision":8296,"compact-revision":6079} {"level":"info","ts":"2026-04-19T11:31:55.604491Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10694} {"level":"info","ts":"2026-04-19T11:31:55.684007Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10694,"took":"76.685637ms","hash":3749082037,"current-db-size-bytes":56549376,"current-db-size":"56 MB","current-db-size-in-use-bytes":20684800,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-19T11:31:55.684082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3749082037,"revision":10694,"compact-revision":8296}