{"level":"warn","ts":"2026-04-21T17:26:43.146018Z","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-21T17:26:43.146119Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25: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.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-21T17:26:43.146243Z","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-21T17:26:43.146263Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-21T17:26:43.146284Z","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-21T17:26:43.147089Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-04-21T17:26:43.147267Z","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.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-21T17:26:43.151635Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.073482ms"} {"level":"info","ts":"2026-04-21T17:26:43.159554Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-04-21T17:26:43.159699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T17:26:43.159802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-04-21T17:26:43.159826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T17:26:43.159842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-04-21T17:26:43.159975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-04-21T17:26:43.167411Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T17:26:43.169328Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T17:26:43.172361Z","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-21T17:26:43.174661Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T17:26:43.174908Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T17:26:43.1751Z","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-21T17:26:43.175213Z","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-21T17:26:43.175228Z","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-21T17:26:43.175717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-04-21T17:26:43.176615Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-21T17:26:43.180116Z","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-21T17:26:43.180308Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T17:26:43.18037Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T17:26:43.180332Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-21T17:26:43.180464Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-21T17:26:44.060767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T17:26:44.060815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T17:26:44.060842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-04-21T17:26:44.060855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-04-21T17:26:44.060862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-21T17:26:44.060876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-04-21T17:26:44.060884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-21T17:26:44.061925Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T17:26:44.061977Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:26:44.062077Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:26:44.06204Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:26:44.063936Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:26:44.063975Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T17:26:44.064079Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:26:44.064157Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T17:26:44.064239Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T17:26:44.065248Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-04-21T17:26:44.064111Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-21T17:26:45.786142Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422004054808694,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T17:26:45.903251Z","caller":"traceutil/trace.go:171","msg":"trace[669755435] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"618.679558ms","start":"2026-04-21T17:26:45.284549Z","end":"2026-04-21T17:26:45.903229Z","steps":["trace[669755435] 'process raft request' (duration: 618.508163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:45.904238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.284537Z","time spent":"619.20468ms","remote":"127.0.0.1:47536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:26:47.891322Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.988238545s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-21T17:26:48.084081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.383522ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-21T17:26:48.084294Z","caller":"traceutil/trace.go:171","msg":"trace[249884147] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"2.742330881s","start":"2026-04-21T17:26:45.34193Z","end":"2026-04-21T17:26:48.084261Z","steps":["trace[249884147] 'process raft request' (duration: 2.742250289s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.084341Z","caller":"traceutil/trace.go:171","msg":"trace[866452193] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:4; }","duration":"2.799280843s","start":"2026-04-21T17:26:45.285052Z","end":"2026-04-21T17:26:48.084333Z","steps":["trace[866452193] 'read index received' (duration: 618.073801ms)","trace[866452193] 'applied index is now lower than readState.Index' (duration: 2.181206322s)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:26:48.084377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.341915Z","time spent":"2.742426603s","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:26:48.084363Z","caller":"traceutil/trace.go:171","msg":"trace[115337654] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"2.742048235s","start":"2026-04-21T17:26:45.342267Z","end":"2026-04-21T17:26:48.084316Z","steps":["trace[115337654] 'process raft request' (duration: 2.741976033s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.08425Z","caller":"traceutil/trace.go:171","msg":"trace[1630004255] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"2.742380562s","start":"2026-04-21T17:26:45.341842Z","end":"2026-04-21T17:26:48.084222Z","steps":["trace[1630004255] 'process raft request' (duration: 2.549709013s)","trace[1630004255] 'compare' (duration: 192.237579ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:26:48.084505Z","caller":"traceutil/trace.go:171","msg":"trace[127297802] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"2.742109066s","start":"2026-04-21T17:26:45.34239Z","end":"2026-04-21T17:26:48.084499Z","steps":["trace[127297802] 'process raft request' (duration: 2.74187422s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.084559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.342377Z","time spent":"2.742164877s","remote":"127.0.0.1:47938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.084547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.342254Z","time spent":"2.742194928s","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.084505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.341834Z","time spent":"2.742617188s","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.084633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.79956489s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T17:26:48.084664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.799500879s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-04-21T17:26:48.08468Z","caller":"traceutil/trace.go:171","msg":"trace[348107734] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"2.799524439s","start":"2026-04-21T17:26:45.285151Z","end":"2026-04-21T17:26:48.084675Z","steps":["trace[348107734] 'agreement among raft nodes before linearized reading' (duration: 2.799490938s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.084676Z","caller":"traceutil/trace.go:171","msg":"trace[290308552] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"2.799636162s","start":"2026-04-21T17:26:45.285029Z","end":"2026-04-21T17:26:48.084665Z","steps":["trace[290308552] 'agreement among raft nodes before linearized reading' (duration: 2.799473488s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.084696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.285148Z","time spent":"2.7995451s","remote":"127.0.0.1:47654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-21T17:26:48.084705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.285013Z","time spent":"2.799684963s","remote":"127.0.0.1:47530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-04-21T17:26:48.084706Z","caller":"traceutil/trace.go:171","msg":"trace[1016008842] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"2.742601137s","start":"2026-04-21T17:26:45.342086Z","end":"2026-04-21T17:26:48.084687Z","steps":["trace[1016008842] 'process raft request' (duration: 2.742121216s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.08472Z","caller":"traceutil/trace.go:171","msg":"trace[1842370514] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"2.73011286s","start":"2026-04-21T17:26:45.354554Z","end":"2026-04-21T17:26:48.084667Z","steps":["trace[1842370514] 'process raft request' (duration: 2.729734451s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.084767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.342078Z","time spent":"2.742653089s","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.084783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.691715835s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.084802Z","caller":"traceutil/trace.go:171","msg":"trace[88806865] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.691753586s","start":"2026-04-21T17:26:45.393043Z","end":"2026-04-21T17:26:48.084797Z","steps":["trace[88806865] 'agreement among raft nodes before linearized reading' (duration: 2.691723285s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.084817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.39303Z","time spent":"2.691781936s","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-21T17:26:48.084876Z","caller":"traceutil/trace.go:171","msg":"trace[1301083743] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"2.742658789s","start":"2026-04-21T17:26:45.342208Z","end":"2026-04-21T17:26:48.084867Z","steps":["trace[1301083743] 'process raft request' (duration: 2.742014963s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.084797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.84418802s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T17:26:48.084918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.342191Z","time spent":"2.74270872s","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.084958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.743038778s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.084949Z","caller":"traceutil/trace.go:171","msg":"trace[1707094322] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.730072048s","start":"2026-04-21T17:26:45.354854Z","end":"2026-04-21T17:26:48.084926Z","steps":["trace[1707094322] 'process raft request' (duration: 2.729455153s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.084977Z","caller":"traceutil/trace.go:171","msg":"trace[2025236169] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.743075149s","start":"2026-04-21T17:26:45.341897Z","end":"2026-04-21T17:26:48.084972Z","steps":["trace[2025236169] 'agreement among raft nodes before linearized reading' (duration: 2.743046348s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.084956Z","caller":"traceutil/trace.go:171","msg":"trace[508008167] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:10; }","duration":"1.844438506s","start":"2026-04-21T17:26:46.240495Z","end":"2026-04-21T17:26:48.084933Z","steps":["trace[508008167] 'agreement among raft nodes before linearized reading' (duration: 1.84419297s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.084992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.341887Z","time spent":"2.74310217s","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-21T17:26:48.085015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:46.240477Z","time spent":"1.844528618s","remote":"127.0.0.1:47836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-04-21T17:26:48.085019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.354725Z","time spent":"2.730265443s","remote":"127.0.0.1:47654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.085037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.596899631s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T17:26:48.085065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.743285204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.085069Z","caller":"traceutil/trace.go:171","msg":"trace[637114907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10; }","duration":"1.596961842s","start":"2026-04-21T17:26:46.488098Z","end":"2026-04-21T17:26:48.085059Z","steps":["trace[637114907] 'agreement among raft nodes before linearized reading' (duration: 1.596892101s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.085067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.452621326s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.085085Z","caller":"traceutil/trace.go:171","msg":"trace[1981740070] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"2.743313045s","start":"2026-04-21T17:26:45.341765Z","end":"2026-04-21T17:26:48.085078Z","steps":["trace[1981740070] 'agreement among raft nodes before linearized reading' (duration: 2.743285284s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.085096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:46.488079Z","time spent":"1.597011984s","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:26:48.0851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.748115513s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.085102Z","caller":"traceutil/trace.go:171","msg":"trace[1144346654] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:10; }","duration":"1.452693028s","start":"2026-04-21T17:26:46.6324Z","end":"2026-04-21T17:26:48.085093Z","steps":["trace[1144346654] 'agreement among raft nodes before linearized reading' (duration: 1.452641917s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.085125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.799729164s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-04-21T17:26:48.085129Z","caller":"traceutil/trace.go:171","msg":"trace[1197361934] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.748176785s","start":"2026-04-21T17:26:45.336944Z","end":"2026-04-21T17:26:48.085121Z","steps":["trace[1197361934] 'agreement among raft nodes before linearized reading' (duration: 2.748117813s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.085133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:46.632375Z","time spent":"1.45275179s","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-04-21T17:26:48.085151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.336926Z","time spent":"2.748221305s","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-21T17:26:48.084896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.35454Z","time spent":"2.730247903s","remote":"127.0.0.1:47750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.08524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.745313534s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.085257Z","caller":"traceutil/trace.go:171","msg":"trace[1256880558] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:0; response_revision:10; }","duration":"2.745340255s","start":"2026-04-21T17:26:45.339912Z","end":"2026-04-21T17:26:48.085252Z","steps":["trace[1256880558] 'agreement among raft nodes before linearized reading' (duration: 2.745314414s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.085282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.339905Z","time spent":"2.745373575s","remote":"127.0.0.1:47496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.25\" "} {"level":"warn","ts":"2026-04-21T17:26:48.085102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.34176Z","time spent":"2.743338305s","remote":"127.0.0.1:47550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-04-21T17:26:48.085334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.747573419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.085385Z","caller":"traceutil/trace.go:171","msg":"trace[98724733] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.747655351s","start":"2026-04-21T17:26:45.337717Z","end":"2026-04-21T17:26:48.085372Z","steps":["trace[98724733] 'agreement among raft nodes before linearized reading' (duration: 2.747591159s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.085419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.337693Z","time spent":"2.747719583s","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-21T17:26:48.085141Z","caller":"traceutil/trace.go:171","msg":"trace[1719104738] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"2.799751204s","start":"2026-04-21T17:26:45.285385Z","end":"2026-04-21T17:26:48.085136Z","steps":["trace[1719104738] 'agreement among raft nodes before linearized reading' (duration: 2.799727273s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.085504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.747650502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T17:26:48.085537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.285381Z","time spent":"2.800130034s","remote":"127.0.0.1:47654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-21T17:26:48.085541Z","caller":"traceutil/trace.go:171","msg":"trace[2003361469] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"2.747702163s","start":"2026-04-21T17:26:45.337819Z","end":"2026-04-21T17:26:48.085521Z","steps":["trace[2003361469] 'agreement among raft nodes before linearized reading' (duration: 2.747668332s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.085572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:45.337802Z","time spent":"2.747765164s","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-21T17:26:48.085688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.843044462s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.085731Z","caller":"traceutil/trace.go:171","msg":"trace[530409061] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:10; }","duration":"1.843103934s","start":"2026-04-21T17:26:46.242615Z","end":"2026-04-21T17:26:48.085719Z","steps":["trace[530409061] 'agreement among raft nodes before linearized reading' (duration: 1.843043412s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.085886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:46.242606Z","time spent":"1.843268977s","remote":"127.0.0.1:47842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-04-21T17:26:48.456816Z","caller":"traceutil/trace.go:171","msg":"trace[1368582842] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"365.215092ms","start":"2026-04-21T17:26:48.091574Z","end":"2026-04-21T17:26:48.456789Z","steps":["trace[1368582842] 'process raft request' (duration: 342.896505ms)","trace[1368582842] 'compare' (duration: 22.199474ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:26:48.457155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.091555Z","time spent":"365.480197ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:26:48.457587Z","caller":"traceutil/trace.go:171","msg":"trace[1254948356] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"365.691273ms","start":"2026-04-21T17:26:48.091864Z","end":"2026-04-21T17:26:48.457555Z","steps":["trace[1254948356] 'process raft request' (duration: 365.340554ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.45773Z","caller":"traceutil/trace.go:171","msg":"trace[351170667] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"365.523008ms","start":"2026-04-21T17:26:48.092187Z","end":"2026-04-21T17:26:48.45771Z","steps":["trace[351170667] 'process raft request' (duration: 365.198921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.457779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.091846Z","time spent":"365.828206ms","remote":"127.0.0.1:47530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:26:48.457798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.092179Z","time spent":"365.59033ms","remote":"127.0.0.1:47842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:26:48.457791Z","caller":"traceutil/trace.go:171","msg":"trace[659665956] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"365.722353ms","start":"2026-04-21T17:26:48.092027Z","end":"2026-04-21T17:26:48.457749Z","steps":["trace[659665956] 'process raft request' (duration: 365.323684ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.457827Z","caller":"traceutil/trace.go:171","msg":"trace[1291258902] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"365.622421ms","start":"2026-04-21T17:26:48.092185Z","end":"2026-04-21T17:26:48.457808Z","steps":["trace[1291258902] 'process raft request' (duration: 365.227371ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.457841Z","caller":"traceutil/trace.go:171","msg":"trace[1776237355] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"365.881467ms","start":"2026-04-21T17:26:48.091924Z","end":"2026-04-21T17:26:48.457805Z","steps":["trace[1776237355] 'process raft request' (duration: 365.375125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.45792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.092018Z","time spent":"365.839916ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.457926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.092167Z","time spent":"365.701833ms","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.457947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.091906Z","time spent":"365.99031ms","remote":"127.0.0.1:47938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:26:48.458134Z","caller":"traceutil/trace.go:171","msg":"trace[1910617535] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"365.865317ms","start":"2026-04-21T17:26:48.092259Z","end":"2026-04-21T17:26:48.458124Z","steps":["trace[1910617535] 'process raft request' (duration: 365.19932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.45818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.092245Z","time spent":"365.910359ms","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:26:48.458256Z","caller":"traceutil/trace.go:171","msg":"trace[808431778] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"365.990231ms","start":"2026-04-21T17:26:48.092255Z","end":"2026-04-21T17:26:48.458245Z","steps":["trace[808431778] 'process raft request' (duration: 365.225742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.45831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.092225Z","time spent":"366.060572ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:26:48.458585Z","caller":"traceutil/trace.go:171","msg":"trace[1194470060] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"366.262557ms","start":"2026-04-21T17:26:48.092306Z","end":"2026-04-21T17:26:48.458568Z","steps":["trace[1194470060] 'process raft request' (duration: 365.224511ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.45861Z","caller":"traceutil/trace.go:171","msg":"trace[1686987464] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:13; }","duration":"366.558524ms","start":"2026-04-21T17:26:48.092039Z","end":"2026-04-21T17:26:48.458597Z","steps":["trace[1686987464] 'read index received' (duration: 342.521807ms)","trace[1686987464] 'applied index is now lower than readState.Index' (duration: 24.035907ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:26:48.458653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.092301Z","time spent":"366.321698ms","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:26:48.458691Z","caller":"traceutil/trace.go:171","msg":"trace[1732301387] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"358.134411ms","start":"2026-04-21T17:26:48.100549Z","end":"2026-04-21T17:26:48.458683Z","steps":["trace[1732301387] 'process raft request' (duration: 357.982498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.458841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.100507Z","time spent":"358.204053ms","remote":"127.0.0.1:47654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:26:48.458893Z","caller":"traceutil/trace.go:171","msg":"trace[685567964] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"366.513383ms","start":"2026-04-21T17:26:48.092367Z","end":"2026-04-21T17:26:48.45888Z","steps":["trace[685567964] 'process raft request' (duration: 366.097303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.45896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.092348Z","time spent":"366.575014ms","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:26:48.459036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.919492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-2gn74\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-04-21T17:26:48.459085Z","caller":"traceutil/trace.go:171","msg":"trace[1910730084] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-2gn74; range_end:; response_count:1; response_revision:21; }","duration":"366.994555ms","start":"2026-04-21T17:26:48.092076Z","end":"2026-04-21T17:26:48.459071Z","steps":["trace[1910730084] 'agreement among raft nodes before linearized reading' (duration: 366.866182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.459132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.09207Z","time spent":"367.047796ms","remote":"127.0.0.1:47750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-2gn74\" "} {"level":"info","ts":"2026-04-21T17:26:48.459135Z","caller":"traceutil/trace.go:171","msg":"trace[961380496] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"366.519833ms","start":"2026-04-21T17:26:48.0926Z","end":"2026-04-21T17:26:48.45912Z","steps":["trace[961380496] 'process raft request' (duration: 365.895398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.459182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.051977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-21T17:26:48.459218Z","caller":"traceutil/trace.go:171","msg":"trace[1993772390] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"310.088248ms","start":"2026-04-21T17:26:48.149118Z","end":"2026-04-21T17:26:48.459206Z","steps":["trace[1993772390] 'agreement among raft nodes before linearized reading' (duration: 310.026606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.459248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.149069Z","time spent":"310.173051ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-21T17:26:48.459284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.435634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.459324Z","caller":"traceutil/trace.go:171","msg":"trace[1400740463] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:21; }","duration":"317.508385ms","start":"2026-04-21T17:26:48.141804Z","end":"2026-04-21T17:26:48.459312Z","steps":["trace[1400740463] 'agreement among raft nodes before linearized reading' (duration: 317.438114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.459336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.189449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T17:26:48.45936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.141783Z","time spent":"317.570987ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-node-lease\" "} {"level":"warn","ts":"2026-04-21T17:26:48.459378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.337813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.45941Z","caller":"traceutil/trace.go:171","msg":"trace[1011552436] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:21; }","duration":"367.369333ms","start":"2026-04-21T17:26:48.092032Z","end":"2026-04-21T17:26:48.459401Z","steps":["trace[1011552436] 'agreement among raft nodes before linearized reading' (duration: 367.323062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.459438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.091975Z","time spent":"367.455935ms","remote":"127.0.0.1:47840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-04-21T17:26:48.459509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.638672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-21T17:26:48.459541Z","caller":"traceutil/trace.go:171","msg":"trace[602407067] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:21; }","duration":"315.690323ms","start":"2026-04-21T17:26:48.143841Z","end":"2026-04-21T17:26:48.459532Z","steps":["trace[602407067] 'agreement among raft nodes before linearized reading' (duration: 315.640961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.459558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.429222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-21T17:26:48.459565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.143833Z","time spent":"315.726903ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"info","ts":"2026-04-21T17:26:48.459588Z","caller":"traceutil/trace.go:171","msg":"trace[812122476] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:21; }","duration":"167.493513ms","start":"2026-04-21T17:26:48.292084Z","end":"2026-04-21T17:26:48.459577Z","steps":["trace[812122476] 'agreement among raft nodes before linearized reading' (duration: 167.455052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.459672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.243405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-21T17:26:48.459376Z","caller":"traceutil/trace.go:171","msg":"trace[446961930] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"367.249441ms","start":"2026-04-21T17:26:48.092115Z","end":"2026-04-21T17:26:48.459364Z","steps":["trace[446961930] 'agreement among raft nodes before linearized reading' (duration: 367.191869ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:48.459703Z","caller":"traceutil/trace.go:171","msg":"trace[639901911] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"251.312556ms","start":"2026-04-21T17:26:48.208381Z","end":"2026-04-21T17:26:48.459693Z","steps":["trace[639901911] 'agreement among raft nodes before linearized reading' (duration: 251.261835ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:48.459707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.092105Z","time spent":"367.595499ms","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:26:48.459211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:48.092574Z","time spent":"366.596195ms","remote":"127.0.0.1:47994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:26:51.325203Z","caller":"traceutil/trace.go:171","msg":"trace[1023979540] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"104.042818ms","start":"2026-04-21T17:26:51.221133Z","end":"2026-04-21T17:26:51.325175Z","steps":["trace[1023979540] 'compare' (duration: 95.260252ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:51.326361Z","caller":"traceutil/trace.go:171","msg":"trace[1322984639] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"101.402046ms","start":"2026-04-21T17:26:51.224933Z","end":"2026-04-21T17:26:51.326335Z","steps":["trace[1322984639] 'process raft request' (duration: 101.038557ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:52.463337Z","caller":"traceutil/trace.go:171","msg":"trace[493021988] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"391.537931ms","start":"2026-04-21T17:26:52.071743Z","end":"2026-04-21T17:26:52.463281Z","steps":["trace[493021988] 'process raft request' (duration: 388.312336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:52.463486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:52.071716Z","time spent":"391.711855ms","remote":"127.0.0.1:47668","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:26:52.523515Z","caller":"traceutil/trace.go:171","msg":"trace[1970373129] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:321; }","duration":"427.397005ms","start":"2026-04-21T17:26:52.096094Z","end":"2026-04-21T17:26:52.523491Z","steps":["trace[1970373129] 'read index received' (duration: 363.97442ms)","trace[1970373129] 'applied index is now lower than readState.Index' (duration: 63.421585ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:26:52.523614Z","caller":"traceutil/trace.go:171","msg":"trace[530497694] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"438.459262ms","start":"2026-04-21T17:26:52.085126Z","end":"2026-04-21T17:26:52.523585Z","steps":["trace[530497694] 'process raft request' (duration: 438.216277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:52.523686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.59072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-21T17:26:52.523722Z","caller":"traceutil/trace.go:171","msg":"trace[531383007] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:314; }","duration":"427.644151ms","start":"2026-04-21T17:26:52.096067Z","end":"2026-04-21T17:26:52.523711Z","steps":["trace[531383007] 'agreement among raft nodes before linearized reading' (duration: 427.564299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:26:52.523762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:52.096031Z","time spent":"427.723893ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-21T17:26:52.523798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:26:52.085108Z","time spent":"438.582216ms","remote":"127.0.0.1:47668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5139,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:26:52.523991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.83896ms","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-21T17:26:52.524158Z","caller":"traceutil/trace.go:171","msg":"trace[354251887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:314; }","duration":"109.068895ms","start":"2026-04-21T17:26:52.415069Z","end":"2026-04-21T17:26:52.524138Z","steps":["trace[354251887] 'agreement among raft nodes before linearized reading' (duration: 108.714937ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:52.655987Z","caller":"traceutil/trace.go:171","msg":"trace[819390865] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"128.369224ms","start":"2026-04-21T17:26:52.527594Z","end":"2026-04-21T17:26:52.655963Z","steps":["trace[819390865] 'process raft request' (duration: 127.625977ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:52.656628Z","caller":"traceutil/trace.go:171","msg":"trace[1255523881] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"127.927623ms","start":"2026-04-21T17:26:52.52868Z","end":"2026-04-21T17:26:52.656607Z","steps":["trace[1255523881] 'process raft request' (duration: 127.250487ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:26:52.656836Z","caller":"traceutil/trace.go:171","msg":"trace[811722229] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"122.674831ms","start":"2026-04-21T17:26:52.534127Z","end":"2026-04-21T17:26:52.656802Z","steps":["trace[811722229] 'process raft request' (duration: 122.328973ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:09.973385Z","caller":"traceutil/trace.go:171","msg":"trace[694972764] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"158.022062ms","start":"2026-04-21T17:27:09.815347Z","end":"2026-04-21T17:27:09.973369Z","steps":["trace[694972764] 'process raft request' (duration: 157.930161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.265066Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422004054809659,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:27:16.678794Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.067190357s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:27:16.679628Z","caller":"traceutil/trace.go:171","msg":"trace[349345961] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.068115616s","start":"2026-04-21T17:27:15.611472Z","end":"2026-04-21T17:27:16.679587Z","steps":["trace[349345961] 'process raft request' (duration: 1.067832291s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.679988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.611448Z","time spent":"1.068424271s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:27:16.769929Z","caller":"traceutil/trace.go:171","msg":"trace[863819436] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.153428019s","start":"2026-04-21T17:27:15.616453Z","end":"2026-04-21T17:27:16.769881Z","steps":["trace[863819436] 'process raft request' (duration: 1.153279086s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:16.770032Z","caller":"traceutil/trace.go:171","msg":"trace[153856873] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.15354143s","start":"2026-04-21T17:27:15.616436Z","end":"2026-04-21T17:27:16.769977Z","steps":["trace[153856873] 'process raft request' (duration: 1.153158203s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:16.770125Z","caller":"traceutil/trace.go:171","msg":"trace[1152510476] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.138109617s","start":"2026-04-21T17:27:15.631943Z","end":"2026-04-21T17:27:16.770053Z","steps":["trace[1152510476] 'process raft request' (duration: 1.137872182s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.770198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.616436Z","time spent":"1.153628492s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:27:16.770239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.616415Z","time spent":"1.153726995s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:27:16.77019Z","caller":"traceutil/trace.go:171","msg":"trace[1589754542] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.137341962s","start":"2026-04-21T17:27:15.632769Z","end":"2026-04-21T17:27:16.770111Z","steps":["trace[1589754542] 'process raft request' (duration: 1.137087317s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.770328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.63193Z","time spent":"1.138313511s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:27:16.770427Z","caller":"traceutil/trace.go:171","msg":"trace[771884297] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.126072531s","start":"2026-04-21T17:27:15.644342Z","end":"2026-04-21T17:27:16.770414Z","steps":["trace[771884297] 'process raft request' (duration: 1.125715834s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.770466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.63276Z","time spent":"1.137601558s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:27:16.770442Z","caller":"traceutil/trace.go:171","msg":"trace[53296007] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:524; }","duration":"1.005728348s","start":"2026-04-21T17:27:15.764683Z","end":"2026-04-21T17:27:16.770411Z","steps":["trace[53296007] 'read index received' (duration: 914.509489ms)","trace[53296007] 'applied index is now lower than readState.Index' (duration: 91.217639ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:27:16.770464Z","caller":"traceutil/trace.go:171","msg":"trace[1776672601] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.134930365s","start":"2026-04-21T17:27:15.635498Z","end":"2026-04-21T17:27:16.770429Z","steps":["trace[1776672601] 'process raft request' (duration: 1.134394945s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:16.770506Z","caller":"traceutil/trace.go:171","msg":"trace[1078878673] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.138557106s","start":"2026-04-21T17:27:15.631936Z","end":"2026-04-21T17:27:16.770493Z","steps":["trace[1078878673] 'process raft request' (duration: 1.137835572s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:16.770531Z","caller":"traceutil/trace.go:171","msg":"trace[661809796] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.128422488s","start":"2026-04-21T17:27:15.642095Z","end":"2026-04-21T17:27:16.770517Z","steps":["trace[661809796] 'process raft request' (duration: 1.127833196s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:16.770555Z","caller":"traceutil/trace.go:171","msg":"trace[416310916] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.101652631s","start":"2026-04-21T17:27:15.668892Z","end":"2026-04-21T17:27:16.770545Z","steps":["trace[416310916] 'process raft request' (duration: 1.101248074s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.770579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.642078Z","time spent":"1.128478458s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:27:16.770581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.63192Z","time spent":"1.138632677s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:27:16.77062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.635489Z","time spent":"1.135064417s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:27:16.770672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.668875Z","time spent":"1.101715192s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:27:16.770683Z","caller":"traceutil/trace.go:171","msg":"trace[1016849564] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"1.079627609s","start":"2026-04-21T17:27:15.691045Z","end":"2026-04-21T17:27:16.770673Z","steps":["trace[1016849564] 'process raft request' (duration: 1.07916288s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:16.77069Z","caller":"traceutil/trace.go:171","msg":"trace[1236871708] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"977.514064ms","start":"2026-04-21T17:27:15.793158Z","end":"2026-04-21T17:27:16.770672Z","steps":["trace[1236871708] 'process raft request' (duration: 977.181327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.770727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.691025Z","time spent":"1.079681209s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:27:16.770746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.793107Z","time spent":"977.613746ms","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:27:16.770481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.644327Z","time spent":"1.126132573s","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:27:16.770852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006175537s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:16.770898Z","caller":"traceutil/trace.go:171","msg":"trace[1308535125] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"1.006282719s","start":"2026-04-21T17:27:15.764602Z","end":"2026-04-21T17:27:16.770884Z","steps":["trace[1308535125] 'agreement among raft nodes before linearized reading' (duration: 1.006166997s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.770935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.76457Z","time spent":"1.0063589s","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:27:16.780023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.725931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T17:27:16.780088Z","caller":"traceutil/trace.go:171","msg":"trace[1120662758] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:523; }","duration":"329.834464ms","start":"2026-04-21T17:27:16.450239Z","end":"2026-04-21T17:27:16.780074Z","steps":["trace[1120662758] 'agreement among raft nodes before linearized reading' (duration: 329.576808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.780123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:16.45022Z","time spent":"329.895796ms","remote":"127.0.0.1:47766","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-21T17:27:16.780437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.569925ms","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-21T17:27:16.780509Z","caller":"traceutil/trace.go:171","msg":"trace[1907547502] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"780.705238ms","start":"2026-04-21T17:27:15.999787Z","end":"2026-04-21T17:27:16.780492Z","steps":["trace[1907547502] 'agreement among raft nodes before linearized reading' (duration: 780.535864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:16.780576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:15.999756Z","time spent":"780.81423ms","remote":"127.0.0.1:47766","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-21T17:27:17.817851Z","caller":"traceutil/trace.go:171","msg":"trace[2045046484] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"513.998431ms","start":"2026-04-21T17:27:17.303804Z","end":"2026-04-21T17:27:17.817802Z","steps":["trace[2045046484] 'process raft request' (duration: 494.90117ms)","trace[2045046484] 'compare' (duration: 18.783705ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:27:17.818071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:17.303771Z","time spent":"514.181884ms","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:27:17.820172Z","caller":"traceutil/trace.go:171","msg":"trace[1484678168] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"458.71422ms","start":"2026-04-21T17:27:17.361361Z","end":"2026-04-21T17:27:17.820075Z","steps":["trace[1484678168] 'process raft request' (duration: 457.320092ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:17.820278Z","caller":"traceutil/trace.go:171","msg":"trace[528457954] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"326.754163ms","start":"2026-04-21T17:27:17.493268Z","end":"2026-04-21T17:27:17.820022Z","steps":["trace[528457954] 'process raft request' (duration: 326.483428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:17.820393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:17.493234Z","time spent":"327.09589ms","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:27:17.820677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:17.361325Z","time spent":"458.935994ms","remote":"127.0.0.1:47514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:27:18.017777Z","caller":"traceutil/trace.go:171","msg":"trace[1735275050] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"167.418642ms","start":"2026-04-21T17:27:17.850322Z","end":"2026-04-21T17:27:18.017741Z","steps":["trace[1735275050] 'process raft request' (duration: 78.3877ms)","trace[1735275050] 'compare' (duration: 88.688856ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:27:18.089229Z","caller":"traceutil/trace.go:171","msg":"trace[1805634321] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"158.030163ms","start":"2026-04-21T17:27:17.931176Z","end":"2026-04-21T17:27:18.089206Z","steps":["trace[1805634321] 'process raft request' (duration: 156.34939ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:18.212961Z","caller":"traceutil/trace.go:171","msg":"trace[1319007224] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"188.56474ms","start":"2026-04-21T17:27:18.024377Z","end":"2026-04-21T17:27:18.212942Z","steps":["trace[1319007224] 'process raft request' (duration: 182.104356ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:18.213143Z","caller":"traceutil/trace.go:171","msg":"trace[1832661289] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"171.945591ms","start":"2026-04-21T17:27:18.041192Z","end":"2026-04-21T17:27:18.213137Z","steps":["trace[1832661289] 'process raft request' (duration: 171.691906ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:18.363925Z","caller":"traceutil/trace.go:171","msg":"trace[753126754] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"123.684672ms","start":"2026-04-21T17:27:18.240221Z","end":"2026-04-21T17:27:18.363906Z","steps":["trace[753126754] 'process raft request' (duration: 123.601ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:18.363978Z","caller":"traceutil/trace.go:171","msg":"trace[1254987879] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"126.706409ms","start":"2026-04-21T17:27:18.237234Z","end":"2026-04-21T17:27:18.363941Z","steps":["trace[1254987879] 'process raft request' (duration: 84.587638ms)","trace[1254987879] 'compare' (duration: 41.708143ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:27:18.552822Z","caller":"traceutil/trace.go:171","msg":"trace[1547661714] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:597; }","duration":"142.470442ms","start":"2026-04-21T17:27:18.410295Z","end":"2026-04-21T17:27:18.552766Z","steps":["trace[1547661714] 'read index received' (duration: 17.332574ms)","trace[1547661714] 'applied index is now lower than readState.Index' (duration: 125.136848ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:27:18.552921Z","caller":"traceutil/trace.go:171","msg":"trace[374497135] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"149.756753ms","start":"2026-04-21T17:27:18.40312Z","end":"2026-04-21T17:27:18.552877Z","steps":["trace[374497135] 'process raft request' (duration: 149.173132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:18.553024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.713157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-04-21T17:27:18.55307Z","caller":"traceutil/trace.go:171","msg":"trace[402504833] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:580; }","duration":"142.83126ms","start":"2026-04-21T17:27:18.410227Z","end":"2026-04-21T17:27:18.553058Z","steps":["trace[402504833] 'agreement among raft nodes before linearized reading' (duration: 142.675317ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:18.807669Z","caller":"traceutil/trace.go:171","msg":"trace[280466796] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"206.412954ms","start":"2026-04-21T17:27:18.601238Z","end":"2026-04-21T17:27:18.807651Z","steps":["trace[280466796] 'process raft request' (duration: 139.534996ms)","trace[280466796] 'compare' (duration: 66.713675ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:27:18.807662Z","caller":"traceutil/trace.go:171","msg":"trace[1906150839] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"200.4669ms","start":"2026-04-21T17:27:18.607157Z","end":"2026-04-21T17:27:18.807624Z","steps":["trace[1906150839] 'read index received' (duration: 133.552441ms)","trace[1906150839] 'applied index is now lower than readState.Index' (duration: 66.913468ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:27:18.807947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.687574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-04-21T17:27:18.808002Z","caller":"traceutil/trace.go:171","msg":"trace[475253911] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:581; }","duration":"200.866747ms","start":"2026-04-21T17:27:18.607123Z","end":"2026-04-21T17:27:18.807989Z","steps":["trace[475253911] 'agreement among raft nodes before linearized reading' (duration: 200.589542ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:18.811871Z","caller":"traceutil/trace.go:171","msg":"trace[2117508017] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"190.212422ms","start":"2026-04-21T17:27:18.621633Z","end":"2026-04-21T17:27:18.811845Z","steps":["trace[2117508017] 'process raft request' (duration: 186.784037ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:19.030683Z","caller":"traceutil/trace.go:171","msg":"trace[1629216656] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"128.698765ms","start":"2026-04-21T17:27:18.901942Z","end":"2026-04-21T17:27:19.030641Z","steps":["trace[1629216656] 'process raft request' (duration: 33.451744ms)","trace[1629216656] 'compare' (duration: 94.775272ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:27:19.031017Z","caller":"traceutil/trace.go:171","msg":"trace[1500705409] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"128.645203ms","start":"2026-04-21T17:27:18.902341Z","end":"2026-04-21T17:27:19.030986Z","steps":["trace[1500705409] 'process raft request' (duration: 128.551902ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:19.031192Z","caller":"traceutil/trace.go:171","msg":"trace[255702949] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:605; }","duration":"126.699916ms","start":"2026-04-21T17:27:18.904468Z","end":"2026-04-21T17:27:19.031168Z","steps":["trace[255702949] 'read index received' (duration: 30.829603ms)","trace[255702949] 'applied index is now lower than readState.Index' (duration: 95.868703ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:27:19.031399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.905589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-21T17:27:19.031455Z","caller":"traceutil/trace.go:171","msg":"trace[291576131] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:588; }","duration":"126.998052ms","start":"2026-04-21T17:27:18.904443Z","end":"2026-04-21T17:27:19.031441Z","steps":["trace[291576131] 'agreement among raft nodes before linearized reading' (duration: 126.796908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:23.804486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.399735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bn2k6\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-21T17:27:23.804681Z","caller":"traceutil/trace.go:171","msg":"trace[152484797] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bn2k6; range_end:; response_count:1; response_revision:618; }","duration":"650.659129ms","start":"2026-04-21T17:27:23.153994Z","end":"2026-04-21T17:27:23.804654Z","steps":["trace[152484797] 'range keys from in-memory index tree' (duration: 650.180001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:23.804738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:23.153975Z","time spent":"650.752002ms","remote":"127.0.0.1:47668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-bn2k6\" "} {"level":"info","ts":"2026-04-21T17:27:23.899224Z","caller":"traceutil/trace.go:171","msg":"trace[1167663208] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"134.607261ms","start":"2026-04-21T17:27:23.764595Z","end":"2026-04-21T17:27:23.899202Z","steps":["trace[1167663208] 'read index received' (duration: 133.833647ms)","trace[1167663208] 'applied index is now lower than readState.Index' (duration: 772.654µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:27:23.899348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.727994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:23.89932Z","caller":"traceutil/trace.go:171","msg":"trace[1714251726] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"436.28478ms","start":"2026-04-21T17:27:23.462998Z","end":"2026-04-21T17:27:23.899283Z","steps":["trace[1714251726] 'process raft request' (duration: 435.678879ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:23.899388Z","caller":"traceutil/trace.go:171","msg":"trace[1997425953] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"134.827405ms","start":"2026-04-21T17:27:23.764551Z","end":"2026-04-21T17:27:23.899378Z","steps":["trace[1997425953] 'agreement among raft nodes before linearized reading' (duration: 134.742743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:23.89962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:23.46297Z","time spent":"436.437483ms","remote":"127.0.0.1:47560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:27:24.122859Z","caller":"traceutil/trace.go:171","msg":"trace[133441428] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"304.238283ms","start":"2026-04-21T17:27:23.818596Z","end":"2026-04-21T17:27:24.122834Z","steps":["trace[133441428] 'process raft request' (duration: 303.979448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:24.123023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:23.818567Z","time spent":"304.368865ms","remote":"127.0.0.1:47668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:27:24.129142Z","caller":"traceutil/trace.go:171","msg":"trace[2012214059] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"173.111616ms","start":"2026-04-21T17:27:23.956011Z","end":"2026-04-21T17:27:24.129122Z","steps":["trace[2012214059] 'process raft request' (duration: 172.949653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.108546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.051633ms","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-21T17:27:25.108609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.783121ms","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-21T17:27:25.108675Z","caller":"traceutil/trace.go:171","msg":"trace[1368354401] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"918.268127ms","start":"2026-04-21T17:27:24.190376Z","end":"2026-04-21T17:27:25.108644Z","steps":["trace[1368354401] 'count revisions from in-memory index tree' (duration: 917.971602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.108743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.190362Z","time spent":"918.371129ms","remote":"127.0.0.1:43546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:27:25.108792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.187486ms","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":"info","ts":"2026-04-21T17:27:25.108836Z","caller":"traceutil/trace.go:171","msg":"trace[543705120] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"918.325269ms","start":"2026-04-21T17:27:24.1905Z","end":"2026-04-21T17:27:25.108825Z","steps":["trace[543705120] 'range keys from in-memory index tree' (duration: 918.062404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.108887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.190469Z","time spent":"918.40742ms","remote":"127.0.0.1:43546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:25.10881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.395429ms","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":"info","ts":"2026-04-21T17:27:25.109013Z","caller":"traceutil/trace.go:171","msg":"trace[2057386335] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:621; }","duration":"536.774556ms","start":"2026-04-21T17:27:24.572219Z","end":"2026-04-21T17:27:25.108993Z","steps":["trace[2057386335] 'range keys from in-memory index tree' (duration: 536.344658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.109094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.572214Z","time spent":"536.865077ms","remote":"127.0.0.1:43582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:27:25.109214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.041296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:25.109331Z","caller":"traceutil/trace.go:171","msg":"trace[775325677] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"861.23488ms","start":"2026-04-21T17:27:24.248073Z","end":"2026-04-21T17:27:25.109308Z","steps":["trace[775325677] 'range keys from in-memory index tree' (duration: 860.971635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.109391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.248062Z","time spent":"861.317542ms","remote":"127.0.0.1:43564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:25.109551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.718098ms","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":"info","ts":"2026-04-21T17:27:25.109637Z","caller":"traceutil/trace.go:171","msg":"trace[299492830] 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:621; }","duration":"841.81032ms","start":"2026-04-21T17:27:24.267809Z","end":"2026-04-21T17:27:25.109619Z","steps":["trace[299492830] 'range keys from in-memory index tree' (duration: 841.661307ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:25.108737Z","caller":"traceutil/trace.go:171","msg":"trace[997618785] 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:621; }","duration":"840.937554ms","start":"2026-04-21T17:27:24.267749Z","end":"2026-04-21T17:27:25.108687Z","steps":["trace[997618785] 'range keys from in-memory index tree' (duration: 840.650209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.109698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.267803Z","time spent":"841.882441ms","remote":"127.0.0.1:43570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"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-21T17:27:25.109826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.968827ms","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-21T17:27:25.109857Z","caller":"traceutil/trace.go:171","msg":"trace[518299448] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:621; }","duration":"538.041919ms","start":"2026-04-21T17:27:24.571806Z","end":"2026-04-21T17:27:25.109848Z","steps":["trace[518299448] 'range keys from in-memory index tree' (duration: 537.922536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.109883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.406953ms","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-21T17:27:25.109915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.57179Z","time spent":"538.08327ms","remote":"127.0.0.1:43582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:27:25.109924Z","caller":"traceutil/trace.go:171","msg":"trace[1770441430] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"888.463764ms","start":"2026-04-21T17:27:24.221448Z","end":"2026-04-21T17:27:25.109912Z","steps":["trace[1770441430] 'range keys from in-memory index tree' (duration: 888.317982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.109956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.221437Z","time spent":"888.510395ms","remote":"127.0.0.1:43556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:25.110088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.12037ms","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-21T17:27:25.110141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.536945ms","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":"info","ts":"2026-04-21T17:27:25.110175Z","caller":"traceutil/trace.go:171","msg":"trace[1365510041] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"888.587976ms","start":"2026-04-21T17:27:24.221579Z","end":"2026-04-21T17:27:25.110167Z","steps":["trace[1365510041] 'count revisions from in-memory index tree' (duration: 888.510365ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:25.110209Z","caller":"traceutil/trace.go:171","msg":"trace[1012309858] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:621; }","duration":"538.217142ms","start":"2026-04-21T17:27:24.571939Z","end":"2026-04-21T17:27:25.110156Z","steps":["trace[1012309858] 'count revisions from in-memory index tree' (duration: 538.0966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.109756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.267735Z","time spent":"841.981053ms","remote":"127.0.0.1:43570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"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-21T17:27:25.110299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.221574Z","time spent":"888.617296ms","remote":"127.0.0.1:43556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:27:25.110282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.571936Z","time spent":"538.328324ms","remote":"127.0.0.1:43582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:27:25.110455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.589748ms","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-21T17:27:25.110509Z","caller":"traceutil/trace.go:171","msg":"trace[1228477496] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"887.638269ms","start":"2026-04-21T17:27:24.222839Z","end":"2026-04-21T17:27:25.110478Z","steps":["trace[1228477496] 'range keys from in-memory index tree' (duration: 887.521127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.110541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.222832Z","time spent":"887.699211ms","remote":"127.0.0.1:43546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:27:25.110762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.243018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:25.110848Z","caller":"traceutil/trace.go:171","msg":"trace[1733958152] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"862.37441ms","start":"2026-04-21T17:27:24.248462Z","end":"2026-04-21T17:27:25.110836Z","steps":["trace[1733958152] 'range keys from in-memory index tree' (duration: 862.122235ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.110895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.105103ms","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":"info","ts":"2026-04-21T17:27:25.110987Z","caller":"traceutil/trace.go:171","msg":"trace[1234805386] 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:621; }","duration":"843.227676ms","start":"2026-04-21T17:27:24.267746Z","end":"2026-04-21T17:27:25.110973Z","steps":["trace[1234805386] 'count revisions from in-memory index tree' (duration: 843.035562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.111031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.267738Z","time spent":"843.268426ms","remote":"127.0.0.1:43570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"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-21T17:27:25.111088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.757057ms","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":"warn","ts":"2026-04-21T17:27:25.111046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.248437Z","time spent":"862.588044ms","remote":"127.0.0.1:43564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-04-21T17:27:25.111127Z","caller":"traceutil/trace.go:171","msg":"trace[1650751922] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"862.827799ms","start":"2026-04-21T17:27:24.248287Z","end":"2026-04-21T17:27:25.111114Z","steps":["trace[1650751922] 'count revisions from in-memory index tree' (duration: 862.649335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.111385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.248268Z","time spent":"863.101095ms","remote":"127.0.0.1:43564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:27:25.146017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.614616ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-21T17:27:25.146501Z","caller":"traceutil/trace.go:171","msg":"trace[2029637472] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"393.712788ms","start":"2026-04-21T17:27:24.752758Z","end":"2026-04-21T17:27:25.14647Z","steps":["trace[2029637472] 'read index received' (duration: 261.638904ms)","trace[2029637472] 'applied index is now lower than readState.Index' (duration: 132.072154ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:27:25.146728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.926562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:25.146841Z","caller":"traceutil/trace.go:171","msg":"trace[938590856] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:621; }","duration":"394.080645ms","start":"2026-04-21T17:27:24.752734Z","end":"2026-04-21T17:27:25.146814Z","steps":["trace[938590856] 'agreement among raft nodes before linearized reading' (duration: 393.877522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.146958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.752713Z","time spent":"394.187477ms","remote":"127.0.0.1:43594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:27:25.147078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.237338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:25.147135Z","caller":"traceutil/trace.go:171","msg":"trace[520031033] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"394.35127ms","start":"2026-04-21T17:27:24.752767Z","end":"2026-04-21T17:27:25.147118Z","steps":["trace[520031033] 'agreement among raft nodes before linearized reading' (duration: 394.249968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.752741Z","time spent":"394.430302ms","remote":"127.0.0.1:43594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:25.147206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.849433ms","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-21T17:27:25.147212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.481296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:25.147259Z","caller":"traceutil/trace.go:171","msg":"trace[1399787877] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"135.915875ms","start":"2026-04-21T17:27:25.011321Z","end":"2026-04-21T17:27:25.147237Z","steps":["trace[1399787877] 'agreement among raft nodes before linearized reading' (duration: 135.830983ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:25.147277Z","caller":"traceutil/trace.go:171","msg":"trace[618253064] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"265.597038ms","start":"2026-04-21T17:27:24.881667Z","end":"2026-04-21T17:27:25.147264Z","steps":["trace[618253064] 'agreement among raft nodes before linearized reading' (duration: 265.481166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.737617ms","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-21T17:27:25.147334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.713419ms","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-21T17:27:25.147351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.464417ms","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-21T17:27:25.147387Z","caller":"traceutil/trace.go:171","msg":"trace[1609611049] 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:622; }","duration":"241.951101ms","start":"2026-04-21T17:27:24.905391Z","end":"2026-04-21T17:27:25.147342Z","steps":["trace[1609611049] 'agreement among raft nodes before linearized reading' (duration: 241.745457ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:25.147401Z","caller":"traceutil/trace.go:171","msg":"trace[1124735529] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:622; }","duration":"218.798142ms","start":"2026-04-21T17:27:24.928585Z","end":"2026-04-21T17:27:25.147383Z","steps":["trace[1124735529] 'agreement among raft nodes before linearized reading' (duration: 218.69726ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:25.147439Z","caller":"traceutil/trace.go:171","msg":"trace[1370122922] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"299.601929ms","start":"2026-04-21T17:27:24.847813Z","end":"2026-04-21T17:27:25.147415Z","steps":["trace[1370122922] 'agreement among raft nodes before linearized reading' (duration: 299.364255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.082103ms","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-21T17:27:25.147502Z","caller":"traceutil/trace.go:171","msg":"trace[1222816598] 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:622; }","duration":"242.146994ms","start":"2026-04-21T17:27:24.905347Z","end":"2026-04-21T17:27:25.147494Z","steps":["trace[1222816598] 'agreement among raft nodes before linearized reading' (duration: 242.095633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.14759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.758942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:25.147616Z","caller":"traceutil/trace.go:171","msg":"trace[1290205610] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"265.808314ms","start":"2026-04-21T17:27:24.881799Z","end":"2026-04-21T17:27:25.147607Z","steps":["trace[1290205610] 'agreement among raft nodes before linearized reading' (duration: 265.767143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.940931ms","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":"warn","ts":"2026-04-21T17:27:25.147759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.037447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:25.14777Z","caller":"traceutil/trace.go:171","msg":"trace[418261063] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:622; }","duration":"173.041813ms","start":"2026-04-21T17:27:24.974711Z","end":"2026-04-21T17:27:25.147753Z","steps":["trace[418261063] 'agreement among raft nodes before linearized reading' (duration: 172.947502ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:25.1478Z","caller":"traceutil/trace.go:171","msg":"trace[2035195303] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"266.079768ms","start":"2026-04-21T17:27:24.881713Z","end":"2026-04-21T17:27:25.147792Z","steps":["trace[2035195303] 'agreement among raft nodes before linearized reading' (duration: 266.017557ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:25.147796Z","caller":"traceutil/trace.go:171","msg":"trace[405455369] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"384.527259ms","start":"2026-04-21T17:27:24.763255Z","end":"2026-04-21T17:27:25.147783Z","steps":["trace[405455369] 'process raft request' (duration: 383.037251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.502375ms","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-21T17:27:25.147905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.251132ms","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-21T17:27:25.147934Z","caller":"traceutil/trace.go:171","msg":"trace[1363523932] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:622; }","duration":"219.622547ms","start":"2026-04-21T17:27:24.928271Z","end":"2026-04-21T17:27:25.147893Z","steps":["trace[1363523932] 'agreement among raft nodes before linearized reading' (duration: 219.530515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.763229Z","time spent":"384.615ms","remote":"127.0.0.1:47560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:27:25.147955Z","caller":"traceutil/trace.go:171","msg":"trace[655522595] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"104.327074ms","start":"2026-04-21T17:27:25.043612Z","end":"2026-04-21T17:27:25.147939Z","steps":["trace[655522595] 'agreement among raft nodes before linearized reading' (duration: 104.263262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.292196ms","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-21T17:27:25.148065Z","caller":"traceutil/trace.go:171","msg":"trace[981752663] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:622; }","duration":"174.390169ms","start":"2026-04-21T17:27:24.973666Z","end":"2026-04-21T17:27:25.148056Z","steps":["trace[981752663] 'agreement among raft nodes before linearized reading' (duration: 174.298657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.056683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T17:27:25.148195Z","caller":"traceutil/trace.go:171","msg":"trace[11286700] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"290.562012ms","start":"2026-04-21T17:27:24.857625Z","end":"2026-04-21T17:27:25.148187Z","steps":["trace[11286700] 'agreement among raft nodes before linearized reading' (duration: 289.981092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.160008ms","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-21T17:27:25.148331Z","caller":"traceutil/trace.go:171","msg":"trace[1571401001] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:622; }","duration":"219.774909ms","start":"2026-04-21T17:27:24.928546Z","end":"2026-04-21T17:27:25.148321Z","steps":["trace[1571401001] 'agreement among raft nodes before linearized reading' (duration: 219.135918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.148424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.502096ms","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-21T17:27:25.14738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.776754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:25.1485Z","caller":"traceutil/trace.go:171","msg":"trace[1039157303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"383.895516ms","start":"2026-04-21T17:27:24.764595Z","end":"2026-04-21T17:27:25.148491Z","steps":["trace[1039157303] 'agreement among raft nodes before linearized reading' (duration: 382.760384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.148561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:24.76455Z","time spent":"383.998358ms","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T17:27:25.148466Z","caller":"traceutil/trace.go:171","msg":"trace[1299338958] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"104.546687ms","start":"2026-04-21T17:27:25.043909Z","end":"2026-04-21T17:27:25.148456Z","steps":["trace[1299338958] 'agreement among raft nodes before linearized reading' (duration: 104.485696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.14874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.290131ms","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-21T17:27:25.148775Z","caller":"traceutil/trace.go:171","msg":"trace[2031445428] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"105.360793ms","start":"2026-04-21T17:27:25.043406Z","end":"2026-04-21T17:27:25.148767Z","steps":["trace[2031445428] 'agreement among raft nodes before linearized reading' (duration: 105.306972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.148814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.368762ms","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-21T17:27:25.148857Z","caller":"traceutil/trace.go:171","msg":"trace[193963558] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"137.444993ms","start":"2026-04-21T17:27:25.011402Z","end":"2026-04-21T17:27:25.148847Z","steps":["trace[193963558] 'agreement among raft nodes before linearized reading' (duration: 137.381542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.147947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.221166ms","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-21T17:27:25.149008Z","caller":"traceutil/trace.go:171","msg":"trace[784953012] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:622; }","duration":"175.294705ms","start":"2026-04-21T17:27:24.973702Z","end":"2026-04-21T17:27:25.148997Z","steps":["trace[784953012] 'agreement among raft nodes before linearized reading' (duration: 174.217525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.148262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.004712ms","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":"info","ts":"2026-04-21T17:27:25.14926Z","caller":"traceutil/trace.go:171","msg":"trace[2029180865] 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:622; }","duration":"242.97899ms","start":"2026-04-21T17:27:24.906241Z","end":"2026-04-21T17:27:25.14922Z","steps":["trace[2029180865] 'agreement among raft nodes before linearized reading' (duration: 241.91461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:25.815786Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422004054809873,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:27:27.480766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.468242746s","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-21T17:27:27.480891Z","caller":"traceutil/trace.go:171","msg":"trace[505612890] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:622; }","duration":"1.468379689s","start":"2026-04-21T17:27:26.012493Z","end":"2026-04-21T17:27:27.480873Z","steps":["trace[505612890] 'range keys from in-memory index tree' (duration: 1.468227546s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.481115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.55157888s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:27:27.481358Z","caller":"traceutil/trace.go:171","msg":"trace[1646004955] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"2.327089355s","start":"2026-04-21T17:27:25.154245Z","end":"2026-04-21T17:27:27.481335Z","steps":["trace[1646004955] 'process raft request' (duration: 775.204588ms)","trace[1646004955] 'compare' (duration: 1.551058541s)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:27:27.481465Z","caller":"traceutil/trace.go:171","msg":"trace[110952362] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:643; }","duration":"2.166663408s","start":"2026-04-21T17:27:25.314784Z","end":"2026-04-21T17:27:27.481447Z","steps":["trace[110952362] 'read index received' (duration: 614.671769ms)","trace[110952362] 'applied index is now lower than readState.Index' (duration: 1.551990439s)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:27:27.481741Z","caller":"traceutil/trace.go:171","msg":"trace[723095718] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"2.324866064s","start":"2026-04-21T17:27:25.156859Z","end":"2026-04-21T17:27:27.481725Z","steps":["trace[723095718] 'process raft request' (duration: 2.324353215s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.481839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.156827Z","time spent":"2.324962745s","remote":"127.0.0.1:47766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:27:27.48197Z","caller":"traceutil/trace.go:171","msg":"trace[1213918178] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"2.258716084s","start":"2026-04-21T17:27:25.223239Z","end":"2026-04-21T17:27:27.481955Z","steps":["trace[1213918178] 'process raft request' (duration: 2.258153114s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:27.481982Z","caller":"traceutil/trace.go:171","msg":"trace[56960587] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"2.30895501s","start":"2026-04-21T17:27:25.173016Z","end":"2026-04-21T17:27:27.481971Z","steps":["trace[56960587] 'process raft request' (duration: 2.308325459s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:27.482014Z","caller":"traceutil/trace.go:171","msg":"trace[1871067792] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"2.309084003s","start":"2026-04-21T17:27:25.172918Z","end":"2026-04-21T17:27:27.482002Z","steps":["trace[1871067792] 'process raft request' (duration: 2.30837167s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.223029Z","time spent":"2.2589747s","remote":"127.0.0.1:47982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:27:27.482096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.172893Z","time spent":"2.309164514s","remote":"127.0.0.1:47766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:27:27.482095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.1673009s","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-21T17:27:27.482107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.17301Z","time spent":"2.309023061s","remote":"127.0.0.1:47766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:27:27.482147Z","caller":"traceutil/trace.go:171","msg":"trace[847941879] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"2.167378101s","start":"2026-04-21T17:27:25.31475Z","end":"2026-04-21T17:27:27.482128Z","steps":["trace[847941879] 'agreement among raft nodes before linearized reading' (duration: 2.16730086s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.314731Z","time spent":"2.167447912s","remote":"127.0.0.1:43688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:27:27.482305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.167417462s","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":"info","ts":"2026-04-21T17:27:27.482368Z","caller":"traceutil/trace.go:171","msg":"trace[353332383] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"2.167512123s","start":"2026-04-21T17:27:25.314845Z","end":"2026-04-21T17:27:27.482357Z","steps":["trace[353332383] 'agreement among raft nodes before linearized reading' (duration: 2.167388111s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.314809Z","time spent":"2.167599995s","remote":"127.0.0.1:43688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:27.4824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.912645965s","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-21T17:27:27.482478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.85378961s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:27.482503Z","caller":"traceutil/trace.go:171","msg":"trace[1222335307] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"1.912820118s","start":"2026-04-21T17:27:25.569655Z","end":"2026-04-21T17:27:27.482475Z","steps":["trace[1222335307] 'agreement among raft nodes before linearized reading' (duration: 1.912601164s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.71642708s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:27:27.482563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.91290944s","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":"warn","ts":"2026-04-21T17:27:27.482565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.569634Z","time spent":"1.912916981s","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:27:27.482583Z","caller":"traceutil/trace.go:171","msg":"trace[846603427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"1.716498891s","start":"2026-04-21T17:27:25.766077Z","end":"2026-04-21T17:27:27.482576Z","steps":["trace[846603427] 'agreement among raft nodes before linearized reading' (duration: 1.71645951s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:27.482595Z","caller":"traceutil/trace.go:171","msg":"trace[1443816625] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"1.912981851s","start":"2026-04-21T17:27:25.569604Z","end":"2026-04-21T17:27:27.482586Z","steps":["trace[1443816625] 'agreement among raft nodes before linearized reading' (duration: 1.91289703s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.854558334s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:27:27.482614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.766031Z","time spent":"1.716577052s","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T17:27:27.482627Z","caller":"traceutil/trace.go:171","msg":"trace[706786231] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"1.854596845s","start":"2026-04-21T17:27:25.628022Z","end":"2026-04-21T17:27:27.482619Z","steps":["trace[706786231] 'agreement among raft nodes before linearized reading' (duration: 1.854538274s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.893690716s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:27:27.482639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.872102648s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:27:27.482652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.628017Z","time spent":"1.854629985s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:27:27.482652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.569601Z","time spent":"1.913013992s","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"info","ts":"2026-04-21T17:27:27.482672Z","caller":"traceutil/trace.go:171","msg":"trace[1276235289] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:627; }","duration":"1.89386106s","start":"2026-04-21T17:27:25.588797Z","end":"2026-04-21T17:27:27.482658Z","steps":["trace[1276235289] 'agreement among raft nodes before linearized reading' (duration: 1.893635655s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:27.482681Z","caller":"traceutil/trace.go:171","msg":"trace[289815224] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"1.872148189s","start":"2026-04-21T17:27:25.610517Z","end":"2026-04-21T17:27:27.482665Z","steps":["trace[289815224] 'agreement among raft nodes before linearized reading' (duration: 1.872086248s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.61049Z","time spent":"1.87222409s","remote":"127.0.0.1:43732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:27.482723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.588791Z","time spent":"1.89391625s","remote":"127.0.0.1:43716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:27:27.482743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.913175435s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:27.482764Z","caller":"traceutil/trace.go:171","msg":"trace[1198136995] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"1.913225366s","start":"2026-04-21T17:27:25.569532Z","end":"2026-04-21T17:27:27.482757Z","steps":["trace[1198136995] 'agreement among raft nodes before linearized reading' (duration: 1.913184376s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.569511Z","time spent":"1.913267217s","remote":"127.0.0.1:43704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:27.482821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.854811789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:27.482516Z","caller":"traceutil/trace.go:171","msg":"trace[2076890804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"1.853840342s","start":"2026-04-21T17:27:25.628664Z","end":"2026-04-21T17:27:27.482504Z","steps":["trace[2076890804] 'agreement among raft nodes before linearized reading' (duration: 1.853782791s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:27.482841Z","caller":"traceutil/trace.go:171","msg":"trace[315460943] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"1.85484692s","start":"2026-04-21T17:27:25.627989Z","end":"2026-04-21T17:27:27.482836Z","steps":["trace[315460943] 'agreement among raft nodes before linearized reading' (duration: 1.854815459s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.62798Z","time spent":"1.85487777s","remote":"127.0.0.1:43736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:27.482864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.628657Z","time spent":"1.854194818s","remote":"127.0.0.1:43732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:27:27.48287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.89449231s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:27.48291Z","caller":"traceutil/trace.go:171","msg":"trace[651853690] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:627; }","duration":"1.894541492s","start":"2026-04-21T17:27:25.588356Z","end":"2026-04-21T17:27:27.482898Z","steps":["trace[651853690] 'agreement among raft nodes before linearized reading' (duration: 1.894480651s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.09246516s","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-21T17:27:27.482944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.588352Z","time spent":"1.894583072s","remote":"127.0.0.1:43716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:27.482951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.894606543s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:27.482962Z","caller":"traceutil/trace.go:171","msg":"trace[1178518330] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:627; }","duration":"2.092547212s","start":"2026-04-21T17:27:25.390406Z","end":"2026-04-21T17:27:27.482953Z","steps":["trace[1178518330] 'agreement among raft nodes before linearized reading' (duration: 2.092496841s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:27.48298Z","caller":"traceutil/trace.go:171","msg":"trace[1900734585] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:627; }","duration":"1.894646963s","start":"2026-04-21T17:27:25.588323Z","end":"2026-04-21T17:27:27.48297Z","steps":["trace[1900734585] 'agreement among raft nodes before linearized reading' (duration: 1.894604562s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.482988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.390393Z","time spent":"2.092587252s","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:27.482978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.154175297s","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":"warn","ts":"2026-04-21T17:27:27.483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.167660717s","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":"warn","ts":"2026-04-21T17:27:27.483009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.588315Z","time spent":"1.894685874s","remote":"127.0.0.1:43716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:27:27.483027Z","caller":"traceutil/trace.go:171","msg":"trace[1622990288] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"2.167692707s","start":"2026-04-21T17:27:25.315321Z","end":"2026-04-21T17:27:27.483014Z","steps":["trace[1622990288] 'agreement among raft nodes before linearized reading' (duration: 2.167661066s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:27.483023Z","caller":"traceutil/trace.go:171","msg":"trace[484373097] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:627; }","duration":"2.154233928s","start":"2026-04-21T17:27:25.328776Z","end":"2026-04-21T17:27:27.48301Z","steps":["trace[484373097] 'agreement among raft nodes before linearized reading' (duration: 2.154163237s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.483046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.315316Z","time spent":"2.167725717s","remote":"127.0.0.1:43688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:27:27.483079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.328769Z","time spent":"2.15428242s","remote":"127.0.0.1:43694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"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-21T17:27:27.483099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.093356986s","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-21T17:27:27.483112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.154464352s","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-21T17:27:27.483126Z","caller":"traceutil/trace.go:171","msg":"trace[549632966] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:627; }","duration":"2.093395507s","start":"2026-04-21T17:27:25.389721Z","end":"2026-04-21T17:27:27.483116Z","steps":["trace[549632966] 'agreement among raft nodes before linearized reading' (duration: 2.093352446s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:27:27.483135Z","caller":"traceutil/trace.go:171","msg":"trace[929882223] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:627; }","duration":"2.154509003s","start":"2026-04-21T17:27:25.328619Z","end":"2026-04-21T17:27:27.483128Z","steps":["trace[929882223] 'agreement among raft nodes before linearized reading' (duration: 2.154471402s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.483157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.328607Z","time spent":"2.154544954s","remote":"127.0.0.1:43694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:27:27.483153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.389713Z","time spent":"2.093432927s","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:27:27.483193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.093240214s","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-21T17:27:27.483227Z","caller":"traceutil/trace.go:171","msg":"trace[526240500] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:627; }","duration":"2.093278405s","start":"2026-04-21T17:27:25.389941Z","end":"2026-04-21T17:27:27.483219Z","steps":["trace[526240500] 'agreement among raft nodes before linearized reading' (duration: 2.093230344s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.483257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.38993Z","time spent":"2.093317815s","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:27:27.483327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.153696817s","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-21T17:27:27.483389Z","caller":"traceutil/trace.go:171","msg":"trace[1975337207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:627; }","duration":"2.15376258s","start":"2026-04-21T17:27:25.329599Z","end":"2026-04-21T17:27:27.483362Z","steps":["trace[1975337207] 'agreement among raft nodes before linearized reading' (duration: 2.153682939s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.483431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.329592Z","time spent":"2.153825381s","remote":"127.0.0.1:43694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:27:27.483452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.154232Z","time spent":"2.327193576s","remote":"127.0.0.1:47766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:27:27.48241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.871757102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:27:27.483603Z","caller":"traceutil/trace.go:171","msg":"trace[844051053] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:627; }","duration":"1.872974273s","start":"2026-04-21T17:27:25.610617Z","end":"2026-04-21T17:27:27.483591Z","steps":["trace[844051053] 'agreement among raft nodes before linearized reading' (duration: 1.871756591s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:27.483686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:25.61061Z","time spent":"1.873057955s","remote":"127.0.0.1:43732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:27:43.804978Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422004054810187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:27:44.306019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986422004054810187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:27:44.510265Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.266385543s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:27:44.510658Z","caller":"traceutil/trace.go:171","msg":"trace[293808657] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:812; }","duration":"1.20621842s","start":"2026-04-21T17:27:43.304416Z","end":"2026-04-21T17:27:44.510634Z","steps":["trace[293808657] 'read index received' (duration: 1.206010536s)","trace[293808657] 'applied index is now lower than readState.Index' (duration: 206.944µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:27:44.510793Z","caller":"traceutil/trace.go:171","msg":"trace[1873081155] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"1.267005894s","start":"2026-04-21T17:27:43.243758Z","end":"2026-04-21T17:27:44.510764Z","steps":["trace[1873081155] 'process raft request' (duration: 1.2667511s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:44.510907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206475374s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lq2hd\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-21T17:27:44.510959Z","caller":"traceutil/trace.go:171","msg":"trace[1258096593] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lq2hd; range_end:; response_count:1; response_revision:788; }","duration":"1.206567835s","start":"2026-04-21T17:27:43.30437Z","end":"2026-04-21T17:27:44.510938Z","steps":["trace[1258096593] 'agreement among raft nodes before linearized reading' (duration: 1.206378082s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:44.510961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:43.243735Z","time spent":"1.267133827s","remote":"127.0.0.1:47766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:27:44.510994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:43.304354Z","time spent":"1.206631787s","remote":"127.0.0.1:47668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lq2hd\" "} {"level":"warn","ts":"2026-04-21T17:27:44.511074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.631938ms","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-21T17:27:44.51114Z","caller":"traceutil/trace.go:171","msg":"trace[24273821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:788; }","duration":"879.72939ms","start":"2026-04-21T17:27:43.631396Z","end":"2026-04-21T17:27:44.511125Z","steps":["trace[24273821] 'agreement among raft nodes before linearized reading' (duration: 879.564417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:44.511116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.059679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:27:44.51118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:43.631389Z","time spent":"879.784881ms","remote":"127.0.0.1:47766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T17:27:44.5112Z","caller":"traceutil/trace.go:171","msg":"trace[637361408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:788; }","duration":"746.203452ms","start":"2026-04-21T17:27:43.764978Z","end":"2026-04-21T17:27:44.511181Z","steps":["trace[637361408] 'agreement among raft nodes before linearized reading' (duration: 746.05895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:44.511266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:43.764957Z","time spent":"746.299853ms","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:27:44.511296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.691613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T17:27:44.511313Z","caller":"traceutil/trace.go:171","msg":"trace[971653077] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:788; }","duration":"881.745104ms","start":"2026-04-21T17:27:43.629562Z","end":"2026-04-21T17:27:44.511307Z","steps":["trace[971653077] 'agreement among raft nodes before linearized reading' (duration: 881.694503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:44.511336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:43.629543Z","time spent":"881.787304ms","remote":"127.0.0.1:47766","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-21T17:27:44.511369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.152196ms","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-21T17:27:44.511529Z","caller":"traceutil/trace.go:171","msg":"trace[71129446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:788; }","duration":"880.40181ms","start":"2026-04-21T17:27:43.631107Z","end":"2026-04-21T17:27:44.511509Z","steps":["trace[71129446] 'agreement among raft nodes before linearized reading' (duration: 879.957293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:44.511628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:43.631096Z","time spent":"880.516723ms","remote":"127.0.0.1:47766","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-21T17:27:44.5115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.53867ms","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-21T17:27:44.511765Z","caller":"traceutil/trace.go:171","msg":"trace[1324683830] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:788; }","duration":"890.840245ms","start":"2026-04-21T17:27:43.620917Z","end":"2026-04-21T17:27:44.511757Z","steps":["trace[1324683830] 'agreement among raft nodes before linearized reading' (duration: 889.948271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:27:44.511818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:27:43.620894Z","time spent":"890.915746ms","remote":"127.0.0.1:47766","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-21T17:29:09.933237Z","caller":"traceutil/trace.go:171","msg":"trace[460560840] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"106.492077ms","start":"2026-04-21T17:29:09.82671Z","end":"2026-04-21T17:29:09.933202Z","steps":["trace[460560840] 'process raft request' (duration: 106.285275ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:29:25.935278Z","caller":"traceutil/trace.go:171","msg":"trace[904551711] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"114.340081ms","start":"2026-04-21T17:29:25.820901Z","end":"2026-04-21T17:29:25.935241Z","steps":["trace[904551711] 'process raft request' (duration: 114.20569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:26.228739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.927602ms","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-21T17:29:26.228892Z","caller":"traceutil/trace.go:171","msg":"trace[1152806661] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1269; }","duration":"216.099214ms","start":"2026-04-21T17:29:26.01277Z","end":"2026-04-21T17:29:26.228869Z","steps":["trace[1152806661] 'range keys from in-memory index tree' (duration: 215.906612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:26.22893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.414876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:29:26.229556Z","caller":"traceutil/trace.go:171","msg":"trace[801172525] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"210.388403ms","start":"2026-04-21T17:29:26.019117Z","end":"2026-04-21T17:29:26.229505Z","steps":["trace[801172525] 'process raft request' (duration: 56.305489ms)","trace[801172525] 'compare' (duration: 153.158933ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:29:26.229657Z","caller":"traceutil/trace.go:171","msg":"trace[2050570740] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1319; }","duration":"121.307807ms","start":"2026-04-21T17:29:26.10833Z","end":"2026-04-21T17:29:26.229637Z","steps":["trace[2050570740] 'read index received' (duration: 118.105447ms)","trace[2050570740] 'applied index is now lower than readState.Index' (duration: 3.20137ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:29:26.229729Z","caller":"traceutil/trace.go:171","msg":"trace[1015990632] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"210.513054ms","start":"2026-04-21T17:29:26.01919Z","end":"2026-04-21T17:29:26.229703Z","steps":["trace[1015990632] 'process raft request' (duration: 210.13454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:26.2298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.398287ms","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":"info","ts":"2026-04-21T17:29:26.229866Z","caller":"traceutil/trace.go:171","msg":"trace[516822056] 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:1271; }","duration":"121.58522ms","start":"2026-04-21T17:29:26.108269Z","end":"2026-04-21T17:29:26.229855Z","steps":["trace[516822056] 'agreement among raft nodes before linearized reading' (duration: 121.418488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:39.689022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.327339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T17:29:39.689123Z","caller":"traceutil/trace.go:171","msg":"trace[1495778592] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1333; }","duration":"276.476541ms","start":"2026-04-21T17:29:39.412621Z","end":"2026-04-21T17:29:39.689098Z","steps":["trace[1495778592] 'range keys from in-memory index tree' (duration: 276.160117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:39.689153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.320168ms","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-21T17:29:39.68925Z","caller":"traceutil/trace.go:171","msg":"trace[949144114] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1333; }","duration":"339.43239ms","start":"2026-04-21T17:29:39.349804Z","end":"2026-04-21T17:29:39.689236Z","steps":["trace[949144114] 'range keys from in-memory index tree' (duration: 339.230648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:39.689327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.197854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-21T17:29:39.689398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:29:39.349789Z","time spent":"339.595592ms","remote":"127.0.0.1:47766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-21T17:29:39.689431Z","caller":"traceutil/trace.go:171","msg":"trace[1471867972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1333; }","duration":"324.313185ms","start":"2026-04-21T17:29:39.365094Z","end":"2026-04-21T17:29:39.689407Z","steps":["trace[1471867972] 'range keys from in-memory index tree' (duration: 324.054033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:39.689484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:29:39.365068Z","time spent":"324.402547ms","remote":"127.0.0.1:47766","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-21T17:29:39.689043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.743856ms","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-21T17:29:39.689618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.773097ms","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-21T17:29:39.689638Z","caller":"traceutil/trace.go:171","msg":"trace[1271374200] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1333; }","duration":"269.371114ms","start":"2026-04-21T17:29:39.420252Z","end":"2026-04-21T17:29:39.689624Z","steps":["trace[1271374200] 'range keys from in-memory index tree' (duration: 268.640145ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:29:39.689654Z","caller":"traceutil/trace.go:171","msg":"trace[846597533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1333; }","duration":"264.825327ms","start":"2026-04-21T17:29:39.424818Z","end":"2026-04-21T17:29:39.689643Z","steps":["trace[846597533] 'range keys from in-memory index tree' (duration: 264.682156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:39.68978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.299176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:29:39.689828Z","caller":"traceutil/trace.go:171","msg":"trace[133301769] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1333; }","duration":"194.344586ms","start":"2026-04-21T17:29:39.495463Z","end":"2026-04-21T17:29:39.689808Z","steps":["trace[133301769] 'count revisions from in-memory index tree' (duration: 194.209055ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:29:39.894499Z","caller":"traceutil/trace.go:171","msg":"trace[1155935763] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"198.535847ms","start":"2026-04-21T17:29:39.69593Z","end":"2026-04-21T17:29:39.894466Z","steps":["trace[1155935763] 'process raft request' (duration: 198.363745ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:29:39.96172Z","caller":"traceutil/trace.go:171","msg":"trace[1319932400] linearizableReadLoop","detail":"{readStateIndex:1392; appliedIndex:1387; }","duration":"257.225175ms","start":"2026-04-21T17:29:39.704463Z","end":"2026-04-21T17:29:39.961688Z","steps":["trace[1319932400] 'read index received' (duration: 189.836601ms)","trace[1319932400] 'applied index is now lower than readState.Index' (duration: 67.387124ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:29:39.961958Z","caller":"traceutil/trace.go:171","msg":"trace[129540884] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"261.429526ms","start":"2026-04-21T17:29:39.700494Z","end":"2026-04-21T17:29:39.961924Z","steps":["trace[129540884] 'process raft request' (duration: 261.108052ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:29:39.961965Z","caller":"traceutil/trace.go:171","msg":"trace[282128378] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"264.275891ms","start":"2026-04-21T17:29:39.697626Z","end":"2026-04-21T17:29:39.961902Z","steps":["trace[282128378] 'process raft request' (duration: 263.935067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:39.962085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.588819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:29:39.962188Z","caller":"traceutil/trace.go:171","msg":"trace[1694889364] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1338; }","duration":"257.759901ms","start":"2026-04-21T17:29:39.704414Z","end":"2026-04-21T17:29:39.962173Z","steps":["trace[1694889364] 'agreement among raft nodes before linearized reading' (duration: 257.512268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:29:39.962361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.95793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:29:39.962386Z","caller":"traceutil/trace.go:171","msg":"trace[475568379] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"261.371166ms","start":"2026-04-21T17:29:39.700968Z","end":"2026-04-21T17:29:39.962339Z","steps":["trace[475568379] 'process raft request' (duration: 260.675138ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:29:39.962421Z","caller":"traceutil/trace.go:171","msg":"trace[1806784350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1338; }","duration":"198.138782ms","start":"2026-04-21T17:29:39.764268Z","end":"2026-04-21T17:29:39.962407Z","steps":["trace[1806784350] 'agreement among raft nodes before linearized reading' (duration: 197.660246ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:29:39.96271Z","caller":"traceutil/trace.go:171","msg":"trace[1258006670] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"266.029982ms","start":"2026-04-21T17:29:39.696668Z","end":"2026-04-21T17:29:39.962698Z","steps":["trace[1258006670] 'process raft request' (duration: 264.752196ms)"],"step_count":1}