{"level":"warn","ts":"2026-05-29T02:07:37.71643Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T02:07:37.716515Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-05-29T02:07:37.716582Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T02:07:37.716594Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-29T02:07:37.716622Z","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-05-29T02:07:37.717241Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-05-29T02:07:37.717326Z","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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-05-29T02:07:37.72355Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.999601ms"} {"level":"info","ts":"2026-05-29T02:07:37.731842Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-05-29T02:07:37.73195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T02:07:37.731984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-05-29T02:07:37.732002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T02:07:37.732334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-05-29T02:07:37.732418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-05-29T02:07:37.750735Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T02:07:37.752173Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T02:07:37.754519Z","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-05-29T02:07:37.757303Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T02:07:37.75754Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T02:07:37.757823Z","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-05-29T02:07:37.75786Z","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-05-29T02:07:37.757871Z","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-05-29T02:07:37.759752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-05-29T02:07:37.759922Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-05-29T02:07:37.761775Z","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-05-29T02:07:37.76188Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-29T02:07:37.761924Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-05-29T02:07:37.762133Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T02:07:37.762181Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T02:07:38.532879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T02:07:38.532964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T02:07:38.532989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-05-29T02:07:38.533009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-05-29T02:07:38.53302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-29T02:07:38.533036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-05-29T02:07:38.533054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-05-29T02:07:38.533998Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T02:07:38.534858Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T02:07:38.535053Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T02:07:38.535147Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T02:07:38.535164Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T02:07:38.535194Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-29T02:07:38.535471Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T02:07:38.53557Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T02:07:38.535613Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T02:07:38.538082Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-29T02:07:38.538777Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-05-29T02:07:42.652897Z","caller":"traceutil/trace.go:171","msg":"trace[441189043] linearizableReadLoop","detail":"{readStateIndex:259; appliedIndex:258; }","duration":"100.082076ms","start":"2026-05-29T02:07:42.552789Z","end":"2026-05-29T02:07:42.652871Z","steps":["trace[441189043] 'read index received' (duration: 99.843522ms)","trace[441189043] 'applied index is now lower than readState.Index' (duration: 237.434µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:07:42.652975Z","caller":"traceutil/trace.go:171","msg":"trace[2043364939] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"168.080445ms","start":"2026-05-29T02:07:42.484857Z","end":"2026-05-29T02:07:42.652937Z","steps":["trace[2043364939] 'process raft request' (duration: 167.85106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:07:42.653124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.314291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"} {"level":"info","ts":"2026-05-29T02:07:42.653236Z","caller":"traceutil/trace.go:171","msg":"trace[1266978003] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:253; }","duration":"100.484354ms","start":"2026-05-29T02:07:42.552727Z","end":"2026-05-29T02:07:42.653211Z","steps":["trace[1266978003] 'agreement among raft nodes before linearized reading' (duration: 100.27024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:07:42.883416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.156236ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-29T02:07:42.883745Z","caller":"traceutil/trace.go:171","msg":"trace[406655394] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"223.60999ms","start":"2026-05-29T02:07:42.660104Z","end":"2026-05-29T02:07:42.883714Z","steps":["trace[406655394] 'process raft request' (duration: 121.649999ms)","trace[406655394] 'compare' (duration: 100.989953ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:07:42.883787Z","caller":"traceutil/trace.go:171","msg":"trace[479316383] linearizableReadLoop","detail":"{readStateIndex:260; appliedIndex:259; }","duration":"221.418379ms","start":"2026-05-29T02:07:42.662258Z","end":"2026-05-29T02:07:42.883676Z","steps":["trace[479316383] 'read index received' (duration: 119.456738ms)","trace[479316383] 'applied index is now lower than readState.Index' (duration: 101.960221ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:07:42.883952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.678514ms","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-05-29T02:07:42.884172Z","caller":"traceutil/trace.go:171","msg":"trace[20409125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:254; }","duration":"221.947429ms","start":"2026-05-29T02:07:42.662207Z","end":"2026-05-29T02:07:42.884154Z","steps":["trace[20409125] 'agreement among raft nodes before linearized reading' (duration: 221.612293ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:07:43.008978Z","caller":"traceutil/trace.go:171","msg":"trace[2034684138] linearizableReadLoop","detail":"{readStateIndex:261; appliedIndex:260; }","duration":"124.984361ms","start":"2026-05-29T02:07:42.883961Z","end":"2026-05-29T02:07:43.008945Z","steps":["trace[2034684138] 'read index received' (duration: 124.738226ms)","trace[2034684138] 'applied index is now lower than readState.Index' (duration: 244.985µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:07:43.009086Z","caller":"traceutil/trace.go:171","msg":"trace[1015012778] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"346.683266ms","start":"2026-05-29T02:07:42.662372Z","end":"2026-05-29T02:07:43.009056Z","steps":["trace[1015012778] 'process raft request' (duration: 346.314599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:07:43.009132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.900988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:07:43.00917Z","caller":"traceutil/trace.go:171","msg":"trace[1159660617] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:0; response_revision:255; }","duration":"340.971409ms","start":"2026-05-29T02:07:42.668184Z","end":"2026-05-29T02:07:43.009156Z","steps":["trace[1159660617] 'agreement among raft nodes before linearized reading' (duration: 340.876837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:07:43.009212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:07:42.668176Z","time spent":"341.02817ms","remote":"127.0.0.1:38800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-05-29T02:07:43.009423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:07:42.662346Z","time spent":"346.810388ms","remote":"127.0.0.1:38786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:07:43.01252Z","caller":"traceutil/trace.go:171","msg":"trace[1275997422] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"124.320328ms","start":"2026-05-29T02:07:42.88818Z","end":"2026-05-29T02:07:43.0125Z","steps":["trace[1275997422] 'process raft request' (duration: 124.225296ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:13.352929Z","caller":"traceutil/trace.go:171","msg":"trace[2022650671] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"105.474558ms","start":"2026-05-29T02:08:13.247405Z","end":"2026-05-29T02:08:13.35288Z","steps":["trace[2022650671] 'process raft request' (duration: 105.239373ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:13.357551Z","caller":"traceutil/trace.go:171","msg":"trace[1522087742] transaction","detail":"{read_only:false; number_of_response:1; response_revision:535; }","duration":"109.130045ms","start":"2026-05-29T02:08:13.248391Z","end":"2026-05-29T02:08:13.357521Z","steps":["trace[1522087742] 'process raft request' (duration: 108.777459ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:13.358381Z","caller":"traceutil/trace.go:171","msg":"trace[1771919624] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"100.559206ms","start":"2026-05-29T02:08:13.257799Z","end":"2026-05-29T02:08:13.358358Z","steps":["trace[1771919624] 'process raft request' (duration: 99.531196ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:13.358403Z","caller":"traceutil/trace.go:171","msg":"trace[964848097] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"100.158138ms","start":"2026-05-29T02:08:13.258225Z","end":"2026-05-29T02:08:13.358383Z","steps":["trace[964848097] 'process raft request' (duration: 99.128678ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:13.35858Z","caller":"traceutil/trace.go:171","msg":"trace[1895585989] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"102.35113ms","start":"2026-05-29T02:08:13.256219Z","end":"2026-05-29T02:08:13.358571Z","steps":["trace[1895585989] 'process raft request' (duration: 101.054185ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:18.277249Z","caller":"traceutil/trace.go:171","msg":"trace[1665543715] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"165.16828ms","start":"2026-05-29T02:08:18.112063Z","end":"2026-05-29T02:08:18.277232Z","steps":["trace[1665543715] 'read index received' (duration: 164.63957ms)","trace[1665543715] 'applied index is now lower than readState.Index' (duration: 527.87µs)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:08:18.27737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.216932ms","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-05-29T02:08:18.277391Z","caller":"traceutil/trace.go:171","msg":"trace[68708525] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:620; }","duration":"165.263692ms","start":"2026-05-29T02:08:18.11212Z","end":"2026-05-29T02:08:18.277384Z","steps":["trace[68708525] 'agreement among raft nodes before linearized reading' (duration: 165.208981ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:18.277313Z","caller":"traceutil/trace.go:171","msg":"trace[2084483400] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"175.592354ms","start":"2026-05-29T02:08:18.101694Z","end":"2026-05-29T02:08:18.277286Z","steps":["trace[2084483400] 'process raft request' (duration: 175.166146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:18.277461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.353334ms","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-05-29T02:08:18.277553Z","caller":"traceutil/trace.go:171","msg":"trace[901495706] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:620; }","duration":"165.516867ms","start":"2026-05-29T02:08:18.112009Z","end":"2026-05-29T02:08:18.277526Z","steps":["trace[901495706] 'agreement among raft nodes before linearized reading' (duration: 165.325963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:18.277657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.30676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:08:18.277676Z","caller":"traceutil/trace.go:171","msg":"trace[1570433359] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:620; }","duration":"115.34017ms","start":"2026-05-29T02:08:18.16233Z","end":"2026-05-29T02:08:18.27767Z","steps":["trace[1570433359] 'agreement among raft nodes before linearized reading' (duration: 115.3127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:18.277758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.453633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:08:18.277772Z","caller":"traceutil/trace.go:171","msg":"trace[2061827314] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:620; }","duration":"115.506874ms","start":"2026-05-29T02:08:18.16226Z","end":"2026-05-29T02:08:18.277767Z","steps":["trace[2061827314] 'agreement among raft nodes before linearized reading' (duration: 115.481314ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:19.314814Z","caller":"traceutil/trace.go:171","msg":"trace[1185416494] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"136.697309ms","start":"2026-05-29T02:08:19.17808Z","end":"2026-05-29T02:08:19.314778Z","steps":["trace[1185416494] 'process raft request' (duration: 123.059285ms)","trace[1185416494] 'compare' (duration: 13.518982ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:19.560654Z","caller":"traceutil/trace.go:171","msg":"trace[1762911393] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"252.916207ms","start":"2026-05-29T02:08:19.307667Z","end":"2026-05-29T02:08:19.560583Z","steps":["trace[1762911393] 'process raft request' (duration: 225.808131ms)","trace[1762911393] 'compare' (duration: 26.618197ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:19.822426Z","caller":"traceutil/trace.go:171","msg":"trace[663226893] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"255.876891ms","start":"2026-05-29T02:08:19.566509Z","end":"2026-05-29T02:08:19.822386Z","steps":["trace[663226893] 'process raft request' (duration: 174.956082ms)","trace[663226893] 'compare' (duration: 80.725146ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:19.822508Z","caller":"traceutil/trace.go:171","msg":"trace[747719263] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"246.044398ms","start":"2026-05-29T02:08:19.576438Z","end":"2026-05-29T02:08:19.822483Z","steps":["trace[747719263] 'read index received' (duration: 165.117159ms)","trace[747719263] 'applied index is now lower than readState.Index' (duration: 80.925809ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T02:08:19.822608Z","caller":"traceutil/trace.go:171","msg":"trace[1993393331] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"201.341605ms","start":"2026-05-29T02:08:19.621246Z","end":"2026-05-29T02:08:19.822587Z","steps":["trace[1993393331] 'process raft request' (duration: 201.09871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:08:19.822696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.249972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gk2gh\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-29T02:08:19.822742Z","caller":"traceutil/trace.go:171","msg":"trace[95740721] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gk2gh; range_end:; response_count:1; response_revision:631; }","duration":"246.347983ms","start":"2026-05-29T02:08:19.576383Z","end":"2026-05-29T02:08:19.822731Z","steps":["trace[95740721] 'agreement among raft nodes before linearized reading' (duration: 246.18285ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:08:38.225335Z","caller":"traceutil/trace.go:171","msg":"trace[1045775725] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"156.195841ms","start":"2026-05-29T02:08:38.069119Z","end":"2026-05-29T02:08:38.225315Z","steps":["trace[1045775725] 'process raft request' (duration: 156.082569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:11.6662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.881028ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-05-29T02:09:11.666315Z","caller":"traceutil/trace.go:171","msg":"trace[579748851] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"104.552749ms","start":"2026-05-29T02:09:11.561735Z","end":"2026-05-29T02:09:11.666288Z","steps":["trace[579748851] 'read index received' (duration: 28.941µs)","trace[579748851] 'applied index is now lower than readState.Index' (duration: 104.522328ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:09:11.666527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.747142ms","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-05-29T02:09:11.666565Z","caller":"traceutil/trace.go:171","msg":"trace[1754096831] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1010; }","duration":"104.853984ms","start":"2026-05-29T02:09:11.561702Z","end":"2026-05-29T02:09:11.666556Z","steps":["trace[1754096831] 'agreement among raft nodes before linearized reading' (duration: 104.64348ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:11.782033Z","caller":"traceutil/trace.go:171","msg":"trace[913894098] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"111.984398ms","start":"2026-05-29T02:09:11.670025Z","end":"2026-05-29T02:09:11.78201Z","steps":["trace[913894098] 'process raft request' (duration: 110.764875ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:11.782214Z","caller":"traceutil/trace.go:171","msg":"trace[1350830362] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"108.479731ms","start":"2026-05-29T02:09:11.67372Z","end":"2026-05-29T02:09:11.7822Z","steps":["trace[1350830362] 'process raft request' (duration: 108.219506ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:34.332478Z","caller":"traceutil/trace.go:171","msg":"trace[595440812] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"178.559088ms","start":"2026-05-29T02:09:34.153892Z","end":"2026-05-29T02:09:34.332451Z","steps":["trace[595440812] 'process raft request' (duration: 178.429826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:09:34.980593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.655773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:09:34.980686Z","caller":"traceutil/trace.go:171","msg":"trace[908976020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1089; }","duration":"102.794446ms","start":"2026-05-29T02:09:34.87787Z","end":"2026-05-29T02:09:34.980665Z","steps":["trace[908976020] 'range keys from in-memory index tree' (duration: 102.570632ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:36.020328Z","caller":"traceutil/trace.go:171","msg":"trace[2089402695] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"113.626018ms","start":"2026-05-29T02:09:35.906478Z","end":"2026-05-29T02:09:36.020104Z","steps":["trace[2089402695] 'process raft request' (duration: 113.429184ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:36.467924Z","caller":"traceutil/trace.go:171","msg":"trace[2089383115] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"127.120248ms","start":"2026-05-29T02:09:36.340776Z","end":"2026-05-29T02:09:36.467896Z","steps":["trace[2089383115] 'process raft request' (duration: 126.953985ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:52.221041Z","caller":"traceutil/trace.go:171","msg":"trace[176390130] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"152.026447ms","start":"2026-05-29T02:09:52.068983Z","end":"2026-05-29T02:09:52.221009Z","steps":["trace[176390130] 'process raft request' (duration: 151.877304ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:09:52.239496Z","caller":"traceutil/trace.go:171","msg":"trace[1220828845] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"168.579648ms","start":"2026-05-29T02:09:52.070892Z","end":"2026-05-29T02:09:52.239471Z","steps":["trace[1220828845] 'process raft request' (duration: 168.477176ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:10:08.867052Z","caller":"traceutil/trace.go:171","msg":"trace[1640047156] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"147.587934ms","start":"2026-05-29T02:10:08.719445Z","end":"2026-05-29T02:10:08.867033Z","steps":["trace[1640047156] 'process raft request' (duration: 104.082426ms)","trace[1640047156] 'compare' (duration: 43.412387ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:10:59.05037Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:10:59.551361Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:00.052288Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:00.552486Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:01.052954Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:01.553715Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:01.878434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00071129s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-29T02:11:01.878561Z","caller":"traceutil/trace.go:171","msg":"trace[1546578094] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000879182s","start":"2026-05-29T02:10:59.877661Z","end":"2026-05-29T02:11:01.87854Z","steps":["trace[1546578094] 'agreement among raft nodes before linearized reading' (duration: 2.0007321s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:01.878617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:59.877642Z","time spent":"2.000962694s","remote":"127.0.0.1:38592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/29 02:11:01 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:02.054291Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:02.554714Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:03.055588Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:03.496561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:58.498201Z","time spent":"4.998353374s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-29T02:11:03.556533Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:03.578389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999005985s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:03.578456Z","caller":"traceutil/trace.go:171","msg":"trace[1357198334] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999131978s","start":"2026-05-29T02:10:58.579304Z","end":"2026-05-29T02:11:03.578436Z","steps":["trace[1357198334] 'agreement among raft nodes before linearized reading' (duration: 4.999045366s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:03.578502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:58.579281Z","time spent":"4.999210879s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/05/29 02:11:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:03.878888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999870353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-29T02:11:03.878985Z","caller":"traceutil/trace.go:171","msg":"trace[363587440] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000022995s","start":"2026-05-29T02:11:01.878939Z","end":"2026-05-29T02:11:03.878962Z","steps":["trace[363587440] 'agreement among raft nodes before linearized reading' (duration: 1.999902233s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:03.879044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:01.87892Z","time spent":"2.000111617s","remote":"127.0.0.1:38586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/29 02:11:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:03.902596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000085057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-29T02:11:03.902667Z","caller":"traceutil/trace.go:171","msg":"trace[376406434] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000226379s","start":"2026-05-29T02:10:58.902424Z","end":"2026-05-29T02:11:03.902651Z","steps":["trace[376406434] 'agreement among raft nodes before linearized reading' (duration: 5.000118117s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:03.902714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:58.902406Z","time spent":"5.000298311s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/05/29 02:11:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:04.056865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:04.55731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:04.959202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999832931s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:04.959287Z","caller":"traceutil/trace.go:171","msg":"trace[1006899590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999960183s","start":"2026-05-29T02:10:59.959302Z","end":"2026-05-29T02:11:04.959262Z","steps":["trace[1006899590] 'agreement among raft nodes before linearized reading' (duration: 4.999861191s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:04.959341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:59.959283Z","time spent":"5.000048575s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/05/29 02:11:04 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:05.057972Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909675,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:05.549776Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-05-29T02:11:05.549928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.000239573s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-29T02:11:05.549973Z","caller":"traceutil/trace.go:171","msg":"trace[1040293328] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; }","duration":"7.000296814s","start":"2026-05-29T02:10:58.549657Z","end":"2026-05-29T02:11:05.549954Z","steps":["trace[1040293328] 'agreement among raft nodes before linearized reading' (duration: 7.000238163s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:05.550014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:58.549601Z","time spent":"7.000404626s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-29T02:11:05.887472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00083336s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-29T02:11:05.887588Z","caller":"traceutil/trace.go:171","msg":"trace[1624322373] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001029624s","start":"2026-05-29T02:11:03.886538Z","end":"2026-05-29T02:11:05.887568Z","steps":["trace[1624322373] 'agreement among raft nodes before linearized reading' (duration: 2.000889171s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:05.887751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:03.886524Z","time spent":"2.001126505s","remote":"127.0.0.1:38592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/29 02:11:05 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:06.05084Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:06.551032Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:07.051788Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:07.552944Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:07.887772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999957854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-29T02:11:07.887843Z","caller":"traceutil/trace.go:171","msg":"trace[2026203384] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000082907s","start":"2026-05-29T02:11:05.887744Z","end":"2026-05-29T02:11:07.887827Z","steps":["trace[2026203384] 'agreement among raft nodes before linearized reading' (duration: 1.999990865s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:07.88788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:05.887725Z","time spent":"2.000146988s","remote":"127.0.0.1:38586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T02:11:08.053943Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:08.498022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999730508s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:08.498143Z","caller":"traceutil/trace.go:171","msg":"trace[340612477] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; }","duration":"4.999880811s","start":"2026-05-29T02:11:03.498206Z","end":"2026-05-29T02:11:08.498087Z","steps":["trace[340612477] 'agreement among raft nodes before linearized reading' (duration: 4.999762748s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:08.498195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:03.498187Z","time spent":"4.999996382s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} 2026/05/29 02:11:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:08.554902Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:08.578242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997368389s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:08.578307Z","caller":"traceutil/trace.go:171","msg":"trace[878187662] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.997495361s","start":"2026-05-29T02:11:05.580792Z","end":"2026-05-29T02:11:08.578288Z","steps":["trace[878187662] 'agreement among raft nodes before linearized reading' (duration: 2.99741456s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:08.578495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:05.580767Z","time spent":"2.997683675s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/05/29 02:11:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:08.678774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999729523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:08.678858Z","caller":"traceutil/trace.go:171","msg":"trace[190948608] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; }","duration":"9.999870015s","start":"2026-05-29T02:10:58.678968Z","end":"2026-05-29T02:11:08.678838Z","steps":["trace[190948608] 'agreement among raft nodes before linearized reading' (duration: 9.999762473s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:08.679005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:58.678948Z","time spent":"9.999948357s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} 2026/05/29 02:11:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:08.902059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997127504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:08.902139Z","caller":"traceutil/trace.go:171","msg":"trace[1839221105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.997255666s","start":"2026-05-29T02:11:05.904867Z","end":"2026-05-29T02:11:08.902123Z","steps":["trace[1839221105] 'agreement among raft nodes before linearized reading' (duration: 2.997160794s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:08.902174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:05.904849Z","time spent":"2.997317437s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/05/29 02:11:08 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:09.055898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:09.094888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.000411095s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:09.094976Z","caller":"traceutil/trace.go:171","msg":"trace[93315948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"10.000561968s","start":"2026-05-29T02:10:59.094395Z","end":"2026-05-29T02:11:09.094957Z","steps":["trace[93315948] 'agreement among raft nodes before linearized reading' (duration: 10.000449336s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:09.095023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:59.094371Z","time spent":"10.000643559s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} 2026/05/29 02:11:09 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:09.162241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999471797s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:09.162318Z","caller":"traceutil/trace.go:171","msg":"trace[486969525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"9.99960092s","start":"2026-05-29T02:10:59.162698Z","end":"2026-05-29T02:11:09.162299Z","steps":["trace[486969525] 'agreement among raft nodes before linearized reading' (duration: 9.999509088s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:09.162367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:59.162676Z","time spent":"9.999681411s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} 2026/05/29 02:11:09 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:09.556865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:09.896337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000311031s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:09.896415Z","caller":"traceutil/trace.go:171","msg":"trace[1181460707] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000423904s","start":"2026-05-29T02:11:07.895973Z","end":"2026-05-29T02:11:09.896397Z","steps":["trace[1181460707] 'agreement among raft nodes before linearized reading' (duration: 2.000324862s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:09.896459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:07.895961Z","time spent":"2.000489465s","remote":"127.0.0.1:38592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/29 02:11:09 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:09.959327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.998327657s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:09.959412Z","caller":"traceutil/trace.go:171","msg":"trace[532917616] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.99846695s","start":"2026-05-29T02:11:06.960925Z","end":"2026-05-29T02:11:09.959392Z","steps":["trace[532917616] 'agreement among raft nodes before linearized reading' (duration: 2.998360528s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:09.959507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:06.960904Z","time spent":"2.998588963s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/05/29 02:11:09 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:10.014963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.99961711s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:10.015036Z","caller":"traceutil/trace.go:171","msg":"trace[670095642] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; }","duration":"9.999689741s","start":"2026-05-29T02:11:00.015322Z","end":"2026-05-29T02:11:10.015012Z","steps":["trace[670095642] 'agreement among raft nodes before linearized reading' (duration: 9.99961556s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:10.015076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:00.015264Z","time spent":"9.999802914s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} 2026/05/29 02:11:10 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:10.057572Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:10.558509Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:10.883219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:03.882209Z","time spent":"7.001004548s","remote":"127.0.0.1:38692","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-29T02:11:11.058967Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:11.145523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.000390735s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:11.145612Z","caller":"traceutil/trace.go:171","msg":"trace[517810712] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; }","duration":"10.000490856s","start":"2026-05-29T02:11:01.145098Z","end":"2026-05-29T02:11:11.145589Z","steps":["trace[517810712] 'agreement among raft nodes before linearized reading' (duration: 10.000387994s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:11.145668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:01.145079Z","time spent":"10.000577338s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} 2026/05/29 02:11:11 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:11.267305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:04.266247Z","time spent":"7.001051288s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-05-29T02:11:11.56018Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:11.881956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00028592s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-29T02:11:11.882053Z","caller":"traceutil/trace.go:171","msg":"trace[1296316683] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000417773s","start":"2026-05-29T02:11:09.881613Z","end":"2026-05-29T02:11:11.882031Z","steps":["trace[1296316683] 'agreement among raft nodes before linearized reading' (duration: 2.000301671s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:11.882108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:09.881602Z","time spent":"2.000494305s","remote":"127.0.0.1:38592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-29T02:11:11.896816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000131068s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:11.896871Z","caller":"traceutil/trace.go:171","msg":"trace[227006428] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00023236s","start":"2026-05-29T02:11:09.896626Z","end":"2026-05-29T02:11:11.896858Z","steps":["trace[227006428] 'agreement among raft nodes before linearized reading' (duration: 2.000171308s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:11.896907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:09.896596Z","time spent":"2.00030326s","remote":"127.0.0.1:38586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/29 02:11:11 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:12.061107Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909680,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:12.458545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999900854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-29T02:11:12.458643Z","caller":"traceutil/trace.go:171","msg":"trace[513779550] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; }","duration":"10.000056557s","start":"2026-05-29T02:11:02.458563Z","end":"2026-05-29T02:11:12.45862Z","steps":["trace[513779550] 'agreement among raft nodes before linearized reading' (duration: 9.999940635s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:12.458704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:02.458538Z","time spent":"10.00015228s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} 2026/05/29 02:11:12 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-29T02:11:12.550316Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-05-29T02:11:12.550482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.280213248s","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":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-05-29T02:11:12.550492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.078106747s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-29T02:11:12.550552Z","caller":"traceutil/trace.go:171","msg":"trace[1778823255] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; }","duration":"8.280354241s","start":"2026-05-29T02:11:04.270176Z","end":"2026-05-29T02:11:12.55053Z","steps":["trace[1778823255] 'agreement among raft nodes before linearized reading' (duration: 8.280247889s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:12.5506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.813832654s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-05-29T02:11:12.550621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.446332504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-05-29T02:11:12.550676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:04.270156Z","time spent":"8.280499763s","remote":"127.0.0.1:38736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":0,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:11:12.550595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.615555662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-29T02:11:12.550866Z","caller":"traceutil/trace.go:171","msg":"trace[1118562278] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; }","duration":"9.615897409s","start":"2026-05-29T02:11:02.93495Z","end":"2026-05-29T02:11:12.550847Z","steps":["trace[1118562278] 'agreement among raft nodes before linearized reading' (duration: 9.615586123s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:11:12.550729Z","caller":"traceutil/trace.go:171","msg":"trace[1721047349] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; }","duration":"13.446479806s","start":"2026-05-29T02:10:59.104238Z","end":"2026-05-29T02:11:12.550718Z","steps":["trace[1721047349] 'agreement among raft nodes before linearized reading' (duration: 13.446371274s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:12.550517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.684581466s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-05-29T02:11:12.550925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:02.934929Z","time spent":"9.61598183s","remote":"127.0.0.1:38834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":0,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-05-29T02:11:12.55066Z","caller":"traceutil/trace.go:171","msg":"trace[1066899872] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; }","duration":"11.813952206s","start":"2026-05-29T02:11:00.736693Z","end":"2026-05-29T02:11:12.550645Z","steps":["trace[1066899872] 'agreement among raft nodes before linearized reading' (duration: 11.813868664s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:12.550991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:00.736675Z","time spent":"11.814296062s","remote":"127.0.0.1:38696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":0,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:11:12.550651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.62259715s","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":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-05-29T02:11:12.551097Z","caller":"traceutil/trace.go:171","msg":"trace[2002299286] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; }","duration":"11.623086279s","start":"2026-05-29T02:11:00.927961Z","end":"2026-05-29T02:11:12.551048Z","steps":["trace[2002299286] 'agreement among raft nodes before linearized reading' (duration: 11.622628811s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:12.551175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:00.92794Z","time spent":"11.623216741s","remote":"127.0.0.1:38648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":0,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-29T02:11:12.550573Z","caller":"traceutil/trace.go:171","msg":"trace[195093381] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; }","duration":"11.07824224s","start":"2026-05-29T02:11:01.472311Z","end":"2026-05-29T02:11:12.550553Z","steps":["trace[195093381] 'agreement among raft nodes before linearized reading' (duration: 11.078136058s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:12.551191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:10:59.104215Z","time spent":"13.446949606s","remote":"127.0.0.1:39066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":0,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:11:12.55122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:01.472295Z","time spent":"11.078917733s","remote":"127.0.0.1:38634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/199.204.45.222\" "} {"level":"info","ts":"2026-05-29T02:11:12.551383Z","caller":"traceutil/trace.go:171","msg":"trace[122952083] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; }","duration":"8.685040015s","start":"2026-05-29T02:11:03.86588Z","end":"2026-05-29T02:11:12.55092Z","steps":["trace[122952083] 'agreement among raft nodes before linearized reading' (duration: 8.684609727s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:12.551807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:03.865863Z","time spent":"8.685925661s","remote":"127.0.0.1:39024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":0,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:11:13.050782Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890118690183909690,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-29T02:11:13.501985Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"5f9e9e717cb110df","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-05-29T02:11:13.511826Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"15.013460693s","expected-duration":"1s"} {"level":"info","ts":"2026-05-29T02:11:13.535758Z","caller":"traceutil/trace.go:171","msg":"trace[1257550214] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"4.630892967s","start":"2026-05-29T02:11:08.904173Z","end":"2026-05-29T02:11:13.535066Z","steps":["trace[1257550214] 'process raft request' (duration: 4.630279946s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.53592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:08.904147Z","time spent":"4.631699983s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:11:13.536129Z","caller":"traceutil/trace.go:171","msg":"trace[1947630323] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"6.767876187s","start":"2026-05-29T02:11:06.768241Z","end":"2026-05-29T02:11:13.536117Z","steps":["trace[1947630323] 'process raft request' (duration: 6.766150345s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.536182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:06.768212Z","time spent":"6.767941038s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:11:13.53621Z","caller":"traceutil/trace.go:171","msg":"trace[1403551913] transaction","detail":"{read_only:false; response_revision:1538; number_of_response:1; }","duration":"4.371412251s","start":"2026-05-29T02:11:09.164771Z","end":"2026-05-29T02:11:13.536183Z","steps":["trace[1403551913] 'process raft request' (duration: 4.369725349s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.536331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:09.164743Z","time spent":"4.371521703s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":409,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:11:13.536429Z","caller":"traceutil/trace.go:171","msg":"trace[1068417216] transaction","detail":"{read_only:false; response_revision:1537; number_of_response:1; }","duration":"4.438342559s","start":"2026-05-29T02:11:09.09808Z","end":"2026-05-29T02:11:13.536422Z","steps":["trace[1068417216] 'process raft request' (duration: 4.436397602s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.536459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:09.098047Z","time spent":"4.43839525s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":413,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:11:13.536513Z","caller":"traceutil/trace.go:171","msg":"trace[26376133] transaction","detail":"{read_only:false; response_revision:1539; number_of_response:1; }","duration":"3.574841231s","start":"2026-05-29T02:11:09.961666Z","end":"2026-05-29T02:11:13.536508Z","steps":["trace[26376133] 'process raft request' (duration: 3.572848393s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.536542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:09.961619Z","time spent":"3.574906152s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T02:11:13.537487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:10.884353Z","time spent":"2.653128089s","remote":"127.0.0.1:38692","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-29T02:11:13.55185Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"66.671µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"info","ts":"2026-05-29T02:11:13.552253Z","caller":"traceutil/trace.go:171","msg":"trace[365406331] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1539; }","duration":"2.281603167s","start":"2026-05-29T02:11:11.270617Z","end":"2026-05-29T02:11:13.55222Z","steps":["trace[365406331] 'process raft request' (duration: 2.263944626s)","trace[365406331] 'range keys from in-memory index tree' {req_type:range; range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; } (duration: 11.422454ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:11:13.552267Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"5f9e9e717cb110df","error":"lease not found"} {"level":"warn","ts":"2026-05-29T02:11:13.552378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:11.270599Z","time spent":"2.281705849s","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":720,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T02:11:13.552369Z","caller":"traceutil/trace.go:171","msg":"trace[1091587788] linearizableReadLoop","detail":"{readStateIndex:1600; appliedIndex:1589; }","duration":"1.001948189s","start":"2026-05-29T02:11:12.550399Z","end":"2026-05-29T02:11:13.552347Z","steps":["trace[1091587788] 'read index received' (duration: 961.704813ms)","trace[1091587788] 'applied index is now lower than readState.Index' (duration: 40.239456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T02:11:13.552451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.665349318s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b3e75ce369b3a8\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:11:13.552488Z","caller":"traceutil/trace.go:171","msg":"trace[1739198259] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18b3e75ce369b3a8; range_end:; response_count:0; response_revision:1539; }","duration":"2.66546172s","start":"2026-05-29T02:11:10.887009Z","end":"2026-05-29T02:11:13.55247Z","steps":["trace[1739198259] 'agreement among raft nodes before linearized reading' (duration: 2.665384159s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.552512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.269569306s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T02:11:13.552506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.089327388s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-29T02:11:13.552526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:10.886991Z","time spent":"2.665528942s","remote":"127.0.0.1:38692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b3e75ce369b3a8\" "} {"level":"info","ts":"2026-05-29T02:11:13.552533Z","caller":"traceutil/trace.go:171","msg":"trace[320722771] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1539; }","duration":"4.269648548s","start":"2026-05-29T02:11:09.28288Z","end":"2026-05-29T02:11:13.552528Z","steps":["trace[320722771] 'agreement among raft nodes before linearized reading' (duration: 4.269573037s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:11:13.552551Z","caller":"traceutil/trace.go:171","msg":"trace[815269132] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1539; }","duration":"4.08941774s","start":"2026-05-29T02:11:09.463121Z","end":"2026-05-29T02:11:13.552539Z","steps":["trace[815269132] 'agreement among raft nodes before linearized reading' (duration: 4.089297768s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.552562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:09.282861Z","time spent":"4.26969389s","remote":"127.0.0.1:38912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:11:13.552583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:09.463101Z","time spent":"4.089477112s","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":17,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:11:13.552576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.735245056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T02:11:13.552609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.64851471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:11:13.552621Z","caller":"traceutil/trace.go:171","msg":"trace[733385150] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1539; }","duration":"3.735333278s","start":"2026-05-29T02:11:09.817273Z","end":"2026-05-29T02:11:13.552606Z","steps":["trace[733385150] 'agreement among raft nodes before linearized reading' (duration: 3.735260015s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:11:13.552638Z","caller":"traceutil/trace.go:171","msg":"trace[1408391783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1539; }","duration":"1.648564101s","start":"2026-05-29T02:11:11.904066Z","end":"2026-05-29T02:11:13.55263Z","steps":["trace[1408391783] 'agreement among raft nodes before linearized reading' (duration: 1.64851691s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.552663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:11.904055Z","time spent":"1.648603292s","remote":"127.0.0.1:38592","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-05-29T02:11:13.552659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:09.817256Z","time spent":"3.735395528s","remote":"127.0.0.1:38562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:11:13.552715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.813127738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T02:11:13.55273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.653009616s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7111"} {"level":"info","ts":"2026-05-29T02:11:13.55274Z","caller":"traceutil/trace.go:171","msg":"trace[1186156024] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1539; }","duration":"6.81318498s","start":"2026-05-29T02:11:06.739546Z","end":"2026-05-29T02:11:13.552731Z","steps":["trace[1186156024] 'agreement among raft nodes before linearized reading' (duration: 6.813148859s)"],"step_count":1} {"level":"info","ts":"2026-05-29T02:11:13.552752Z","caller":"traceutil/trace.go:171","msg":"trace[286456982] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:1539; }","duration":"1.653086997s","start":"2026-05-29T02:11:11.899658Z","end":"2026-05-29T02:11:13.552745Z","steps":["trace[286456982] 'agreement among raft nodes before linearized reading' (duration: 1.653033936s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.552763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:06.739526Z","time spent":"6.81323142s","remote":"127.0.0.1:38622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:11:13.55277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:11.899639Z","time spent":"1.653127857s","remote":"127.0.0.1:38792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7134,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-05-29T02:11:13.552777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.254347623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:11:13.552805Z","caller":"traceutil/trace.go:171","msg":"trace[479568263] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1539; }","duration":"1.254413784s","start":"2026-05-29T02:11:12.298385Z","end":"2026-05-29T02:11:13.552799Z","steps":["trace[479568263] 'agreement among raft nodes before linearized reading' (duration: 1.254370793s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.552829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:12.298367Z","time spent":"1.254455845s","remote":"127.0.0.1:38842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-05-29T02:11:13.553617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000726986s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T02:11:13.553852Z","caller":"traceutil/trace.go:171","msg":"trace[424029120] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:0; response_revision:1540; }","duration":"1.000790597s","start":"2026-05-29T02:11:12.552847Z","end":"2026-05-29T02:11:13.553638Z","steps":["trace[424029120] 'agreement among raft nodes before linearized reading' (duration: 1.000733076s)"],"step_count":1} {"level":"warn","ts":"2026-05-29T02:11:13.553895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T02:11:12.552826Z","time spent":"1.001060302s","remote":"127.0.0.1:38634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.222\" "}