{"level":"warn","ts":"2026-04-23T00:16:31.167239Z","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-23T00:16:31.16733Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-23T00:16:31.167402Z","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-23T00:16:31.167412Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-23T00:16:31.167435Z","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-23T00:16:31.168286Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-04-23T00:16:31.168424Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-23T00:16:31.173422Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.739578ms"} {"level":"info","ts":"2026-04-23T00:16:31.181369Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-04-23T00:16:31.181435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T00:16:31.181459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-04-23T00:16:31.181498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T00:16:31.181513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-04-23T00:16:31.181566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-04-23T00:16:31.191298Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T00:16:31.193343Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T00:16:31.195599Z","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-23T00:16:31.198601Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T00:16:31.198899Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T00:16:31.199001Z","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-23T00:16:31.19908Z","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-23T00:16:31.199095Z","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-23T00:16:31.203067Z","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-23T00:16:31.20322Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-23T00:16:31.203258Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-23T00:16:31.203055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-04-23T00:16:31.203379Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-23T00:16:31.203457Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T00:16:31.203488Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T00:16:31.582342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T00:16:31.582395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T00:16:31.582414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-04-23T00:16:31.582426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-04-23T00:16:31.582431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-23T00:16:31.582439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-04-23T00:16:31.582446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-23T00:16:31.587846Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T00:16:31.587878Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T00:16:31.587845Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T00:16:31.588193Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T00:16:31.588994Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T00:16:31.589276Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T00:16:31.589568Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T00:16:31.589704Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T00:16:31.589745Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T00:16:31.592338Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-04-23T00:16:31.592443Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T00:16:56.16446Z","caller":"traceutil/trace.go:171","msg":"trace[259579258] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"326.42482ms","start":"2026-04-23T00:16:55.838011Z","end":"2026-04-23T00:16:56.164436Z","steps":["trace[259579258] 'process raft request' (duration: 326.293297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:16:56.165084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:16:55.837994Z","time spent":"326.561212ms","remote":"127.0.0.1:38780","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-04-23T00:16:57.096455Z","caller":"traceutil/trace.go:171","msg":"trace[1527452165] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"223.354264ms","start":"2026-04-23T00:16:56.87308Z","end":"2026-04-23T00:16:57.096435Z","steps":["trace[1527452165] 'process raft request' (duration: 223.102458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:16:57.550684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.071309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-23T00:16:57.550817Z","caller":"traceutil/trace.go:171","msg":"trace[1620481231] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:470; }","duration":"300.265203ms","start":"2026-04-23T00:16:57.250531Z","end":"2026-04-23T00:16:57.550796Z","steps":["trace[1620481231] 'range keys from in-memory index tree' (duration: 299.956887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:16:57.550864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:16:57.250517Z","time spent":"300.336244ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-23T00:16:57.864541Z","caller":"traceutil/trace.go:171","msg":"trace[85770409] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"270.929928ms","start":"2026-04-23T00:16:57.593589Z","end":"2026-04-23T00:16:57.864519Z","steps":["trace[85770409] 'read index received' (duration: 270.727654ms)","trace[85770409] 'applied index is now lower than readState.Index' (duration: 200.894µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:16:57.864759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.729603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:16:57.864842Z","caller":"traceutil/trace.go:171","msg":"trace[1149862467] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:471; }","duration":"228.875285ms","start":"2026-04-23T00:16:57.635952Z","end":"2026-04-23T00:16:57.864827Z","steps":["trace[1149862467] 'agreement among raft nodes before linearized reading' (duration: 228.725913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:16:57.86485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.236033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-04-23T00:16:57.864953Z","caller":"traceutil/trace.go:171","msg":"trace[758821714] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:471; }","duration":"271.382626ms","start":"2026-04-23T00:16:57.59354Z","end":"2026-04-23T00:16:57.864922Z","steps":["trace[758821714] 'agreement among raft nodes before linearized reading' (duration: 271.07031ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:16:57.865149Z","caller":"traceutil/trace.go:171","msg":"trace[1456778469] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"310.601976ms","start":"2026-04-23T00:16:57.553977Z","end":"2026-04-23T00:16:57.864579Z","steps":["trace[1456778469] 'process raft request' (duration: 310.409552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:16:57.865567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:16:57.55396Z","time spent":"311.544173ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:17:01.270645Z","caller":"traceutil/trace.go:171","msg":"trace[2510761] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"224.659987ms","start":"2026-04-23T00:17:01.04596Z","end":"2026-04-23T00:17:01.27062Z","steps":["trace[2510761] 'process raft request' (duration: 223.059118ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:01.276782Z","caller":"traceutil/trace.go:171","msg":"trace[231871000] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"227.582021ms","start":"2026-04-23T00:17:01.049177Z","end":"2026-04-23T00:17:01.276759Z","steps":["trace[231871000] 'process raft request' (duration: 227.366767ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:01.276792Z","caller":"traceutil/trace.go:171","msg":"trace[378517271] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"126.300798ms","start":"2026-04-23T00:17:01.150469Z","end":"2026-04-23T00:17:01.27677Z","steps":["trace[378517271] 'process raft request' (duration: 126.220677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:02.136824Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725786352046534,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T00:17:02.174618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.034065ms","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-04-23T00:17:02.174813Z","caller":"traceutil/trace.go:171","msg":"trace[1990696869] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:597; }","duration":"659.245648ms","start":"2026-04-23T00:17:01.515547Z","end":"2026-04-23T00:17:02.174792Z","steps":["trace[1990696869] 'range keys from in-memory index tree' (duration: 659.016264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:02.174673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.526782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-r65bk\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-04-23T00:17:02.175078Z","caller":"traceutil/trace.go:171","msg":"trace[1922227542] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-r65bk; range_end:; response_count:1; response_revision:597; }","duration":"675.945779ms","start":"2026-04-23T00:17:01.499091Z","end":"2026-04-23T00:17:02.175036Z","steps":["trace[1922227542] 'range keys from in-memory index tree' (duration: 675.391039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:02.175165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:01.499078Z","time spent":"676.056421ms","remote":"127.0.0.1:38696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4707,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-r65bk\" "} {"level":"info","ts":"2026-04-23T00:17:02.176684Z","caller":"traceutil/trace.go:171","msg":"trace[2036874533] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"640.5034ms","start":"2026-04-23T00:17:01.535598Z","end":"2026-04-23T00:17:02.176102Z","steps":["trace[2036874533] 'process raft request' (duration: 635.041268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:02.176866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:01.535578Z","time spent":"641.201242ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:17:02.182324Z","caller":"traceutil/trace.go:171","msg":"trace[1641166588] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"633.397656ms","start":"2026-04-23T00:17:01.548892Z","end":"2026-04-23T00:17:02.18229Z","steps":["trace[1641166588] 'process raft request' (duration: 630.114306ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:02.182775Z","caller":"traceutil/trace.go:171","msg":"trace[1207539899] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"596.100563ms","start":"2026-04-23T00:17:01.58665Z","end":"2026-04-23T00:17:02.182751Z","steps":["trace[1207539899] 'process raft request' (duration: 595.660565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:02.183812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:01.586619Z","time spent":"597.149913ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T00:17:02.182983Z","caller":"traceutil/trace.go:171","msg":"trace[435689741] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:619; }","duration":"546.583412ms","start":"2026-04-23T00:17:01.636357Z","end":"2026-04-23T00:17:02.182941Z","steps":["trace[435689741] 'read index received' (duration: 534.0591ms)","trace[435689741] 'applied index is now lower than readState.Index' (duration: 12.523172ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:17:02.183145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.781147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:02.184132Z","caller":"traceutil/trace.go:171","msg":"trace[908856288] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"547.806995ms","start":"2026-04-23T00:17:01.636306Z","end":"2026-04-23T00:17:02.184113Z","steps":["trace[908856288] 'agreement among raft nodes before linearized reading' (duration: 546.732396ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:02.183198Z","caller":"traceutil/trace.go:171","msg":"trace[1423193123] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"232.505293ms","start":"2026-04-23T00:17:01.950683Z","end":"2026-04-23T00:17:02.183188Z","steps":["trace[1423193123] 'process raft request' (duration: 232.188416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:02.184239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:01.636288Z","time spent":"547.940438ms","remote":"127.0.0.1:38560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-23T00:17:02.183293Z","caller":"traceutil/trace.go:171","msg":"trace[1840043201] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"433.99716ms","start":"2026-04-23T00:17:01.749285Z","end":"2026-04-23T00:17:02.183282Z","steps":["trace[1840043201] 'process raft request' (duration: 433.412049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:02.184003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:01.548815Z","time spent":"634.832224ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T00:17:02.184518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:01.749267Z","time spent":"435.134351ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T00:17:02.185628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.720399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-23T00:17:02.185669Z","caller":"traceutil/trace.go:171","msg":"trace[724834812] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"302.79598ms","start":"2026-04-23T00:17:01.882861Z","end":"2026-04-23T00:17:02.185657Z","steps":["trace[724834812] 'agreement among raft nodes before linearized reading' (duration: 301.506457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:02.185692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:01.882843Z","time spent":"302.84441ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T00:17:02.923088Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725786352046571,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-23T00:17:03.249617Z","caller":"traceutil/trace.go:171","msg":"trace[2012268000] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"839.478389ms","start":"2026-04-23T00:17:02.410116Z","end":"2026-04-23T00:17:03.249594Z","steps":["trace[2012268000] 'process raft request' (duration: 839.100022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:03.249749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:02.410101Z","time spent":"839.576561ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:17:03.255902Z","caller":"traceutil/trace.go:171","msg":"trace[310102073] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"833.082751ms","start":"2026-04-23T00:17:02.422791Z","end":"2026-04-23T00:17:03.255873Z","steps":["trace[310102073] 'read index received' (duration: 826.274344ms)","trace[310102073] 'applied index is now lower than readState.Index' (duration: 6.807027ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:17:03.256031Z","caller":"traceutil/trace.go:171","msg":"trace[468354167] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"502.201688ms","start":"2026-04-23T00:17:02.753819Z","end":"2026-04-23T00:17:03.25602Z","steps":["trace[468354167] 'process raft request' (duration: 501.896243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:03.256086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.673546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:03.256121Z","caller":"traceutil/trace.go:171","msg":"trace[574895436] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:618; }","duration":"708.708697ms","start":"2026-04-23T00:17:02.547401Z","end":"2026-04-23T00:17:03.25611Z","steps":["trace[574895436] 'agreement among raft nodes before linearized reading' (duration: 708.635536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:03.256143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:02.547354Z","time spent":"708.784079ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-04-23T00:17:03.256297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.505168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:98713"} {"level":"info","ts":"2026-04-23T00:17:03.256322Z","caller":"traceutil/trace.go:171","msg":"trace[626578588] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:618; }","duration":"833.553919ms","start":"2026-04-23T00:17:02.422762Z","end":"2026-04-23T00:17:03.256316Z","steps":["trace[626578588] 'agreement among raft nodes before linearized reading' (duration: 833.460267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:03.256317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:02.753799Z","time spent":"502.260939ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T00:17:03.256365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.060801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:03.256383Z","caller":"traceutil/trace.go:171","msg":"trace[1888773111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"619.114012ms","start":"2026-04-23T00:17:02.637265Z","end":"2026-04-23T00:17:03.256379Z","steps":["trace[1888773111] 'agreement among raft nodes before linearized reading' (duration: 619.085991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:03.256399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:02.637248Z","time spent":"619.146682ms","remote":"127.0.0.1:38560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T00:17:03.256339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:02.422749Z","time spent":"833.586109ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":98737,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-23T00:17:03.256439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.762257ms","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-23T00:17:03.256502Z","caller":"traceutil/trace.go:171","msg":"trace[1803553916] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:618; }","duration":"503.8768ms","start":"2026-04-23T00:17:02.75261Z","end":"2026-04-23T00:17:03.256486Z","steps":["trace[1803553916] 'agreement among raft nodes before linearized reading' (duration: 503.683926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:03.256535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:02.752591Z","time spent":"503.937101ms","remote":"127.0.0.1:38780","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-23T00:17:03.256642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.72767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"warn","ts":"2026-04-23T00:17:03.256632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.220401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-04-23T00:17:03.256686Z","caller":"traceutil/trace.go:171","msg":"trace[929187350] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:618; }","duration":"308.812361ms","start":"2026-04-23T00:17:02.947859Z","end":"2026-04-23T00:17:03.256671Z","steps":["trace[929187350] 'agreement among raft nodes before linearized reading' (duration: 308.692979ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:03.256701Z","caller":"traceutil/trace.go:171","msg":"trace[2119353831] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:618; }","duration":"109.336393ms","start":"2026-04-23T00:17:03.147345Z","end":"2026-04-23T00:17:03.256682Z","steps":["trace[2119353831] 'agreement among raft nodes before linearized reading' (duration: 109.13034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:03.256723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:02.947807Z","time spent":"308.906433ms","remote":"127.0.0.1:38588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5201,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"info","ts":"2026-04-23T00:17:06.779475Z","caller":"traceutil/trace.go:171","msg":"trace[700339352] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"142.5224ms","start":"2026-04-23T00:17:06.636927Z","end":"2026-04-23T00:17:06.779449Z","steps":["trace[700339352] 'read index received' (duration: 141.821467ms)","trace[700339352] 'applied index is now lower than readState.Index' (duration: 699.713µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:17:06.779648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.709674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:06.77969Z","caller":"traceutil/trace.go:171","msg":"trace[1187301225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:655; }","duration":"142.764365ms","start":"2026-04-23T00:17:06.636909Z","end":"2026-04-23T00:17:06.779673Z","steps":["trace[1187301225] 'agreement among raft nodes before linearized reading' (duration: 142.642132ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:06.780617Z","caller":"traceutil/trace.go:171","msg":"trace[2137356741] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"239.751208ms","start":"2026-04-23T00:17:06.540854Z","end":"2026-04-23T00:17:06.780605Z","steps":["trace[2137356741] 'process raft request' (duration: 238.108577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:08.702564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.800844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-23T00:17:08.702657Z","caller":"traceutil/trace.go:171","msg":"trace[16082103] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:668; }","duration":"484.914327ms","start":"2026-04-23T00:17:08.217714Z","end":"2026-04-23T00:17:08.702629Z","steps":["trace[16082103] 'range keys from in-memory index tree' (duration: 484.672522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:08.702693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:08.217708Z","time spent":"484.976838ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T00:17:08.702698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.088058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-23T00:17:08.702787Z","caller":"traceutil/trace.go:171","msg":"trace[1394762171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:668; }","duration":"486.21265ms","start":"2026-04-23T00:17:08.216553Z","end":"2026-04-23T00:17:08.702765Z","steps":["trace[1394762171] 'range keys from in-memory index tree' (duration: 485.994967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:08.702834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:08.216524Z","time spent":"486.300882ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-23T00:17:08.748408Z","caller":"traceutil/trace.go:171","msg":"trace[589723454] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"231.884593ms","start":"2026-04-23T00:17:08.516497Z","end":"2026-04-23T00:17:08.748382Z","steps":["trace[589723454] 'read index received' (duration: 230.977015ms)","trace[589723454] 'applied index is now lower than readState.Index' (duration: 906.408µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:17:08.748451Z","caller":"traceutil/trace.go:171","msg":"trace[1103715591] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"471.321224ms","start":"2026-04-23T00:17:08.277094Z","end":"2026-04-23T00:17:08.748416Z","steps":["trace[1103715591] 'process raft request' (duration: 470.477858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:08.748577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.066606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9mqvv\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-23T00:17:08.748633Z","caller":"traceutil/trace.go:171","msg":"trace[1739615908] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9mqvv; range_end:; response_count:1; response_revision:669; }","duration":"232.162997ms","start":"2026-04-23T00:17:08.516454Z","end":"2026-04-23T00:17:08.748617Z","steps":["trace[1739615908] 'agreement among raft nodes before linearized reading' (duration: 232.044535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:08.748615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:08.276997Z","time spent":"471.529578ms","remote":"127.0.0.1:38628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:17:08.764297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.428509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:08.764378Z","caller":"traceutil/trace.go:171","msg":"trace[555619556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:671; }","duration":"127.556781ms","start":"2026-04-23T00:17:08.636801Z","end":"2026-04-23T00:17:08.764357Z","steps":["trace[555619556] 'agreement among raft nodes before linearized reading' (duration: 127.424429ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:08.941227Z","caller":"traceutil/trace.go:171","msg":"trace[895576346] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"176.817428ms","start":"2026-04-23T00:17:08.764385Z","end":"2026-04-23T00:17:08.941203Z","steps":["trace[895576346] 'process raft request' (duration: 176.671985ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:08.966304Z","caller":"traceutil/trace.go:171","msg":"trace[836084957] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"153.706168ms","start":"2026-04-23T00:17:08.812571Z","end":"2026-04-23T00:17:08.966277Z","steps":["trace[836084957] 'process raft request' (duration: 153.579426ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:09.776121Z","caller":"traceutil/trace.go:171","msg":"trace[1313446842] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"408.698299ms","start":"2026-04-23T00:17:09.367402Z","end":"2026-04-23T00:17:09.776101Z","steps":["trace[1313446842] 'read index received' (duration: 408.670649ms)","trace[1313446842] 'applied index is now lower than readState.Index' (duration: 26.65µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:17:09.776219Z","caller":"traceutil/trace.go:171","msg":"trace[576625249] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"456.515518ms","start":"2026-04-23T00:17:09.319695Z","end":"2026-04-23T00:17:09.776211Z","steps":["trace[576625249] 'process raft request' (duration: 456.257644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:09.776319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:09.319676Z","time spent":"456.569399ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:17:09.776538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.146287ms","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-23T00:17:09.776575Z","caller":"traceutil/trace.go:171","msg":"trace[1015036111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:674; }","duration":"409.218299ms","start":"2026-04-23T00:17:09.367336Z","end":"2026-04-23T00:17:09.776554Z","steps":["trace[1015036111] 'agreement among raft nodes before linearized reading' (duration: 409.083736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:09.776596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:09.367306Z","time spent":"409.285929ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-23T00:17:10.03442Z","caller":"traceutil/trace.go:171","msg":"trace[1444951485] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"654.973318ms","start":"2026-04-23T00:17:09.379374Z","end":"2026-04-23T00:17:10.034347Z","steps":["trace[1444951485] 'process raft request' (duration: 654.199664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:10.03463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:09.379349Z","time spent":"655.160212ms","remote":"127.0.0.1:38628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:17:10.110288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.464123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:10.110363Z","caller":"traceutil/trace.go:171","msg":"trace[1108289442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:675; }","duration":"473.596896ms","start":"2026-04-23T00:17:09.636752Z","end":"2026-04-23T00:17:10.110349Z","steps":["trace[1108289442] 'agreement among raft nodes before linearized reading' (duration: 473.466233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:10.110417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:09.636732Z","time spent":"473.675287ms","remote":"127.0.0.1:38560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T00:17:10.110489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.317378ms","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-23T00:17:10.110558Z","caller":"traceutil/trace.go:171","msg":"trace[1854934961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:675; }","duration":"731.41739ms","start":"2026-04-23T00:17:09.379124Z","end":"2026-04-23T00:17:10.110541Z","steps":["trace[1854934961] 'agreement among raft nodes before linearized reading' (duration: 731.189575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:10.110629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:09.379112Z","time spent":"731.506732ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-23T00:17:10.110162Z","caller":"traceutil/trace.go:171","msg":"trace[391724902] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:697; }","duration":"333.956099ms","start":"2026-04-23T00:17:09.77618Z","end":"2026-04-23T00:17:10.110136Z","steps":["trace[391724902] 'read index received' (duration: 257.253442ms)","trace[391724902] 'applied index is now lower than readState.Index' (duration: 76.701067ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:17:10.612649Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471725786352046723,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-23T00:17:10.83312Z","caller":"traceutil/trace.go:171","msg":"trace[92635102] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"1.051483271s","start":"2026-04-23T00:17:09.781617Z","end":"2026-04-23T00:17:10.8331Z","steps":["trace[92635102] 'process raft request' (duration: 1.051318937s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:10.833433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:09.781596Z","time spent":"1.051759836s","remote":"127.0.0.1:38780","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-04-23T00:17:11.084347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.165734ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:17:11.084493Z","caller":"traceutil/trace.go:171","msg":"trace[1910318091] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:699; }","duration":"972.89933ms","start":"2026-04-23T00:17:10.111558Z","end":"2026-04-23T00:17:11.084457Z","steps":["trace[1910318091] 'read index received' (duration: 721.453086ms)","trace[1910318091] 'applied index is now lower than readState.Index' (duration: 251.445584ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:17:11.084565Z","caller":"traceutil/trace.go:171","msg":"trace[1631276155] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"990.13761ms","start":"2026-04-23T00:17:10.094421Z","end":"2026-04-23T00:17:11.084559Z","steps":["trace[1631276155] 'process raft request' (duration: 833.60474ms)","trace[1631276155] 'compare' (duration: 156.045951ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:17:11.084614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.094291Z","time spent":"990.290113ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T00:17:11.084691Z","caller":"traceutil/trace.go:171","msg":"trace[608451638] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"969.72781ms","start":"2026-04-23T00:17:10.114958Z","end":"2026-04-23T00:17:11.084686Z","steps":["trace[608451638] 'process raft request' (duration: 969.454556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.084742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.67544ms","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":"warn","ts":"2026-04-23T00:17:11.084759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.890947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.0848Z","caller":"traceutil/trace.go:171","msg":"trace[1288863999] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:678; }","duration":"504.979858ms","start":"2026-04-23T00:17:10.579811Z","end":"2026-04-23T00:17:11.084791Z","steps":["trace[1288863999] 'agreement among raft nodes before linearized reading' (duration: 504.919377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.084742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.161305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.084821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.579793Z","time spent":"505.0226ms","remote":"127.0.0.1:49484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-23T00:17:11.084876Z","caller":"traceutil/trace.go:171","msg":"trace[1692917958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:678; }","duration":"973.376088ms","start":"2026-04-23T00:17:10.111462Z","end":"2026-04-23T00:17:11.084839Z","steps":["trace[1692917958] 'agreement among raft nodes before linearized reading' (duration: 973.110823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.084873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.187194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.084958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.111434Z","time spent":"973.515691ms","remote":"127.0.0.1:38548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-23T00:17:11.084957Z","caller":"traceutil/trace.go:171","msg":"trace[2007968035] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:678; }","duration":"682.285976ms","start":"2026-04-23T00:17:10.40265Z","end":"2026-04-23T00:17:11.084936Z","steps":["trace[2007968035] 'agreement among raft nodes before linearized reading' (duration: 682.127983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.084955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.769775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.40262Z","time spent":"682.372919ms","remote":"127.0.0.1:49436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-23T00:17:11.085018Z","caller":"traceutil/trace.go:171","msg":"trace[1996111368] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:678; }","duration":"269.875468ms","start":"2026-04-23T00:17:10.815127Z","end":"2026-04-23T00:17:11.085003Z","steps":["trace[1996111368] 'agreement among raft nodes before linearized reading' (duration: 269.760185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.084944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.245445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.386076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.699937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.08521Z","caller":"traceutil/trace.go:171","msg":"trace[498832144] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:678; }","duration":"577.475827ms","start":"2026-04-23T00:17:10.507713Z","end":"2026-04-23T00:17:11.085189Z","steps":["trace[498832144] 'agreement among raft nodes before linearized reading' (duration: 577.351495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.507673Z","time spent":"577.57461ms","remote":"127.0.0.1:49466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.085255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.82414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.085243Z","caller":"traceutil/trace.go:171","msg":"trace[725729622] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:678; }","duration":"682.512651ms","start":"2026-04-23T00:17:10.40259Z","end":"2026-04-23T00:17:11.085103Z","steps":["trace[725729622] 'agreement among raft nodes before linearized reading' (duration: 682.232415ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.085316Z","caller":"traceutil/trace.go:171","msg":"trace[1776217919] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:678; }","duration":"303.889961ms","start":"2026-04-23T00:17:10.78142Z","end":"2026-04-23T00:17:11.08531Z","steps":["trace[1776217919] 'agreement among raft nodes before linearized reading' (duration: 303.820619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.008608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.0848Z","caller":"traceutil/trace.go:171","msg":"trace[936032078] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:678; }","duration":"926.762952ms","start":"2026-04-23T00:17:10.158021Z","end":"2026-04-23T00:17:11.084784Z","steps":["trace[936032078] 'agreement among raft nodes before linearized reading' (duration: 926.66396ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.085364Z","caller":"traceutil/trace.go:171","msg":"trace[480546870] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:678; }","duration":"578.052378ms","start":"2026-04-23T00:17:10.507301Z","end":"2026-04-23T00:17:11.085354Z","steps":["trace[480546870] 'agreement among raft nodes before linearized reading' (duration: 577.988907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.781417Z","time spent":"303.913041ms","remote":"127.0.0.1:49498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-23T00:17:11.085395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.507275Z","time spent":"578.112349ms","remote":"127.0.0.1:49466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-23T00:17:11.085402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.158007Z","time spent":"927.380344ms","remote":"127.0.0.1:49396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-04-23T00:17:11.085453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.658932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.085519Z","caller":"traceutil/trace.go:171","msg":"trace[990376368] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:678; }","duration":"505.736543ms","start":"2026-04-23T00:17:10.579773Z","end":"2026-04-23T00:17:11.085509Z","steps":["trace[990376368] 'agreement among raft nodes before linearized reading' (duration: 505.655142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.122145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.085553Z","caller":"traceutil/trace.go:171","msg":"trace[976576724] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:678; }","duration":"304.151055ms","start":"2026-04-23T00:17:10.781397Z","end":"2026-04-23T00:17:11.085548Z","steps":["trace[976576724] 'agreement among raft nodes before linearized reading' (duration: 304.105894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.579769Z","time spent":"505.777914ms","remote":"127.0.0.1:49484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-23T00:17:11.085577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.066845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.085615Z","caller":"traceutil/trace.go:171","msg":"trace[1654627949] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:678; }","duration":"616.105316ms","start":"2026-04-23T00:17:10.4695Z","end":"2026-04-23T00:17:11.085605Z","steps":["trace[1654627949] 'agreement among raft nodes before linearized reading' (duration: 616.051625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.494247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.469424Z","time spent":"616.216358ms","remote":"127.0.0.1:49460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-23T00:17:11.085662Z","caller":"traceutil/trace.go:171","msg":"trace[1053270684] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:678; }","duration":"172.550818ms","start":"2026-04-23T00:17:10.913099Z","end":"2026-04-23T00:17:11.08565Z","steps":["trace[1053270684] 'agreement among raft nodes before linearized reading' (duration: 172.490017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.921626ms","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:5"} {"level":"info","ts":"2026-04-23T00:17:11.085727Z","caller":"traceutil/trace.go:171","msg":"trace[980166892] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:678; }","duration":"505.962827ms","start":"2026-04-23T00:17:10.579756Z","end":"2026-04-23T00:17:11.085718Z","steps":["trace[980166892] 'agreement among raft nodes before linearized reading' (duration: 505.908126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.069067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-23T00:17:11.085761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.57973Z","time spent":"506.024109ms","remote":"127.0.0.1:49484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.085787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.35181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.700615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.420964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.085819Z","caller":"traceutil/trace.go:171","msg":"trace[2120681695] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:678; }","duration":"616.425642ms","start":"2026-04-23T00:17:10.469384Z","end":"2026-04-23T00:17:11.08581Z","steps":["trace[2120681695] 'agreement among raft nodes before linearized reading' (duration: 616.381321ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.08584Z","caller":"traceutil/trace.go:171","msg":"trace[503191176] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:678; }","duration":"173.468345ms","start":"2026-04-23T00:17:10.912363Z","end":"2026-04-23T00:17:11.085831Z","steps":["trace[503191176] 'agreement among raft nodes before linearized reading' (duration: 173.422084ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.085773Z","caller":"traceutil/trace.go:171","msg":"trace[1021311440] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:678; }","duration":"316.112018ms","start":"2026-04-23T00:17:10.769655Z","end":"2026-04-23T00:17:11.085767Z","steps":["trace[1021311440] 'agreement among raft nodes before linearized reading' (duration: 316.058757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.08589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.678969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.428048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.893428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.821636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.085888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.769642Z","time spent":"316.2411ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-23T00:17:11.085958Z","caller":"traceutil/trace.go:171","msg":"trace[423495278] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:678; }","duration":"654.939328ms","start":"2026-04-23T00:17:10.431011Z","end":"2026-04-23T00:17:11.085951Z","steps":["trace[423495278] 'agreement among raft nodes before linearized reading' (duration: 654.904517ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.085967Z","caller":"traceutil/trace.go:171","msg":"trace[501016889] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:678; }","duration":"654.910807ms","start":"2026-04-23T00:17:10.431046Z","end":"2026-04-23T00:17:11.085957Z","steps":["trace[501016889] 'agreement among raft nodes before linearized reading' (duration: 654.828876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.747564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.085978Z","caller":"traceutil/trace.go:171","msg":"trace[1429219273] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:678; }","duration":"711.50404ms","start":"2026-04-23T00:17:10.374435Z","end":"2026-04-23T00:17:11.085939Z","steps":["trace[1429219273] 'agreement among raft nodes before linearized reading' (duration: 711.427178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.430999Z","time spent":"654.979569ms","remote":"127.0.0.1:49444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-23T00:17:11.085999Z","caller":"traceutil/trace.go:171","msg":"trace[742849744] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:678; }","duration":"270.804005ms","start":"2026-04-23T00:17:10.815186Z","end":"2026-04-23T00:17:11.08599Z","steps":["trace[742849744] 'agreement among raft nodes before linearized reading' (duration: 270.759054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.086017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.374422Z","time spent":"711.583101ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.086038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.183688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.086042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.69367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.086039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.114937Z","time spent":"970.863181ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:17:11.085342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.402548Z","time spent":"682.779106ms","remote":"127.0.0.1:49436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-23T00:17:11.086113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.351761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.086138Z","caller":"traceutil/trace.go:171","msg":"trace[2049919655] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:678; }","duration":"558.399753ms","start":"2026-04-23T00:17:10.527732Z","end":"2026-04-23T00:17:11.086131Z","steps":["trace[2049919655] 'agreement among raft nodes before linearized reading' (duration: 558.359543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.086173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.527719Z","time spent":"558.446564ms","remote":"127.0.0.1:49478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-23T00:17:11.08618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.732671ms","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-23T00:17:11.085841Z","caller":"traceutil/trace.go:171","msg":"trace[758801323] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:678; }","duration":"711.095562ms","start":"2026-04-23T00:17:10.374732Z","end":"2026-04-23T00:17:11.085828Z","steps":["trace[758801323] 'agreement among raft nodes before linearized reading' (duration: 710.695095ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.085931Z","caller":"traceutil/trace.go:171","msg":"trace[1948684268] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:678; }","duration":"557.744611ms","start":"2026-04-23T00:17:10.528176Z","end":"2026-04-23T00:17:11.085921Z","steps":["trace[1948684268] 'agreement among raft nodes before linearized reading' (duration: 557.69084ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.086245Z","caller":"traceutil/trace.go:171","msg":"trace[1417781721] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:678; }","duration":"194.773662ms","start":"2026-04-23T00:17:10.891439Z","end":"2026-04-23T00:17:11.086213Z","steps":["trace[1417781721] 'agreement among raft nodes before linearized reading' (duration: 194.720361ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.08607Z","caller":"traceutil/trace.go:171","msg":"trace[304085263] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:678; }","duration":"558.246319ms","start":"2026-04-23T00:17:10.527816Z","end":"2026-04-23T00:17:11.086063Z","steps":["trace[304085263] 'agreement among raft nodes before linearized reading' (duration: 558.202138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.431013Z","time spent":"654.974859ms","remote":"127.0.0.1:49444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-23T00:17:11.0852Z","caller":"traceutil/trace.go:171","msg":"trace[778866583] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:678; }","duration":"303.761089ms","start":"2026-04-23T00:17:10.781431Z","end":"2026-04-23T00:17:11.085192Z","steps":["trace[778866583] 'agreement among raft nodes before linearized reading' (duration: 303.696747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.085848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.469357Z","time spent":"616.484302ms","remote":"127.0.0.1:49460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.086342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.854576ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.08635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.781429Z","time spent":"304.912439ms","remote":"127.0.0.1:49498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.086409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.527795Z","time spent":"558.606416ms","remote":"127.0.0.1:49478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.086277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.528166Z","time spent":"558.098527ms","remote":"127.0.0.1:49478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-23T00:17:11.086492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.439825ms","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-23T00:17:11.08646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.062151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.086121Z","caller":"traceutil/trace.go:171","msg":"trace[141374608] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:678; }","duration":"173.765601ms","start":"2026-04-23T00:17:10.912342Z","end":"2026-04-23T00:17:11.086108Z","steps":["trace[141374608] 'agreement among raft nodes before linearized reading' (duration: 173.681819ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.086532Z","caller":"traceutil/trace.go:171","msg":"trace[1711545690] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:678; }","duration":"712.151932ms","start":"2026-04-23T00:17:10.374363Z","end":"2026-04-23T00:17:11.086515Z","steps":["trace[1711545690] 'agreement among raft nodes before linearized reading' (duration: 712.060931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.086543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.57674ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.086549Z","caller":"traceutil/trace.go:171","msg":"trace[590563909] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:678; }","duration":"195.470375ms","start":"2026-04-23T00:17:10.891041Z","end":"2026-04-23T00:17:11.086512Z","steps":["trace[590563909] 'agreement among raft nodes before linearized reading' (duration: 195.395044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.086567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.374351Z","time spent":"712.205423ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-23T00:17:11.086274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.374724Z","time spent":"711.53079ms","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-23T00:17:11.085582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.781392Z","time spent":"304.172115ms","remote":"127.0.0.1:49498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-23T00:17:11.086743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.916006ms","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:5"} {"level":"warn","ts":"2026-04-23T00:17:11.08674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.586695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.086315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.16976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.086818Z","caller":"traceutil/trace.go:171","msg":"trace[1401195685] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:678; }","duration":"801.633086ms","start":"2026-04-23T00:17:10.285133Z","end":"2026-04-23T00:17:11.086766Z","steps":["trace[1401195685] 'agreement among raft nodes before linearized reading' (duration: 801.576725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.086834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.687518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.086753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.747479ms","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-23T00:17:11.085699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.275443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-23T00:17:11.086868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.789428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.086893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.112183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.086905Z","caller":"traceutil/trace.go:171","msg":"trace[1520063882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:678; }","duration":"308.507716ms","start":"2026-04-23T00:17:10.778384Z","end":"2026-04-23T00:17:11.086891Z","steps":["trace[1520063882] 'agreement among raft nodes before linearized reading' (duration: 307.217512ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.086476Z","caller":"traceutil/trace.go:171","msg":"trace[158328742] 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:678; }","duration":"327.887726ms","start":"2026-04-23T00:17:10.758468Z","end":"2026-04-23T00:17:11.086356Z","steps":["trace[158328742] 'agreement among raft nodes before linearized reading' (duration: 327.774174ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.086916Z","caller":"traceutil/trace.go:171","msg":"trace[2108095729] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:678; }","duration":"801.85289ms","start":"2026-04-23T00:17:10.285048Z","end":"2026-04-23T00:17:11.086901Z","steps":["trace[2108095729] 'agreement among raft nodes before linearized reading' (duration: 801.716198ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.086927Z","caller":"traceutil/trace.go:171","msg":"trace[1149540170] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:678; }","duration":"739.171144ms","start":"2026-04-23T00:17:10.347749Z","end":"2026-04-23T00:17:11.08692Z","steps":["trace[1149540170] 'agreement among raft nodes before linearized reading' (duration: 739.122104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.086947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.778374Z","time spent":"308.561557ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T00:17:11.086955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.758461Z","time spent":"328.481058ms","remote":"127.0.0.1:49496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-23T00:17:11.086966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.285036Z","time spent":"801.912761ms","remote":"127.0.0.1:49404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-23T00:17:11.086993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.534366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.086995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.471643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.087025Z","caller":"traceutil/trace.go:171","msg":"trace[2135090788] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:678; }","duration":"771.585296ms","start":"2026-04-23T00:17:10.315432Z","end":"2026-04-23T00:17:11.087017Z","steps":["trace[2135090788] 'agreement among raft nodes before linearized reading' (duration: 771.542365ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.087046Z","caller":"traceutil/trace.go:171","msg":"trace[1804854873] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:678; }","duration":"217.598046ms","start":"2026-04-23T00:17:10.869441Z","end":"2026-04-23T00:17:11.087039Z","steps":["trace[1804854873] 'agreement among raft nodes before linearized reading' (duration: 217.536434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.087096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.893921ms","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:5"} {"level":"info","ts":"2026-04-23T00:17:11.087132Z","caller":"traceutil/trace.go:171","msg":"trace[604747231] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:678; }","duration":"771.930562ms","start":"2026-04-23T00:17:10.315193Z","end":"2026-04-23T00:17:11.087124Z","steps":["trace[604747231] 'agreement among raft nodes before linearized reading' (duration: 771.881181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.087168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.315125Z","time spent":"772.035345ms","remote":"127.0.0.1:49412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-23T00:17:11.086834Z","caller":"traceutil/trace.go:171","msg":"trace[1358952102] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:678; }","duration":"578.719892ms","start":"2026-04-23T00:17:10.508101Z","end":"2026-04-23T00:17:11.086821Z","steps":["trace[1358952102] 'agreement among raft nodes before linearized reading' (duration: 578.189091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.087232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.125957ms","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-23T00:17:11.087239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.508081Z","time spent":"579.140739ms","remote":"127.0.0.1:49460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"info","ts":"2026-04-23T00:17:11.086896Z","caller":"traceutil/trace.go:171","msg":"trace[408606387] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:678; }","duration":"195.890963ms","start":"2026-04-23T00:17:10.890983Z","end":"2026-04-23T00:17:11.086874Z","steps":["trace[408606387] 'agreement among raft nodes before linearized reading' (duration: 195.74786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.087284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.058078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.087302Z","caller":"traceutil/trace.go:171","msg":"trace[562764838] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:678; }","duration":"656.088228ms","start":"2026-04-23T00:17:10.431209Z","end":"2026-04-23T00:17:11.087297Z","steps":["trace[562764838] 'agreement among raft nodes before linearized reading' (duration: 654.656742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.086735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.876679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.086961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.947634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.087321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.431202Z","time spent":"656.114139ms","remote":"127.0.0.1:49436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-04-23T00:17:11.087369Z","caller":"traceutil/trace.go:171","msg":"trace[664675554] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:678; }","duration":"739.555871ms","start":"2026-04-23T00:17:10.347801Z","end":"2026-04-23T00:17:11.087357Z","steps":["trace[664675554] 'agreement among raft nodes before linearized reading' (duration: 738.891429ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.087383Z","caller":"traceutil/trace.go:171","msg":"trace[151156888] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:678; }","duration":"217.406962ms","start":"2026-04-23T00:17:10.869964Z","end":"2026-04-23T00:17:11.087371Z","steps":["trace[151156888] 'agreement among raft nodes before linearized reading' (duration: 216.948954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.087406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.347778Z","time spent":"739.617112ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-23T00:17:11.08741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.949722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.087496Z","caller":"traceutil/trace.go:171","msg":"trace[1798368458] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:678; }","duration":"218.128715ms","start":"2026-04-23T00:17:10.869355Z","end":"2026-04-23T00:17:11.087484Z","steps":["trace[1798368458] 'agreement among raft nodes before linearized reading' (duration: 217.969003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.087531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.156133ms","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":"warn","ts":"2026-04-23T00:17:11.086956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.34773Z","time spent":"739.218985ms","remote":"127.0.0.1:49422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.087365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.358519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.086764Z","caller":"traceutil/trace.go:171","msg":"trace[1841540863] 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:678; }","duration":"328.963337ms","start":"2026-04-23T00:17:10.757795Z","end":"2026-04-23T00:17:11.086759Z","steps":["trace[1841540863] 'agreement among raft nodes before linearized reading' (duration: 328.929396ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.087618Z","caller":"traceutil/trace.go:171","msg":"trace[240182928] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:678; }","duration":"801.620305ms","start":"2026-04-23T00:17:10.285989Z","end":"2026-04-23T00:17:11.087609Z","steps":["trace[240182928] 'agreement among raft nodes before linearized reading' (duration: 801.35885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.087633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.757779Z","time spent":"329.838273ms","remote":"127.0.0.1:49496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.087635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.206194ms","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-23T00:17:11.087651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.285983Z","time spent":"801.658285ms","remote":"127.0.0.1:49404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-23T00:17:11.087185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.318761ms","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-23T00:17:11.087675Z","caller":"traceutil/trace.go:171","msg":"trace[667264020] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:678; }","duration":"455.260175ms","start":"2026-04-23T00:17:10.632401Z","end":"2026-04-23T00:17:11.087661Z","steps":["trace[667264020] 'agreement among raft nodes before linearized reading' (duration: 455.209294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.08771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.632393Z","time spent":"455.309595ms","remote":"127.0.0.1:49486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.086851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.285129Z","time spent":"801.713647ms","remote":"127.0.0.1:49404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-04-23T00:17:11.087261Z","caller":"traceutil/trace.go:171","msg":"trace[1425221136] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:678; }","duration":"929.157297ms","start":"2026-04-23T00:17:10.158097Z","end":"2026-04-23T00:17:11.087254Z","steps":["trace[1425221136] 'agreement among raft nodes before linearized reading' (duration: 929.115737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.08777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.158054Z","time spent":"929.709616ms","remote":"127.0.0.1:49396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:17:11.087697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.927921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T00:17:11.086005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.417908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.0878Z","caller":"traceutil/trace.go:171","msg":"trace[1670885355] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:678; }","duration":"354.089444ms","start":"2026-04-23T00:17:10.733703Z","end":"2026-04-23T00:17:11.087793Z","steps":["trace[1670885355] 'agreement among raft nodes before linearized reading' (duration: 353.766517ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.087915Z","caller":"traceutil/trace.go:171","msg":"trace[1665160873] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:678; }","duration":"272.343054ms","start":"2026-04-23T00:17:10.81552Z","end":"2026-04-23T00:17:11.087863Z","steps":["trace[1665160873] 'agreement among raft nodes before linearized reading' (duration: 270.416928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.087933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.733689Z","time spent":"354.235686ms","remote":"127.0.0.1:49494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-23T00:17:11.087721Z","caller":"traceutil/trace.go:171","msg":"trace[698765916] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:678; }","duration":"928.86012ms","start":"2026-04-23T00:17:10.158836Z","end":"2026-04-23T00:17:11.087696Z","steps":["trace[698765916] 'agreement among raft nodes before linearized reading' (duration: 928.315591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.08787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.142363ms","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-23T00:17:11.087967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.158832Z","time spent":"929.126296ms","remote":"127.0.0.1:49396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-04-23T00:17:11.087438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.428712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.086559Z","caller":"traceutil/trace.go:171","msg":"trace[315825767] 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:678; }","duration":"328.59414ms","start":"2026-04-23T00:17:10.75796Z","end":"2026-04-23T00:17:11.086554Z","steps":["trace[315825767] 'agreement among raft nodes before linearized reading' (duration: 328.537849ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:11.088002Z","caller":"traceutil/trace.go:171","msg":"trace[74797462] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:678; }","duration":"455.276726ms","start":"2026-04-23T00:17:10.632718Z","end":"2026-04-23T00:17:11.087995Z","steps":["trace[74797462] 'agreement among raft nodes before linearized reading' (duration: 454.849397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.087055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.315424Z","time spent":"771.622797ms","remote":"127.0.0.1:49412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-23T00:17:11.088227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.757945Z","time spent":"330.267932ms","remote":"127.0.0.1:49496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-23T00:17:11.088284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.632663Z","time spent":"455.557301ms","remote":"127.0.0.1:49486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-23T00:17:11.086852Z","caller":"traceutil/trace.go:171","msg":"trace[476856166] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:678; }","duration":"352.723158ms","start":"2026-04-23T00:17:10.734124Z","end":"2026-04-23T00:17:11.086848Z","steps":["trace[476856166] 'agreement among raft nodes before linearized reading' (duration: 352.695128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.088482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.734117Z","time spent":"354.326629ms","remote":"127.0.0.1:49494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-23T00:17:11.087329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.219748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:17:11.088139Z","caller":"traceutil/trace.go:171","msg":"trace[1530805171] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:678; }","duration":"354.383459ms","start":"2026-04-23T00:17:10.733739Z","end":"2026-04-23T00:17:11.088122Z","steps":["trace[1530805171] 'agreement among raft nodes before linearized reading' (duration: 353.121985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.088652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.733716Z","time spent":"354.920759ms","remote":"127.0.0.1:49494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-23T00:17:11.087555Z","caller":"traceutil/trace.go:171","msg":"trace[1292319643] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:678; }","duration":"455.215244ms","start":"2026-04-23T00:17:10.632332Z","end":"2026-04-23T00:17:11.087548Z","steps":["trace[1292319643] 'agreement among raft nodes before linearized reading' (duration: 455.177953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.088851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.632225Z","time spent":"456.60717ms","remote":"127.0.0.1:49486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-23T00:17:11.088771Z","caller":"traceutil/trace.go:171","msg":"trace[1836296598] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:678; }","duration":"773.694575ms","start":"2026-04-23T00:17:10.315066Z","end":"2026-04-23T00:17:11.08876Z","steps":["trace[1836296598] 'agreement among raft nodes before linearized reading' (duration: 772.238718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:11.089272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:10.315046Z","time spent":"774.149194ms","remote":"127.0.0.1:49412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-23T00:17:24.217081Z","caller":"traceutil/trace.go:171","msg":"trace[1045955625] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"315.682931ms","start":"2026-04-23T00:17:23.901373Z","end":"2026-04-23T00:17:24.217056Z","steps":["trace[1045955625] 'process raft request' (duration: 315.500377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:24.217244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:23.901356Z","time spent":"315.796292ms","remote":"127.0.0.1:38780","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-23T00:17:27.33472Z","caller":"traceutil/trace.go:171","msg":"trace[479647523] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"164.841204ms","start":"2026-04-23T00:17:27.169842Z","end":"2026-04-23T00:17:27.334683Z","steps":["trace[479647523] 'read index received' (duration: 164.556839ms)","trace[479647523] 'applied index is now lower than readState.Index' (duration: 282.545µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:17:27.334798Z","caller":"traceutil/trace.go:171","msg":"trace[1978277125] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"346.305129ms","start":"2026-04-23T00:17:26.988454Z","end":"2026-04-23T00:17:27.334759Z","steps":["trace[1978277125] 'process raft request' (duration: 345.971803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:27.334967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:17:26.988432Z","time spent":"346.445041ms","remote":"127.0.0.1:38780","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-04-23T00:17:27.335036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.193541ms","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-23T00:17:27.335123Z","caller":"traceutil/trace.go:171","msg":"trace[407093713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"165.325634ms","start":"2026-04-23T00:17:27.169785Z","end":"2026-04-23T00:17:27.33511Z","steps":["trace[407093713] 'agreement among raft nodes before linearized reading' (duration: 165.074019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:27.335178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.166682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-23T00:17:27.335173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.518907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-23T00:17:27.335244Z","caller":"traceutil/trace.go:171","msg":"trace[1158037011] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"129.291574ms","start":"2026-04-23T00:17:27.205933Z","end":"2026-04-23T00:17:27.335225Z","steps":["trace[1158037011] 'agreement among raft nodes before linearized reading' (duration: 129.007729ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:27.335251Z","caller":"traceutil/trace.go:171","msg":"trace[1637908362] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:792; }","duration":"102.652539ms","start":"2026-04-23T00:17:27.23258Z","end":"2026-04-23T00:17:27.335233Z","steps":["trace[1637908362] 'agreement among raft nodes before linearized reading' (duration: 102.391355ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:27.515473Z","caller":"traceutil/trace.go:171","msg":"trace[2116920694] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"175.571874ms","start":"2026-04-23T00:17:27.33986Z","end":"2026-04-23T00:17:27.515432Z","steps":["trace[2116920694] 'process raft request' (duration: 172.567769ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:27.51762Z","caller":"traceutil/trace.go:171","msg":"trace[1086947477] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"177.688884ms","start":"2026-04-23T00:17:27.3399Z","end":"2026-04-23T00:17:27.517588Z","steps":["trace[1086947477] 'process raft request' (duration: 177.4612ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:27.517748Z","caller":"traceutil/trace.go:171","msg":"trace[639924698] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"177.811757ms","start":"2026-04-23T00:17:27.339922Z","end":"2026-04-23T00:17:27.517734Z","steps":["trace[639924698] 'process raft request' (duration: 177.623583ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:34.288422Z","caller":"traceutil/trace.go:171","msg":"trace[455632032] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"207.852217ms","start":"2026-04-23T00:17:34.080532Z","end":"2026-04-23T00:17:34.288384Z","steps":["trace[455632032] 'process raft request' (duration: 207.572902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:34.554013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.013281ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:17:34.554128Z","caller":"traceutil/trace.go:171","msg":"trace[1496682807] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"259.241695ms","start":"2026-04-23T00:17:34.294867Z","end":"2026-04-23T00:17:34.554109Z","steps":["trace[1496682807] 'process raft request' (duration: 38.06184ms)","trace[1496682807] 'compare' (duration: 220.808137ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:17:34.556679Z","caller":"traceutil/trace.go:171","msg":"trace[97308873] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"260.009117ms","start":"2026-04-23T00:17:34.296648Z","end":"2026-04-23T00:17:34.556657Z","steps":["trace[97308873] 'process raft request' (duration: 259.947866ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:34.556706Z","caller":"traceutil/trace.go:171","msg":"trace[165225937] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"261.446915ms","start":"2026-04-23T00:17:34.295222Z","end":"2026-04-23T00:17:34.556669Z","steps":["trace[165225937] 'process raft request' (duration: 261.17775ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:17:34.556735Z","caller":"traceutil/trace.go:171","msg":"trace[1151093141] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"260.395306ms","start":"2026-04-23T00:17:34.296306Z","end":"2026-04-23T00:17:34.556701Z","steps":["trace[1151093141] 'process raft request' (duration: 260.228963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:17:49.923759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.382269ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-23T00:17:49.923983Z","caller":"traceutil/trace.go:171","msg":"trace[320941726] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"113.343654ms","start":"2026-04-23T00:17:49.810623Z","end":"2026-04-23T00:17:49.923967Z","steps":["trace[320941726] 'process raft request' (duration: 113.222982ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:01.774463Z","caller":"traceutil/trace.go:171","msg":"trace[328412527] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1043; }","duration":"138.461352ms","start":"2026-04-23T00:18:01.635978Z","end":"2026-04-23T00:18:01.77444Z","steps":["trace[328412527] 'read index received' (duration: 138.236158ms)","trace[328412527] 'applied index is now lower than readState.Index' (duration: 224.064µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:18:01.774546Z","caller":"traceutil/trace.go:171","msg":"trace[968416426] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"223.025649ms","start":"2026-04-23T00:18:01.551494Z","end":"2026-04-23T00:18:01.774519Z","steps":["trace[968416426] 'process raft request' (duration: 222.801205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:01.774636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.643775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:18:01.774694Z","caller":"traceutil/trace.go:171","msg":"trace[1750228329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"138.741657ms","start":"2026-04-23T00:18:01.635939Z","end":"2026-04-23T00:18:01.774681Z","steps":["trace[1750228329] 'agreement among raft nodes before linearized reading' (duration: 138.594414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:02.299324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.241712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-23T00:18:02.299381Z","caller":"traceutil/trace.go:171","msg":"trace[1505954818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1010; }","duration":"328.337843ms","start":"2026-04-23T00:18:01.971031Z","end":"2026-04-23T00:18:02.299368Z","steps":["trace[1505954818] 'range keys from in-memory index tree' (duration: 328.099509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:02.299411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:01.971017Z","time spent":"328.385564ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T00:18:02.299638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.225002ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:18:02.299918Z","caller":"traceutil/trace.go:171","msg":"trace[511669601] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"323.9453ms","start":"2026-04-23T00:18:01.975953Z","end":"2026-04-23T00:18:02.299898Z","steps":["trace[511669601] 'process raft request' (duration: 33.374082ms)","trace[511669601] 'compare' (duration: 289.911357ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:02.299993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:01.975939Z","time spent":"324.020731ms","remote":"127.0.0.1:38780","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-23T00:18:02.836227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.476188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:18:02.836312Z","caller":"traceutil/trace.go:171","msg":"trace[197917359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"200.58836ms","start":"2026-04-23T00:18:02.635692Z","end":"2026-04-23T00:18:02.83628Z","steps":["trace[197917359] 'range keys from in-memory index tree' (duration: 200.399076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:02.836537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.795341ms","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-23T00:18:02.836578Z","caller":"traceutil/trace.go:171","msg":"trace[597182087] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1012; }","duration":"128.866013ms","start":"2026-04-23T00:18:02.707701Z","end":"2026-04-23T00:18:02.836567Z","steps":["trace[597182087] 'range keys from in-memory index tree' (duration: 128.659339ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:03.629728Z","caller":"traceutil/trace.go:171","msg":"trace[1134822283] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"788.552194ms","start":"2026-04-23T00:18:02.84115Z","end":"2026-04-23T00:18:03.629702Z","steps":["trace[1134822283] 'process raft request' (duration: 788.36577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:03.629917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:02.841123Z","time spent":"788.681577ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:18:07.139269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.295762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T00:18:07.139336Z","caller":"traceutil/trace.go:171","msg":"trace[1727014169] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1026; }","duration":"246.406505ms","start":"2026-04-23T00:18:06.892915Z","end":"2026-04-23T00:18:07.139322Z","steps":["trace[1727014169] 'count revisions from in-memory index tree' (duration: 246.228101ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:19.985609Z","caller":"traceutil/trace.go:171","msg":"trace[834456275] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1106; }","duration":"111.811375ms","start":"2026-04-23T00:18:19.873771Z","end":"2026-04-23T00:18:19.985582Z","steps":["trace[834456275] 'read index received' (duration: 37.301815ms)","trace[834456275] 'applied index is now lower than readState.Index' (duration: 74.50806ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:19.985888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.07946ms","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-23T00:18:19.985964Z","caller":"traceutil/trace.go:171","msg":"trace[977812099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1067; }","duration":"112.211282ms","start":"2026-04-23T00:18:19.873734Z","end":"2026-04-23T00:18:19.985946Z","steps":["trace[977812099] 'agreement among raft nodes before linearized reading' (duration: 111.966408ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:20.57258Z","caller":"traceutil/trace.go:171","msg":"trace[1315863638] linearizableReadLoop","detail":"{readStateIndex:1111; appliedIndex:1110; }","duration":"153.538174ms","start":"2026-04-23T00:18:20.419019Z","end":"2026-04-23T00:18:20.572557Z","steps":["trace[1315863638] 'read index received' (duration: 153.379331ms)","trace[1315863638] 'applied index is now lower than readState.Index' (duration: 157.863µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:20.572817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.788898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-23T00:18:20.572857Z","caller":"traceutil/trace.go:171","msg":"trace[340778920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1071; }","duration":"153.87829ms","start":"2026-04-23T00:18:20.418968Z","end":"2026-04-23T00:18:20.572846Z","steps":["trace[340778920] 'agreement among raft nodes before linearized reading' (duration: 153.702917ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:20.572976Z","caller":"traceutil/trace.go:171","msg":"trace[633195570] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"183.259398ms","start":"2026-04-23T00:18:20.389684Z","end":"2026-04-23T00:18:20.572943Z","steps":["trace[633195570] 'process raft request' (duration: 182.735648ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:22.237461Z","caller":"traceutil/trace.go:171","msg":"trace[1861509774] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1113; }","duration":"232.868922ms","start":"2026-04-23T00:18:22.004565Z","end":"2026-04-23T00:18:22.237434Z","steps":["trace[1861509774] 'read index received' (duration: 75.399585ms)","trace[1861509774] 'applied index is now lower than readState.Index' (duration: 157.468397ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:22.237745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.152527ms","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-04-23T00:18:22.237748Z","caller":"traceutil/trace.go:171","msg":"trace[257357203] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"234.123326ms","start":"2026-04-23T00:18:22.003592Z","end":"2026-04-23T00:18:22.237715Z","steps":["trace[257357203] 'process raft request' (duration: 155.680433ms)","trace[257357203] 'compare' (duration: 78.013865ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:18:22.237789Z","caller":"traceutil/trace.go:171","msg":"trace[820334560] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1075; }","duration":"233.214108ms","start":"2026-04-23T00:18:22.004559Z","end":"2026-04-23T00:18:22.237774Z","steps":["trace[820334560] 'agreement among raft nodes before linearized reading' (duration: 233.048655ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:22.74829Z","caller":"traceutil/trace.go:171","msg":"trace[611061521] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"169.503701ms","start":"2026-04-23T00:18:22.578758Z","end":"2026-04-23T00:18:22.748262Z","steps":["trace[611061521] 'process raft request' (duration: 169.323067ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:26.128159Z","caller":"traceutil/trace.go:171","msg":"trace[1555077704] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"331.873408ms","start":"2026-04-23T00:18:25.79625Z","end":"2026-04-23T00:18:26.128123Z","steps":["trace[1555077704] 'process raft request' (duration: 331.672175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:26.128222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.758744ms","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-23T00:18:26.12829Z","caller":"traceutil/trace.go:171","msg":"trace[1146883911] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1086; }","duration":"319.861875ms","start":"2026-04-23T00:18:25.808414Z","end":"2026-04-23T00:18:26.128276Z","steps":["trace[1146883911] 'agreement among raft nodes before linearized reading' (duration: 319.750533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:26.128332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:25.808404Z","time spent":"319.917106ms","remote":"127.0.0.1:54168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:18:26.128339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:25.796223Z","time spent":"332.020492ms","remote":"127.0.0.1:38780","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-23T00:18:26.128096Z","caller":"traceutil/trace.go:171","msg":"trace[403288453] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"319.623801ms","start":"2026-04-23T00:18:25.808446Z","end":"2026-04-23T00:18:26.12807Z","steps":["trace[403288453] 'read index received' (duration: 319.490758ms)","trace[403288453] 'applied index is now lower than readState.Index' (duration: 132.022µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:26.668123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.509724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:18:26.668237Z","caller":"traceutil/trace.go:171","msg":"trace[1141740033] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1127; }","duration":"539.441599ms","start":"2026-04-23T00:18:26.128774Z","end":"2026-04-23T00:18:26.668215Z","steps":["trace[1141740033] 'read index received' (duration: 246.625889ms)","trace[1141740033] 'applied index is now lower than readState.Index' (duration: 292.814ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:18:26.668332Z","caller":"traceutil/trace.go:171","msg":"trace[4593678] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"808.817092ms","start":"2026-04-23T00:18:25.859503Z","end":"2026-04-23T00:18:26.66832Z","steps":["trace[4593678] 'process raft request' (duration: 516.007202ms)","trace[4593678] 'compare' (duration: 292.401392ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:26.668396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:25.859486Z","time spent":"808.878143ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:18:26.668496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.116466ms","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":"info","ts":"2026-04-23T00:18:26.668573Z","caller":"traceutil/trace.go:171","msg":"trace[1767835240] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1087; }","duration":"840.235858ms","start":"2026-04-23T00:18:25.828319Z","end":"2026-04-23T00:18:26.668555Z","steps":["trace[1767835240] 'agreement among raft nodes before linearized reading' (duration: 840.087255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:26.668649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:25.82826Z","time spent":"840.374741ms","remote":"127.0.0.1:49486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-23T00:18:26.668686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.272323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-23T00:18:26.668721Z","caller":"traceutil/trace.go:171","msg":"trace[614347422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1087; }","duration":"416.354394ms","start":"2026-04-23T00:18:26.252357Z","end":"2026-04-23T00:18:26.668711Z","steps":["trace[614347422] 'agreement among raft nodes before linearized reading' (duration: 416.232991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:26.668755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:26.252334Z","time spent":"416.414275ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-23T00:18:26.66901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.652464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-23T00:18:26.669048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.922591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T00:18:26.669078Z","caller":"traceutil/trace.go:171","msg":"trace[1643303566] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1087; }","duration":"278.988362ms","start":"2026-04-23T00:18:26.390081Z","end":"2026-04-23T00:18:26.669069Z","steps":["trace[1643303566] 'agreement among raft nodes before linearized reading' (duration: 278.939591ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:26.669056Z","caller":"traceutil/trace.go:171","msg":"trace[268459363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1087; }","duration":"575.726356ms","start":"2026-04-23T00:18:26.093316Z","end":"2026-04-23T00:18:26.669042Z","steps":["trace[268459363] 'agreement among raft nodes before linearized reading' (duration: 575.598693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:26.669123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:26.093293Z","time spent":"575.820497ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-23T00:18:26.669186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.108931ms","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-04-23T00:18:26.669238Z","caller":"traceutil/trace.go:171","msg":"trace[157011062] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1087; }","duration":"363.204552ms","start":"2026-04-23T00:18:26.306017Z","end":"2026-04-23T00:18:26.669222Z","steps":["trace[157011062] 'agreement among raft nodes before linearized reading' (duration: 363.066179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:26.6693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:26.306Z","time spent":"363.272844ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-23T00:18:26.840842Z","caller":"traceutil/trace.go:171","msg":"trace[1901464258] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"167.158388ms","start":"2026-04-23T00:18:26.673655Z","end":"2026-04-23T00:18:26.840814Z","steps":["trace[1901464258] 'process raft request' (duration: 166.857492ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:26.840878Z","caller":"traceutil/trace.go:171","msg":"trace[1550704286] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"166.893474ms","start":"2026-04-23T00:18:26.673951Z","end":"2026-04-23T00:18:26.840845Z","steps":["trace[1550704286] 'process raft request' (duration: 166.747991ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:26.840784Z","caller":"traceutil/trace.go:171","msg":"trace[308905244] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1128; }","duration":"115.736948ms","start":"2026-04-23T00:18:26.725026Z","end":"2026-04-23T00:18:26.840763Z","steps":["trace[308905244] 'read index received' (duration: 26.84357ms)","trace[308905244] 'applied index is now lower than readState.Index' (duration: 88.892338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:26.841048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.005324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:18:26.841239Z","caller":"traceutil/trace.go:171","msg":"trace[546419564] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1090; }","duration":"116.167147ms","start":"2026-04-23T00:18:26.725006Z","end":"2026-04-23T00:18:26.841173Z","steps":["trace[546419564] 'agreement among raft nodes before linearized reading' (duration: 115.940183ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:28.469165Z","caller":"traceutil/trace.go:171","msg":"trace[1903901432] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"332.849697ms","start":"2026-04-23T00:18:28.136287Z","end":"2026-04-23T00:18:28.469137Z","steps":["trace[1903901432] 'process raft request' (duration: 332.649804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:28.469325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:28.136266Z","time spent":"332.972339ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:18:28.986727Z","caller":"traceutil/trace.go:171","msg":"trace[1615828714] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"101.734626ms","start":"2026-04-23T00:18:28.884972Z","end":"2026-04-23T00:18:28.986707Z","steps":["trace[1615828714] 'read index received' (duration: 68.14304ms)","trace[1615828714] 'applied index is now lower than readState.Index' (duration: 33.590646ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:18:28.987059Z","caller":"traceutil/trace.go:171","msg":"trace[1655056649] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"121.817421ms","start":"2026-04-23T00:18:28.865169Z","end":"2026-04-23T00:18:28.986987Z","steps":["trace[1655056649] 'process raft request' (duration: 87.949159ms)","trace[1655056649] 'compare' (duration: 33.360272ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:28.987091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.064753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-23T00:18:28.987308Z","caller":"traceutil/trace.go:171","msg":"trace[2068379086] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1097; }","duration":"102.309018ms","start":"2026-04-23T00:18:28.884967Z","end":"2026-04-23T00:18:28.987276Z","steps":["trace[2068379086] 'agreement among raft nodes before linearized reading' (duration: 101.814078ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:31.004254Z","caller":"traceutil/trace.go:171","msg":"trace[1207261720] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1141; }","duration":"404.959161ms","start":"2026-04-23T00:18:30.599273Z","end":"2026-04-23T00:18:31.004232Z","steps":["trace[1207261720] 'read index received' (duration: 404.752077ms)","trace[1207261720] 'applied index is now lower than readState.Index' (duration: 205.984µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:31.004389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.110083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:18:31.00442Z","caller":"traceutil/trace.go:171","msg":"trace[1929508555] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1100; }","duration":"405.192795ms","start":"2026-04-23T00:18:30.599217Z","end":"2026-04-23T00:18:31.00441Z","steps":["trace[1929508555] 'agreement among raft nodes before linearized reading' (duration: 405.128104ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:31.004373Z","caller":"traceutil/trace.go:171","msg":"trace[1671126348] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"524.260756ms","start":"2026-04-23T00:18:30.480083Z","end":"2026-04-23T00:18:31.004344Z","steps":["trace[1671126348] 'process raft request' (duration: 524.007431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:31.004457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:30.599199Z","time spent":"405.251696ms","remote":"127.0.0.1:38560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T00:18:31.004565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:30.48006Z","time spent":"524.407088ms","remote":"127.0.0.1:38780","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-23T00:18:31.14083Z","caller":"traceutil/trace.go:171","msg":"trace[567683516] linearizableReadLoop","detail":"{readStateIndex:1143; appliedIndex:1142; }","duration":"136.490396ms","start":"2026-04-23T00:18:31.004319Z","end":"2026-04-23T00:18:31.140809Z","steps":["trace[567683516] 'read index received' (duration: 41.707298ms)","trace[567683516] 'applied index is now lower than readState.Index' (duration: 94.781968ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:18:31.140951Z","caller":"traceutil/trace.go:171","msg":"trace[1675570425] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"273.945828ms","start":"2026-04-23T00:18:30.866992Z","end":"2026-04-23T00:18:31.140938Z","steps":["trace[1675570425] 'process raft request' (duration: 179.11106ms)","trace[1675570425] 'compare' (duration: 94.596984ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:31.141095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.703264ms","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-23T00:18:31.141143Z","caller":"traceutil/trace.go:171","msg":"trace[924480929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1101; }","duration":"280.801857ms","start":"2026-04-23T00:18:30.860329Z","end":"2026-04-23T00:18:31.141131Z","steps":["trace[924480929] 'agreement among raft nodes before linearized reading' (duration: 280.649734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:31.141189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.376985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-23T00:18:31.14126Z","caller":"traceutil/trace.go:171","msg":"trace[1843659765] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1101; }","duration":"135.494817ms","start":"2026-04-23T00:18:31.005749Z","end":"2026-04-23T00:18:31.141243Z","steps":["trace[1843659765] 'agreement among raft nodes before linearized reading' (duration: 135.298133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:31.141276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.211744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-23T00:18:31.141247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.785012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:18:31.141306Z","caller":"traceutil/trace.go:171","msg":"trace[1144414221] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1101; }","duration":"266.268105ms","start":"2026-04-23T00:18:30.875027Z","end":"2026-04-23T00:18:31.141295Z","steps":["trace[1144414221] 'agreement among raft nodes before linearized reading' (duration: 266.193333ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:31.141332Z","caller":"traceutil/trace.go:171","msg":"trace[1449615254] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1101; }","duration":"238.927605ms","start":"2026-04-23T00:18:30.90238Z","end":"2026-04-23T00:18:31.141307Z","steps":["trace[1449615254] 'agreement among raft nodes before linearized reading' (duration: 238.751132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:31.141379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.996337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-23T00:18:31.14144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.421781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:18:31.141511Z","caller":"traceutil/trace.go:171","msg":"trace[523812410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1101; }","duration":"500.530123ms","start":"2026-04-23T00:18:30.640972Z","end":"2026-04-23T00:18:31.141502Z","steps":["trace[523812410] 'agreement among raft nodes before linearized reading' (duration: 500.446681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:31.141538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:18:30.640952Z","time spent":"500.579684ms","remote":"127.0.0.1:38548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-23T00:18:31.141445Z","caller":"traceutil/trace.go:171","msg":"trace[718325197] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1101; }","duration":"150.115859ms","start":"2026-04-23T00:18:30.991317Z","end":"2026-04-23T00:18:31.141433Z","steps":["trace[718325197] 'agreement among raft nodes before linearized reading' (duration: 149.919796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:33.31106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.59397ms","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-04-23T00:18:33.311136Z","caller":"traceutil/trace.go:171","msg":"trace[694882418] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1107; }","duration":"126.722011ms","start":"2026-04-23T00:18:33.184396Z","end":"2026-04-23T00:18:33.311118Z","steps":["trace[694882418] 'range keys from in-memory index tree' (duration: 126.417006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:18:39.809743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.312377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:18:39.809992Z","caller":"traceutil/trace.go:171","msg":"trace[594252246] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1172; }","duration":"172.230146ms","start":"2026-04-23T00:18:39.637745Z","end":"2026-04-23T00:18:39.809975Z","steps":["trace[594252246] 'read index received' (duration: 16.616384ms)","trace[594252246] 'applied index is now lower than readState.Index' (duration: 155.612792ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:18:39.809996Z","caller":"traceutil/trace.go:171","msg":"trace[1356090501] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"273.008996ms","start":"2026-04-23T00:18:39.536953Z","end":"2026-04-23T00:18:39.809962Z","steps":["trace[1356090501] 'process raft request' (duration: 117.398634ms)","trace[1356090501] 'compare' (duration: 155.198326ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:39.810073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.336909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:18:39.810106Z","caller":"traceutil/trace.go:171","msg":"trace[414862939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1132; }","duration":"172.41496ms","start":"2026-04-23T00:18:39.637682Z","end":"2026-04-23T00:18:39.810097Z","steps":["trace[414862939] 'agreement among raft nodes before linearized reading' (duration: 172.349389ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:39.810228Z","caller":"traceutil/trace.go:171","msg":"trace[259102811] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"272.697831ms","start":"2026-04-23T00:18:39.537523Z","end":"2026-04-23T00:18:39.810221Z","steps":["trace[259102811] 'process raft request' (duration: 272.319254ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:39.81028Z","caller":"traceutil/trace.go:171","msg":"trace[1980253562] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"270.932533ms","start":"2026-04-23T00:18:39.539304Z","end":"2026-04-23T00:18:39.810237Z","steps":["trace[1980253562] 'process raft request' (duration: 270.594046ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:47.297153Z","caller":"traceutil/trace.go:171","msg":"trace[1284213277] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"114.76155ms","start":"2026-04-23T00:18:47.182364Z","end":"2026-04-23T00:18:47.297125Z","steps":["trace[1284213277] 'read index received' (duration: 114.655559ms)","trace[1284213277] 'applied index is now lower than readState.Index' (duration: 104.931µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:18:47.29735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.964933ms","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-04-23T00:18:47.29736Z","caller":"traceutil/trace.go:171","msg":"trace[1855546279] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"254.985419ms","start":"2026-04-23T00:18:47.042348Z","end":"2026-04-23T00:18:47.297334Z","steps":["trace[1855546279] 'process raft request' (duration: 254.535592ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:47.297391Z","caller":"traceutil/trace.go:171","msg":"trace[1981529204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1204; }","duration":"115.053834ms","start":"2026-04-23T00:18:47.182324Z","end":"2026-04-23T00:18:47.297378Z","steps":["trace[1981529204] 'agreement among raft nodes before linearized reading' (duration: 114.902862ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:18:47.342825Z","caller":"traceutil/trace.go:171","msg":"trace[305938047] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"102.5827ms","start":"2026-04-23T00:18:47.240219Z","end":"2026-04-23T00:18:47.342801Z","steps":["trace[305938047] 'process raft request' (duration: 100.979323ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:19:01.739551Z","caller":"traceutil/trace.go:171","msg":"trace[933411771] linearizableReadLoop","detail":"{readStateIndex:1309; appliedIndex:1308; }","duration":"204.64504ms","start":"2026-04-23T00:19:01.534884Z","end":"2026-04-23T00:19:01.739529Z","steps":["trace[933411771] 'read index received' (duration: 204.501168ms)","trace[933411771] 'applied index is now lower than readState.Index' (duration: 142.902µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:19:01.739873Z","caller":"traceutil/trace.go:171","msg":"trace[1774146242] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"265.909449ms","start":"2026-04-23T00:19:01.47395Z","end":"2026-04-23T00:19:01.739859Z","steps":["trace[1774146242] 'process raft request' (duration: 265.414882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:01.740271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.080749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:19:01.740361Z","caller":"traceutil/trace.go:171","msg":"trace[1020582620] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1259; }","duration":"103.21912ms","start":"2026-04-23T00:19:01.637126Z","end":"2026-04-23T00:19:01.740345Z","steps":["trace[1020582620] 'agreement among raft nodes before linearized reading' (duration: 103.095087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:01.741128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.237816ms","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-23T00:19:01.741174Z","caller":"traceutil/trace.go:171","msg":"trace[1725428730] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1259; }","duration":"206.318938ms","start":"2026-04-23T00:19:01.534843Z","end":"2026-04-23T00:19:01.741162Z","steps":["trace[1725428730] 'agreement among raft nodes before linearized reading' (duration: 205.21656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:02.376614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.146052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:19:02.37675Z","caller":"traceutil/trace.go:171","msg":"trace[1425672488] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"631.546831ms","start":"2026-04-23T00:19:01.745178Z","end":"2026-04-23T00:19:02.376725Z","steps":["trace[1425672488] 'process raft request' (duration: 481.157825ms)","trace[1425672488] 'compare' (duration: 149.860928ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:19:02.376808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:01.74516Z","time spent":"631.622742ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:19:02.471065Z","caller":"traceutil/trace.go:171","msg":"trace[1168790408] linearizableReadLoop","detail":"{readStateIndex:1311; appliedIndex:1309; }","duration":"502.706969ms","start":"2026-04-23T00:19:01.968329Z","end":"2026-04-23T00:19:02.471036Z","steps":["trace[1168790408] 'read index received' (duration: 258.151412ms)","trace[1168790408] 'applied index is now lower than readState.Index' (duration: 244.554317ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:19:02.471253Z","caller":"traceutil/trace.go:171","msg":"trace[1496513129] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"724.808618ms","start":"2026-04-23T00:19:01.746389Z","end":"2026-04-23T00:19:02.471198Z","steps":["trace[1496513129] 'process raft request' (duration: 724.450431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:02.471393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:01.746381Z","time spent":"724.912849ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:19:02.471417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.926132ms","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-23T00:19:02.471477Z","caller":"traceutil/trace.go:171","msg":"trace[482238562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1261; }","duration":"475.007243ms","start":"2026-04-23T00:19:01.996454Z","end":"2026-04-23T00:19:02.471461Z","steps":["trace[482238562] 'agreement among raft nodes before linearized reading' (duration: 474.8311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:02.471535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:01.996443Z","time spent":"475.080805ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-23T00:19:02.471924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.585384ms","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-04-23T00:19:02.471988Z","caller":"traceutil/trace.go:171","msg":"trace[1399234957] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1261; }","duration":"503.650605ms","start":"2026-04-23T00:19:01.968322Z","end":"2026-04-23T00:19:02.471973Z","steps":["trace[1399234957] 'agreement among raft nodes before linearized reading' (duration: 503.504203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:02.472037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:01.96826Z","time spent":"503.764757ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-23T00:19:02.472051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.364486ms","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-23T00:19:02.472098Z","caller":"traceutil/trace.go:171","msg":"trace[817680683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1261; }","duration":"473.431997ms","start":"2026-04-23T00:19:01.998652Z","end":"2026-04-23T00:19:02.472084Z","steps":["trace[817680683] 'agreement among raft nodes before linearized reading' (duration: 473.308145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:02.472138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:01.998642Z","time spent":"473.489528ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-23T00:19:02.639142Z","caller":"traceutil/trace.go:171","msg":"trace[400423270] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"161.5266ms","start":"2026-04-23T00:19:02.477601Z","end":"2026-04-23T00:19:02.639128Z","steps":["trace[400423270] 'process raft request' (duration: 80.75698ms)","trace[400423270] 'compare' (duration: 80.655787ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:19:02.639877Z","caller":"traceutil/trace.go:171","msg":"trace[1351954127] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"162.242892ms","start":"2026-04-23T00:19:02.477627Z","end":"2026-04-23T00:19:02.63987Z","steps":["trace[1351954127] 'process raft request' (duration: 161.476949ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:19:02.639903Z","caller":"traceutil/trace.go:171","msg":"trace[1323096828] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1311; }","duration":"131.202921ms","start":"2026-04-23T00:19:02.508682Z","end":"2026-04-23T00:19:02.639885Z","steps":["trace[1323096828] 'read index received' (duration: 49.690559ms)","trace[1323096828] 'applied index is now lower than readState.Index' (duration: 81.511442ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:19:02.640071Z","caller":"traceutil/trace.go:171","msg":"trace[202206919] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"162.332543ms","start":"2026-04-23T00:19:02.477667Z","end":"2026-04-23T00:19:02.639999Z","steps":["trace[202206919] 'process raft request' (duration: 162.14654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:02.640125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.430405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:19:02.640147Z","caller":"traceutil/trace.go:171","msg":"trace[2043290832] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1264; }","duration":"131.488855ms","start":"2026-04-23T00:19:02.50865Z","end":"2026-04-23T00:19:02.640139Z","steps":["trace[2043290832] 'agreement among raft nodes before linearized reading' (duration: 131.448805ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:19:03.99244Z","caller":"traceutil/trace.go:171","msg":"trace[2127007776] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"247.265483ms","start":"2026-04-23T00:19:03.745148Z","end":"2026-04-23T00:19:03.992413Z","steps":["trace[2127007776] 'process raft request' (duration: 247.07749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:04.68807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.723456ms","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-23T00:19:04.688163Z","caller":"traceutil/trace.go:171","msg":"trace[1327182366] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1266; }","duration":"211.851068ms","start":"2026-04-23T00:19:04.476283Z","end":"2026-04-23T00:19:04.688134Z","steps":["trace[1327182366] 'range keys from in-memory index tree' (duration: 211.475902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:04.688068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.035716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-23T00:19:04.688249Z","caller":"traceutil/trace.go:171","msg":"trace[1095413700] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1266; }","duration":"307.263059ms","start":"2026-04-23T00:19:04.380965Z","end":"2026-04-23T00:19:04.688228Z","steps":["trace[1095413700] 'range keys from in-memory index tree' (duration: 306.854373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:04.68833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:04.380945Z","time spent":"307.354201ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-23T00:19:04.878824Z","caller":"traceutil/trace.go:171","msg":"trace[1807131900] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1317; }","duration":"189.668293ms","start":"2026-04-23T00:19:04.68911Z","end":"2026-04-23T00:19:04.878778Z","steps":["trace[1807131900] 'read index received' (duration: 189.652753ms)","trace[1807131900] 'applied index is now lower than readState.Index' (duration: 12.89µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:19:04.87896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.820295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:19:04.879012Z","caller":"traceutil/trace.go:171","msg":"trace[1339684568] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"189.894267ms","start":"2026-04-23T00:19:04.689104Z","end":"2026-04-23T00:19:04.878998Z","steps":["trace[1339684568] 'agreement among raft nodes before linearized reading' (duration: 189.768325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:05.032372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.766242ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:19:05.032656Z","caller":"traceutil/trace.go:171","msg":"trace[235220597] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"340.346805ms","start":"2026-04-23T00:19:04.692266Z","end":"2026-04-23T00:19:05.032613Z","steps":["trace[235220597] 'process raft request' (duration: 217.150396ms)","trace[235220597] 'compare' (duration: 122.471337ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:19:05.032829Z","caller":"traceutil/trace.go:171","msg":"trace[502099931] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"340.516228ms","start":"2026-04-23T00:19:04.692283Z","end":"2026-04-23T00:19:05.032799Z","steps":["trace[502099931] 'process raft request' (duration: 340.240504ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:19:05.03288Z","caller":"traceutil/trace.go:171","msg":"trace[341088578] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"340.504458ms","start":"2026-04-23T00:19:04.692328Z","end":"2026-04-23T00:19:05.032833Z","steps":["trace[341088578] 'process raft request' (duration: 340.377896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:05.032937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:04.692244Z","time spent":"340.512287ms","remote":"127.0.0.1:38780","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-04-23T00:19:05.032963Z","caller":"traceutil/trace.go:171","msg":"trace[1341659387] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"153.01653ms","start":"2026-04-23T00:19:04.879923Z","end":"2026-04-23T00:19:05.032939Z","steps":["trace[1341659387] 'process raft request' (duration: 152.950449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:05.032991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:04.692268Z","time spent":"340.63861ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:19:05.033057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:04.692323Z","time spent":"340.64651ms","remote":"127.0.0.1:38780","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-04-23T00:19:05.033174Z","caller":"traceutil/trace.go:171","msg":"trace[1550852242] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"340.059261ms","start":"2026-04-23T00:19:04.693098Z","end":"2026-04-23T00:19:05.033157Z","steps":["trace[1550852242] 'process raft request' (duration: 339.719675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:05.033231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:04.693092Z","time spent":"340.106471ms","remote":"127.0.0.1:38780","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-23T00:19:05.033168Z","caller":"traceutil/trace.go:171","msg":"trace[1000768506] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"340.446107ms","start":"2026-04-23T00:19:04.692644Z","end":"2026-04-23T00:19:05.03309Z","steps":["trace[1000768506] 'process raft request' (duration: 340.126752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:05.033656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:04.692566Z","time spent":"340.69437ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T00:19:06.145204Z","caller":"traceutil/trace.go:171","msg":"trace[1299128944] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"147.660232ms","start":"2026-04-23T00:19:05.997515Z","end":"2026-04-23T00:19:06.145176Z","steps":["trace[1299128944] 'process raft request' (duration: 147.481358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:06.760938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.178216ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T00:19:06.761071Z","caller":"traceutil/trace.go:171","msg":"trace[1148962638] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"185.139519ms","start":"2026-04-23T00:19:06.575906Z","end":"2026-04-23T00:19:06.761046Z","steps":["trace[1148962638] 'read index received' (duration: 32.819641ms)","trace[1148962638] 'applied index is now lower than readState.Index' (duration: 152.318298ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:19:06.761123Z","caller":"traceutil/trace.go:171","msg":"trace[1121782835] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"248.384291ms","start":"2026-04-23T00:19:06.512709Z","end":"2026-04-23T00:19:06.761093Z","steps":["trace[1121782835] 'process raft request' (duration: 95.94402ms)","trace[1121782835] 'compare' (duration: 151.960853ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T00:19:06.761283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.380274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-04-23T00:19:06.761342Z","caller":"traceutil/trace.go:171","msg":"trace[1347693675] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1276; }","duration":"185.452215ms","start":"2026-04-23T00:19:06.575864Z","end":"2026-04-23T00:19:06.761316Z","steps":["trace[1347693675] 'agreement among raft nodes before linearized reading' (duration: 185.282872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:06.76126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.010026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T00:19:06.761442Z","caller":"traceutil/trace.go:171","msg":"trace[568210759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1276; }","duration":"123.20853ms","start":"2026-04-23T00:19:06.638219Z","end":"2026-04-23T00:19:06.761427Z","steps":["trace[568210759] 'agreement among raft nodes before linearized reading' (duration: 122.984546ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:19:07.067385Z","caller":"traceutil/trace.go:171","msg":"trace[1563926910] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1327; }","duration":"106.825529ms","start":"2026-04-23T00:19:06.960532Z","end":"2026-04-23T00:19:07.067357Z","steps":["trace[1563926910] 'read index received' (duration: 96.929346ms)","trace[1563926910] 'applied index is now lower than readState.Index' (duration: 9.894603ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T00:19:07.067527Z","caller":"traceutil/trace.go:171","msg":"trace[166393541] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"299.989021ms","start":"2026-04-23T00:19:06.76752Z","end":"2026-04-23T00:19:07.067509Z","steps":["trace[166393541] 'process raft request' (duration: 290.078598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:07.068433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:06.76749Z","time spent":"300.852945ms","remote":"127.0.0.1:38686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T00:19:07.067741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.195695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T00:19:07.069275Z","caller":"traceutil/trace.go:171","msg":"trace[1556632517] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1277; }","duration":"108.766471ms","start":"2026-04-23T00:19:06.960489Z","end":"2026-04-23T00:19:07.069255Z","steps":["trace[1556632517] 'agreement among raft nodes before linearized reading' (duration: 107.189374ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:19:16.599744Z","caller":"traceutil/trace.go:171","msg":"trace[1813929373] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"409.068336ms","start":"2026-04-23T00:19:16.190623Z","end":"2026-04-23T00:19:16.599691Z","steps":["trace[1813929373] 'process raft request' (duration: 408.797672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T00:19:16.600219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T00:19:16.190594Z","time spent":"409.509665ms","remote":"127.0.0.1:38780","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-23T00:19:30.031483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.043686ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-23T00:19:30.230973Z","caller":"traceutil/trace.go:171","msg":"trace[274739858] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"125.274653ms","start":"2026-04-23T00:19:30.105676Z","end":"2026-04-23T00:19:30.230951Z","steps":["trace[274739858] 'process raft request' (duration: 125.126811ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T00:22:25.680244Z","caller":"traceutil/trace.go:171","msg":"trace[991428600] transaction","detail":"{read_only:false; response_revision:2255; number_of_response:1; }","duration":"198.964278ms","start":"2026-04-23T00:22:25.481249Z","end":"2026-04-23T00:22:25.680213Z","steps":["trace[991428600] 'process raft request' (duration: 198.632972ms)"],"step_count":1}