{"level":"warn","ts":"2026-02-13T06:55:17.632682Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-13T06:55:17.632829Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.33: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.33:2380","--initial-cluster=instance=https://199.204.45.33:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.33:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.33: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-02-13T06:55:17.63292Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-13T06:55:17.63295Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-02-13T06:55:17.632983Z","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-02-13T06:55:17.633631Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"]} {"level":"info","ts":"2026-02-13T06:55:17.633759Z","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":2,"max-cpu-available":2,"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.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.33: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-02-13T06:55:17.860934Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"226.750894ms"} {"level":"info","ts":"2026-02-13T06:55:17.887528Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e5729930cf7e1f","cluster-id":"14aeb8c3ec66b749"} {"level":"info","ts":"2026-02-13T06:55:17.888776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=()"} {"level":"info","ts":"2026-02-13T06:55:17.888799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 0"} {"level":"info","ts":"2026-02-13T06:55:17.888807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e5729930cf7e1f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-13T06:55:17.888816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 1"} {"level":"info","ts":"2026-02-13T06:55:17.888869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"warn","ts":"2026-02-13T06:55:17.947988Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-13T06:55:17.952065Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-13T06:55:17.957685Z","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-02-13T06:55:17.967794Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e5729930cf7e1f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-13T06:55:17.971981Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e5729930cf7e1f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-13T06:55:17.972591Z","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-02-13T06:55:17.972669Z","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-02-13T06:55:17.97268Z","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-02-13T06:55:17.977779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"info","ts":"2026-02-13T06:55:17.9779Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","added-peer-id":"f1e5729930cf7e1f","added-peer-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-02-13T06:55:17.986022Z","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-02-13T06:55:17.986227Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-02-13T06:55:17.986392Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e5729930cf7e1f","initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-13T06:55:17.986422Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-13T06:55:17.986363Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-02-13T06:55:18.289141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f is starting a new election at term 1"} {"level":"info","ts":"2026-02-13T06:55:18.289226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became pre-candidate at term 1"} {"level":"info","ts":"2026-02-13T06:55:18.28925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgPreVoteResp from f1e5729930cf7e1f at term 1"} {"level":"info","ts":"2026-02-13T06:55:18.289277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became candidate at term 2"} {"level":"info","ts":"2026-02-13T06:55:18.289313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgVoteResp from f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-02-13T06:55:18.289332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became leader at term 2"} {"level":"info","ts":"2026-02-13T06:55:18.289348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e5729930cf7e1f elected leader f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-02-13T06:55:18.294029Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T06:55:18.295404Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T06:55:18.296117Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e5729930cf7e1f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.33:2379]}","request-path":"/0/members/f1e5729930cf7e1f/attributes","cluster-id":"14aeb8c3ec66b749","publish-timeout":"7s"} {"level":"info","ts":"2026-02-13T06:55:18.296318Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-13T06:55:18.298777Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-13T06:55:18.298823Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-13T06:55:18.300067Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-13T06:55:18.301423Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.33:2379"} {"level":"info","ts":"2026-02-13T06:55:18.322997Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T06:55:18.323912Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T06:55:18.323987Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-13T06:55:26.353117Z","caller":"traceutil/trace.go:171","msg":"trace[2091093315] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"238.375345ms","start":"2026-02-13T06:55:26.114719Z","end":"2026-02-13T06:55:26.353094Z","steps":["trace[2091093315] 'process raft request' (duration: 238.214783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:55:26.739632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.117639ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-13T06:55:26.739708Z","caller":"traceutil/trace.go:171","msg":"trace[2017614833] linearizableReadLoop","detail":"{readStateIndex:301; appliedIndex:300; }","duration":"281.211495ms","start":"2026-02-13T06:55:26.458486Z","end":"2026-02-13T06:55:26.739697Z","steps":["trace[2017614833] 'read index received' (duration: 111.642652ms)","trace[2017614833] 'applied index is now lower than readState.Index' (duration: 169.568103ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:55:26.739894Z","caller":"traceutil/trace.go:171","msg":"trace[1250857834] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"377.565935ms","start":"2026-02-13T06:55:26.362321Z","end":"2026-02-13T06:55:26.739887Z","steps":["trace[1250857834] 'process raft request' (duration: 207.890062ms)","trace[1250857834] 'compare' (duration: 169.022338ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:55:26.739929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:55:26.362294Z","time spent":"377.620526ms","remote":"127.0.0.1:42626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-13T06:55:26.740116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.623908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-13T06:55:26.740138Z","caller":"traceutil/trace.go:171","msg":"trace[1840806304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:292; }","duration":"281.680258ms","start":"2026-02-13T06:55:26.458452Z","end":"2026-02-13T06:55:26.740133Z","steps":["trace[1840806304] 'agreement among raft nodes before linearized reading' (duration: 281.569088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:55:26.740241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.05069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-13T06:55:26.740259Z","caller":"traceutil/trace.go:171","msg":"trace[801745399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:292; }","duration":"276.09426ms","start":"2026-02-13T06:55:26.46416Z","end":"2026-02-13T06:55:26.740255Z","steps":["trace[801745399] 'agreement among raft nodes before linearized reading' (duration: 276.0609ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:55:46.555531Z","caller":"traceutil/trace.go:171","msg":"trace[2002544025] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"130.066449ms","start":"2026-02-13T06:55:46.425442Z","end":"2026-02-13T06:55:46.555508Z","steps":["trace[2002544025] 'process raft request' (duration: 129.943676ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:55:53.050908Z","caller":"traceutil/trace.go:171","msg":"trace[1266739370] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"109.039789ms","start":"2026-02-13T06:55:52.941853Z","end":"2026-02-13T06:55:53.050893Z","steps":["trace[1266739370] 'process raft request' (duration: 108.727181ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:55:54.520284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.619033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:55:54.520362Z","caller":"traceutil/trace.go:171","msg":"trace[1595494092] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"736.761677ms","start":"2026-02-13T06:55:53.783583Z","end":"2026-02-13T06:55:54.520345Z","steps":["trace[1595494092] 'range keys from in-memory index tree' (duration: 736.51656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:55:54.520406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:55:53.783564Z","time spent":"736.833089ms","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-13T06:55:54.520412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.426383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:55:54.520486Z","caller":"traceutil/trace.go:171","msg":"trace[1504767871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"684.543017ms","start":"2026-02-13T06:55:53.835924Z","end":"2026-02-13T06:55:54.520467Z","steps":["trace[1504767871] 'range keys from in-memory index tree' (duration: 684.325261ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:55:54.520527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:55:53.83588Z","time spent":"684.63696ms","remote":"127.0.0.1:42420","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-02-13T06:55:54.520687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.574192ms","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-02-13T06:55:54.520744Z","caller":"traceutil/trace.go:171","msg":"trace[213590551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:515; }","duration":"846.665045ms","start":"2026-02-13T06:55:53.674064Z","end":"2026-02-13T06:55:54.520729Z","steps":["trace[213590551] 'range keys from in-memory index tree' (duration: 846.49024ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:55:54.520776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:55:53.674046Z","time spent":"846.722536ms","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-13T06:55:54.529402Z","caller":"traceutil/trace.go:171","msg":"trace[860071525] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"415.075831ms","start":"2026-02-13T06:55:54.114215Z","end":"2026-02-13T06:55:54.529291Z","steps":["trace[860071525] 'process raft request' (duration: 414.965878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:55:54.529744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:55:54.114192Z","time spent":"415.258766ms","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-13T06:55:54.545209Z","caller":"traceutil/trace.go:171","msg":"trace[560278760] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"136.741983ms","start":"2026-02-13T06:55:54.408112Z","end":"2026-02-13T06:55:54.544854Z","steps":["trace[560278760] 'process raft request' (duration: 136.61341ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:56:37.056685Z","caller":"traceutil/trace.go:171","msg":"trace[1885014490] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"294.248544ms","start":"2026-02-13T06:56:36.76241Z","end":"2026-02-13T06:56:37.056658Z","steps":["trace[1885014490] 'process raft request' (duration: 294.130582ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:56:37.058422Z","caller":"traceutil/trace.go:171","msg":"trace[271968777] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"293.896178ms","start":"2026-02-13T06:56:36.764495Z","end":"2026-02-13T06:56:37.058391Z","steps":["trace[271968777] 'process raft request' (duration: 293.652803ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:56:37.060671Z","caller":"traceutil/trace.go:171","msg":"trace[415906456] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"261.066505ms","start":"2026-02-13T06:56:36.799582Z","end":"2026-02-13T06:56:37.060649Z","steps":["trace[415906456] 'read index received' (duration: 257.563744ms)","trace[415906456] 'applied index is now lower than readState.Index' (duration: 3.501511ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:56:37.060998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.387081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-13T06:56:37.061626Z","caller":"traceutil/trace.go:171","msg":"trace[570984615] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"262.051622ms","start":"2026-02-13T06:56:36.799556Z","end":"2026-02-13T06:56:37.061608Z","steps":["trace[570984615] 'agreement among raft nodes before linearized reading' (duration: 261.241398ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:56:37.06261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.222579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:56:37.062998Z","caller":"traceutil/trace.go:171","msg":"trace[1272693907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"231.377291ms","start":"2026-02-13T06:56:36.831605Z","end":"2026-02-13T06:56:37.062982Z","steps":["trace[1272693907] 'agreement among raft nodes before linearized reading' (duration: 230.21896ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:05.705724Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:06.206832Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:06.707973Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:07.208717Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:07.709468Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:08.210451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:08.711304Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:08.83291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000957126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:08.833001Z","caller":"traceutil/trace.go:171","msg":"trace[641087933] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001098068s","start":"2026-02-13T06:57:06.83188Z","end":"2026-02-13T06:57:08.832978Z","steps":["trace[641087933] 'agreement among raft nodes before linearized reading' (duration: 2.000983536s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:08.833284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:06.831867Z","time spent":"2.001401782s","remote":"127.0.0.1:42420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:08 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:09.212551Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:09.713309Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:10.194252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:05.195157Z","time spent":"4.99908735s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:10.198124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:05.198581Z","time spent":"4.999533816s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/02/13 06:57:10 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:10.205574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000309954s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:10.205819Z","caller":"traceutil/trace.go:171","msg":"trace[1964173519] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.000400586s","start":"2026-02-13T06:57:05.205216Z","end":"2026-02-13T06:57:10.205617Z","steps":["trace[1964173519] 'agreement among raft nodes before linearized reading' (duration: 5.000325105s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:10.20591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:05.205206Z","time spent":"5.00068923s","remote":"127.0.0.1:42682","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\" "} {"level":"warn","ts":"2026-02-13T06:57:10.214194Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:10.237869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000247433s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:10.23797Z","caller":"traceutil/trace.go:171","msg":"trace[401819073] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000379995s","start":"2026-02-13T06:57:08.237572Z","end":"2026-02-13T06:57:10.237952Z","steps":["trace[401819073] 'agreement among raft nodes before linearized reading' (duration: 2.000266013s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:10.238049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:08.237554Z","time spent":"2.000482846s","remote":"127.0.0.1:42420","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-02-13T06:57:10.714851Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:10.833651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000494581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:10.833825Z","caller":"traceutil/trace.go:171","msg":"trace[270743061] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000737574s","start":"2026-02-13T06:57:08.833069Z","end":"2026-02-13T06:57:10.833806Z","steps":["trace[270743061] 'agreement among raft nodes before linearized reading' (duration: 2.000548582s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:10.834333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:08.833048Z","time spent":"2.001268762s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:10 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:11.215787Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:11.716408Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021138,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:12.205319Z","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-02-13T06:57:12.706043Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:12.841371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000105381s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:12.841489Z","caller":"traceutil/trace.go:171","msg":"trace[1397298391] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000264184s","start":"2026-02-13T06:57:10.841205Z","end":"2026-02-13T06:57:12.84147Z","steps":["trace[1397298391] 'agreement among raft nodes before linearized reading' (duration: 2.000135412s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:12.841572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:10.841191Z","time spent":"2.000369165s","remote":"127.0.0.1:42420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:12 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:12.955149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:05.954037Z","time spent":"7.001109674s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:13.206697Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:13.707035Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:14.075534Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538819","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:14.20817Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:14.70834Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:14.841517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999602603s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:14.841601Z","caller":"traceutil/trace.go:171","msg":"trace[930263754] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999787946s","start":"2026-02-13T06:57:12.841793Z","end":"2026-02-13T06:57:14.841581Z","steps":["trace[930263754] 'agreement among raft nodes before linearized reading' (duration: 1.999688085s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:14.841658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:12.841769Z","time spent":"1.999877937s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:15.192426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.994098123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:15.192611Z","caller":"traceutil/trace.go:171","msg":"trace[1890291885] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.994297706s","start":"2026-02-13T06:57:12.198292Z","end":"2026-02-13T06:57:15.19259Z","steps":["trace[1890291885] 'agreement among raft nodes before linearized reading' (duration: 2.994097203s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:15.192817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:12.198284Z","time spent":"2.994463788s","remote":"127.0.0.1:42682","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/02/13 06:57:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:15.204832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.004586341s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:15.204894Z","caller":"traceutil/trace.go:171","msg":"trace[782379801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"3.004693473s","start":"2026-02-13T06:57:12.200185Z","end":"2026-02-13T06:57:15.204878Z","steps":["trace[782379801] 'agreement among raft nodes before linearized reading' (duration: 3.004614212s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:15.204942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:12.200175Z","time spent":"3.004750804s","remote":"127.0.0.1:42682","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/02/13 06:57:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:15.208389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.000195028s","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-02-13T06:57:15.208441Z","caller":"traceutil/trace.go:171","msg":"trace[1908202638] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"3.000272189s","start":"2026-02-13T06:57:12.208156Z","end":"2026-02-13T06:57:15.208428Z","steps":["trace[1908202638] 'agreement among raft nodes before linearized reading' (duration: 3.000206168s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:15.208469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:12.208149Z","time spent":"3.000314109s","remote":"127.0.0.1:42682","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/02/13 06:57:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:15.208505Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:15.412646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.000128751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:15.412763Z","caller":"traceutil/trace.go:171","msg":"trace[989517266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"10.000304803s","start":"2026-02-13T06:57:05.412443Z","end":"2026-02-13T06:57:15.412748Z","steps":["trace[989517266] 'agreement among raft nodes before linearized reading' (duration: 10.000173211s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:15.412854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:05.412423Z","time spent":"10.000417666s","remote":"127.0.0.1:42682","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/02/13 06:57:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:15.417234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999900255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:15.417321Z","caller":"traceutil/trace.go:171","msg":"trace[824494870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"10.000052377s","start":"2026-02-13T06:57:05.417256Z","end":"2026-02-13T06:57:15.417308Z","steps":["trace[824494870] 'agreement among raft nodes before linearized reading' (duration: 9.999931315s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:15.417408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:05.417238Z","time spent":"10.000158828s","remote":"127.0.0.1:42682","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/02/13 06:57:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:15.70895Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:16.209744Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:16.710038Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:16.850317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000644897s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:16.850488Z","caller":"traceutil/trace.go:171","msg":"trace[821787855] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00084889s","start":"2026-02-13T06:57:14.849617Z","end":"2026-02-13T06:57:16.850466Z","steps":["trace[821787855] 'agreement among raft nodes before linearized reading' (duration: 2.000664327s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:16.850591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:14.849602Z","time spent":"2.000972151s","remote":"127.0.0.1:42420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:16 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:17.210873Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:17.241729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:10.241464Z","time spent":"7.000259343s","remote":"127.0.0.1:42506","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:17.711747Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:18.212915Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:18.713733Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021146,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:18.850316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000014412s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:18.850363Z","caller":"traceutil/trace.go:171","msg":"trace[1761031323] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000117313s","start":"2026-02-13T06:57:16.850234Z","end":"2026-02-13T06:57:18.850351Z","steps":["trace[1761031323] 'agreement among raft nodes before linearized reading' (duration: 2.000057642s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:18.85039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:16.850214Z","time spent":"2.000170834s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:19.199122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:12.198164Z","time spent":"7.000950656s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:19.20556Z","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-02-13T06:57:19.205754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.606029567s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:19.205843Z","caller":"traceutil/trace.go:171","msg":"trace[899349265] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; }","duration":"12.606146388s","start":"2026-02-13T06:57:06.599643Z","end":"2026-02-13T06:57:19.20579Z","steps":["trace[899349265] 'agreement among raft nodes before linearized reading' (duration: 12.606054547s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:19.205976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:06.599628Z","time spent":"12.606253679s","remote":"127.0.0.1:45850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:19.206095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.344719784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.33\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:19.206166Z","caller":"traceutil/trace.go:171","msg":"trace[1187472089] range","detail":"{range_begin:/registry/masterleases/199.204.45.33; range_end:; }","duration":"7.344796995s","start":"2026-02-13T06:57:11.861323Z","end":"2026-02-13T06:57:19.20612Z","steps":["trace[1187472089] 'agreement among raft nodes before linearized reading' (duration: 7.344757954s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:19.206244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:11.861303Z","time spent":"7.344892547s","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/199.204.45.33\" "} {"level":"warn","ts":"2026-02-13T06:57:19.206331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.323268782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:19.206365Z","caller":"traceutil/trace.go:171","msg":"trace[659372162] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; }","duration":"9.323342893s","start":"2026-02-13T06:57:09.883012Z","end":"2026-02-13T06:57:19.206355Z","steps":["trace[659372162] 'agreement among raft nodes before linearized reading' (duration: 9.323268682s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:19.206438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:09.882953Z","time spent":"9.323474875s","remote":"127.0.0.1:42756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":0,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:19.206848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.24351901s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:19.207Z","caller":"traceutil/trace.go:171","msg":"trace[1558850569] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; }","duration":"7.243730633s","start":"2026-02-13T06:57:11.963251Z","end":"2026-02-13T06:57:19.206981Z","steps":["trace[1558850569] 'agreement among raft nodes before linearized reading' (duration: 7.242377385s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:19.207554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:11.963236Z","time spent":"7.244298801s","remote":"127.0.0.1:42920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":0,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:19.207672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.6032371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:19.207756Z","caller":"traceutil/trace.go:171","msg":"trace[1282869734] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; }","duration":"13.603345912s","start":"2026-02-13T06:57:05.604395Z","end":"2026-02-13T06:57:19.207741Z","steps":["trace[1282869734] 'agreement among raft nodes before linearized reading' (duration: 13.603264201s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:19.20783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:05.604378Z","time spent":"13.603438663s","remote":"127.0.0.1:42574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":0,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:19.207782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.82964779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:19.207927Z","caller":"traceutil/trace.go:171","msg":"trace[1114278046] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; }","duration":"13.829823083s","start":"2026-02-13T06:57:05.378091Z","end":"2026-02-13T06:57:19.207914Z","steps":["trace[1114278046] 'agreement among raft nodes before linearized reading' (duration: 13.829671581s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:19.208051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:05.378077Z","time spent":"13.829922245s","remote":"127.0.0.1:42524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":0,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-13T06:57:19.70627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:19.96042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:12.959364Z","time spent":"7.001049265s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:20.195919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:15.205151Z","time spent":"4.990759905s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/02/13 06:57:20 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:20.206849Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:20.207802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:15.208617Z","time spent":"4.999181101s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/02/13 06:57:20 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:20.240295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000754196s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:20.240392Z","caller":"traceutil/trace.go:171","msg":"trace[1324447544] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000885678s","start":"2026-02-13T06:57:18.239472Z","end":"2026-02-13T06:57:20.240358Z","steps":["trace[1324447544] 'agreement among raft nodes before linearized reading' (duration: 2.000766706s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:20.240451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:18.239458Z","time spent":"2.000978549s","remote":"127.0.0.1:42420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:20 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:20.707907Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:20.862031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000733712s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:20.862172Z","caller":"traceutil/trace.go:171","msg":"trace[673602920] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000915914s","start":"2026-02-13T06:57:18.861234Z","end":"2026-02-13T06:57:20.86215Z","steps":["trace[673602920] 'agreement among raft nodes before linearized reading' (duration: 2.000762832s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:20.863523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:18.861222Z","time spent":"2.002276683s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:20 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:21.082999Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538819","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:21.209021Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:21.710077Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:22.211204Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:22.415984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:15.415152Z","time spent":"7.000823652s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:22.419539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:15.419223Z","time spent":"7.000312622s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:22.711451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:22.871017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000349164s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:22.871183Z","caller":"traceutil/trace.go:171","msg":"trace[1917861735] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000556036s","start":"2026-02-13T06:57:20.870594Z","end":"2026-02-13T06:57:22.87115Z","steps":["trace[1917861735] 'agreement among raft nodes before linearized reading' (duration: 2.000337403s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:22.871262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:20.870545Z","time spent":"2.000703699s","remote":"127.0.0.1:42420","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-02-13T06:57:23.212158Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:23.71342Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:24.087245Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538875","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:24.214375Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:24.246341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:17.245469Z","time spent":"7.000865421s","remote":"127.0.0.1:42506","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:24.714821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:24.871618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000309232s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:24.871703Z","caller":"traceutil/trace.go:171","msg":"trace[1826088863] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000584745s","start":"2026-02-13T06:57:22.871099Z","end":"2026-02-13T06:57:24.871683Z","steps":["trace[1826088863] 'agreement among raft nodes before linearized reading' (duration: 2.000482334s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:24.871769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:22.871056Z","time spent":"2.000701577s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:24 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:25.21539Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:25.715762Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021157,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:26.205136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:19.204704Z","time spent":"7.000421246s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:26.205634Z","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-02-13T06:57:26.205833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.349971877s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:26.205901Z","caller":"traceutil/trace.go:171","msg":"trace[68261638] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; }","duration":"7.350049208s","start":"2026-02-13T06:57:18.855828Z","end":"2026-02-13T06:57:26.205877Z","steps":["trace[68261638] 'agreement among raft nodes before linearized reading' (duration: 7.349969927s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:26.205959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:18.855807Z","time spent":"7.350130698s","remote":"127.0.0.1:42610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":0,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-02-13T06:57:26.206019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.436409166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:26.206042Z","caller":"traceutil/trace.go:171","msg":"trace[364293223] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; }","duration":"7.436466457s","start":"2026-02-13T06:57:18.769568Z","end":"2026-02-13T06:57:26.206034Z","steps":["trace[364293223] 'agreement among raft nodes before linearized reading' (duration: 7.436438206s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:26.206075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:18.769549Z","time spent":"7.436518907s","remote":"127.0.0.1:42892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":0,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:26.206108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.823224104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:26.206146Z","caller":"traceutil/trace.go:171","msg":"trace[127065498] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; }","duration":"7.823278805s","start":"2026-02-13T06:57:18.382844Z","end":"2026-02-13T06:57:26.206122Z","steps":["trace[127065498] 'agreement among raft nodes before linearized reading' (duration: 7.823256505s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:26.206173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:18.382821Z","time spent":"7.823342557s","remote":"127.0.0.1:42822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":0,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:26.206208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.343023197s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:26.206233Z","caller":"traceutil/trace.go:171","msg":"trace[2052566021] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; }","duration":"11.343070797s","start":"2026-02-13T06:57:14.863156Z","end":"2026-02-13T06:57:26.206227Z","steps":["trace[2052566021] 'agreement among raft nodes before linearized reading' (duration: 11.343043067s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:26.206258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:14.863145Z","time spent":"11.343105318s","remote":"127.0.0.1:45840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:26.206291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.556308949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:26.207942Z","caller":"traceutil/trace.go:171","msg":"trace[165863326] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; }","duration":"11.558025202s","start":"2026-02-13T06:57:14.649902Z","end":"2026-02-13T06:57:26.207927Z","steps":["trace[165863326] 'agreement among raft nodes before linearized reading' (duration: 11.55638062s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:26.208036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:14.649882Z","time spent":"11.558104433s","remote":"127.0.0.1:42774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":0,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:26.208115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.037698463s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:26.208169Z","caller":"traceutil/trace.go:171","msg":"trace[1165822113] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; }","duration":"12.037782514s","start":"2026-02-13T06:57:14.170352Z","end":"2026-02-13T06:57:26.208134Z","steps":["trace[1165822113] 'agreement among raft nodes before linearized reading' (duration: 12.037727593s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:26.208208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:14.170333Z","time spent":"12.037864275s","remote":"127.0.0.1:42722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":0,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:26.208307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.695671289s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:26.208338Z","caller":"traceutil/trace.go:171","msg":"trace[312927035] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; }","duration":"13.695752039s","start":"2026-02-13T06:57:12.51258Z","end":"2026-02-13T06:57:26.208332Z","steps":["trace[312927035] 'agreement among raft nodes before linearized reading' (duration: 13.695689399s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:26.208429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:12.512571Z","time spent":"13.69582186s","remote":"127.0.0.1:45798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:26.208478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.697917439s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:26.208532Z","caller":"traceutil/trace.go:171","msg":"trace[1176634087] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; }","duration":"13.698016071s","start":"2026-02-13T06:57:12.510508Z","end":"2026-02-13T06:57:26.208524Z","steps":["trace[1176634087] 'agreement among raft nodes before linearized reading' (duration: 13.6979591s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:26.208596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:12.510488Z","time spent":"13.698097862s","remote":"127.0.0.1:45894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:26.706501Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:26.880501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000567057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:26.880614Z","caller":"traceutil/trace.go:171","msg":"trace[1346104724] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000725019s","start":"2026-02-13T06:57:24.879862Z","end":"2026-02-13T06:57:26.880587Z","steps":["trace[1346104724] 'agreement among raft nodes before linearized reading' (duration: 2.000583167s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:26.881674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:24.879847Z","time spent":"2.001807805s","remote":"127.0.0.1:42420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:26 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:26.966132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:19.96536Z","time spent":"7.000768891s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:27.207047Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:27.707169Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:28.091793Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538819","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:28.208362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:28.709275Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:28.881949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000255124s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:28.882142Z","caller":"traceutil/trace.go:171","msg":"trace[1150973450] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000533998s","start":"2026-02-13T06:57:26.881504Z","end":"2026-02-13T06:57:28.882038Z","steps":["trace[1150973450] 'agreement among raft nodes before linearized reading' (duration: 2.000305425s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:28.882274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:26.881476Z","time spent":"2.000784581s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:28 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:29.210062Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:29.710312Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:30.210809Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:30.240048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999820037s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:30.24018Z","caller":"traceutil/trace.go:171","msg":"trace[1120937978] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00001377s","start":"2026-02-13T06:57:28.240139Z","end":"2026-02-13T06:57:30.240153Z","steps":["trace[1120937978] 'agreement among raft nodes before linearized reading' (duration: 1.999859407s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:30.240688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:28.240104Z","time spent":"2.000566638s","remote":"127.0.0.1:42420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:30 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:30.711092Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:30.888416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000313999s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:30.888542Z","caller":"traceutil/trace.go:171","msg":"trace[1006660386] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00046766s","start":"2026-02-13T06:57:28.888057Z","end":"2026-02-13T06:57:30.888525Z","steps":["trace[1006660386] 'agreement among raft nodes before linearized reading' (duration: 2.000338949s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:30.888619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:28.888047Z","time spent":"2.000561561s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:30 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:31.094639Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538875","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:31.212144Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:31.712937Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:32.213795Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:32.714074Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021161,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:32.895019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999966417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:32.895204Z","caller":"traceutil/trace.go:171","msg":"trace[833969508] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00020806s","start":"2026-02-13T06:57:30.89497Z","end":"2026-02-13T06:57:32.895178Z","steps":["trace[833969508] 'agreement among raft nodes before linearized reading' (duration: 2.000002688s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:32.895362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:30.894956Z","time spent":"2.000387052s","remote":"127.0.0.1:42420","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-02-13T06:57:33.206791Z","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-02-13T06:57:33.206989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.670866096s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:33.20707Z","caller":"traceutil/trace.go:171","msg":"trace[2058882316] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; }","duration":"7.670999159s","start":"2026-02-13T06:57:25.536036Z","end":"2026-02-13T06:57:33.207035Z","steps":["trace[2058882316] 'agreement among raft nodes before linearized reading' (duration: 7.670896037s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:33.207127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:25.536018Z","time spent":"7.67109309s","remote":"127.0.0.1:42908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":0,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:33.207183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.414446614s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:33.207205Z","caller":"traceutil/trace.go:171","msg":"trace[1965493022] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; }","duration":"8.414511565s","start":"2026-02-13T06:57:24.792686Z","end":"2026-02-13T06:57:33.207197Z","steps":["trace[1965493022] 'agreement among raft nodes before linearized reading' (duration: 8.414488285s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:33.207229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:24.792667Z","time spent":"8.414555415s","remote":"127.0.0.1:42614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":0,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:33.207268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.952857874s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1893bc0a484051e9\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:33.207291Z","caller":"traceutil/trace.go:171","msg":"trace[2047120858] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1893bc0a484051e9; range_end:; }","duration":"8.952923145s","start":"2026-02-13T06:57:24.254359Z","end":"2026-02-13T06:57:33.207283Z","steps":["trace[2047120858] 'agreement among raft nodes before linearized reading' (duration: 8.952902015s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:33.207314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:24.254334Z","time spent":"8.952973775s","remote":"127.0.0.1:42506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":0,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.1893bc0a484051e9\" "} {"level":"warn","ts":"2026-02-13T06:57:33.207347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.003361137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:33.207372Z","caller":"traceutil/trace.go:171","msg":"trace[406504181] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; }","duration":"10.003415577s","start":"2026-02-13T06:57:23.203949Z","end":"2026-02-13T06:57:33.207365Z","steps":["trace[406504181] 'agreement among raft nodes before linearized reading' (duration: 10.003389347s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:33.207396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:23.203936Z","time spent":"10.003452697s","remote":"127.0.0.1:42780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":0,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:33.20743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.10757632s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:33.20745Z","caller":"traceutil/trace.go:171","msg":"trace[973447013] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; }","duration":"11.10763068s","start":"2026-02-13T06:57:22.099814Z","end":"2026-02-13T06:57:33.207444Z","steps":["trace[973447013] 'agreement among raft nodes before linearized reading' (duration: 11.10760878s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:33.207473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:22.099794Z","time spent":"11.10767248s","remote":"127.0.0.1:42730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":0,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:33.207503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.345182125s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.33\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:33.207544Z","caller":"traceutil/trace.go:171","msg":"trace[765061064] range","detail":"{range_begin:/registry/masterleases/199.204.45.33; range_end:; }","duration":"11.345270216s","start":"2026-02-13T06:57:21.862268Z","end":"2026-02-13T06:57:33.207538Z","steps":["trace[765061064] 'agreement among raft nodes before linearized reading' (duration: 11.345228226s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:33.207567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:21.86224Z","time spent":"11.345321257s","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/199.204.45.33\" "} {"level":"warn","ts":"2026-02-13T06:57:33.207601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.965859112s","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-02-13T06:57:33.207624Z","caller":"traceutil/trace.go:171","msg":"trace[462083079] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; }","duration":"12.965881162s","start":"2026-02-13T06:57:20.241734Z","end":"2026-02-13T06:57:33.207615Z","steps":["trace[462083079] 'agreement among raft nodes before linearized reading' (duration: 12.965858942s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:33.207651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:20.241671Z","time spent":"12.965972334s","remote":"127.0.0.1:42664","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":"warn","ts":"2026-02-13T06:57:33.214765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:26.214495Z","time spent":"7.000266262s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:33.707597Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:33.972698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:26.971796Z","time spent":"7.000892509s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:34.20867Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:34.709844Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:34.897005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000466907s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:34.89709Z","caller":"traceutil/trace.go:171","msg":"trace[288492781] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000614298s","start":"2026-02-13T06:57:32.896454Z","end":"2026-02-13T06:57:34.897068Z","steps":["trace[288492781] 'agreement among raft nodes before linearized reading' (duration: 2.000506917s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:34.897129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:32.896433Z","time spent":"2.000688989s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:34 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:35.097728Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538819","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:35.210287Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:35.711245Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:36.212273Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:36.713222Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:36.903485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000209515s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:36.903554Z","caller":"traceutil/trace.go:171","msg":"trace[48278204] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000332016s","start":"2026-02-13T06:57:34.903199Z","end":"2026-02-13T06:57:36.903531Z","steps":["trace[48278204] 'agreement among raft nodes before linearized reading' (duration: 2.000233804s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:36.90367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:34.903165Z","time spent":"2.000495808s","remote":"127.0.0.1:42420","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-02-13T06:57:37.214192Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:37.714542Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:38.101678Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538875","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:38.215446Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:38.716129Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:38.904228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00005914s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:38.904303Z","caller":"traceutil/trace.go:171","msg":"trace[1352558231] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000183241s","start":"2026-02-13T06:57:36.904097Z","end":"2026-02-13T06:57:38.90428Z","steps":["trace[1352558231] 'agreement among raft nodes before linearized reading' (duration: 2.00009331s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:38.90436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:36.904079Z","time spent":"2.000272612s","remote":"127.0.0.1:42432","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-02-13T06:57:39.216597Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:39.717538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021166,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:40.207659Z","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-02-13T06:57:40.207849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.631649867s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:40.20792Z","caller":"traceutil/trace.go:171","msg":"trace[1334658270] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; }","duration":"8.631801929s","start":"2026-02-13T06:57:31.576092Z","end":"2026-02-13T06:57:40.207894Z","steps":["trace[1334658270] 'agreement among raft nodes before linearized reading' (duration: 8.631707277s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:40.207988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:31.576065Z","time spent":"8.63190894s","remote":"127.0.0.1:42878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":0,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:40.208059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.119668939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:40.208096Z","caller":"traceutil/trace.go:171","msg":"trace[1771003425] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; }","duration":"9.11973127s","start":"2026-02-13T06:57:31.088357Z","end":"2026-02-13T06:57:40.208088Z","steps":["trace[1771003425] 'agreement among raft nodes before linearized reading' (duration: 9.11969213s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:40.208139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:31.088347Z","time spent":"9.119782761s","remote":"127.0.0.1:42670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":0,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:40.208191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.182524198s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:40.208228Z","caller":"traceutil/trace.go:171","msg":"trace[386276620] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; }","duration":"10.182619049s","start":"2026-02-13T06:57:30.025601Z","end":"2026-02-13T06:57:40.20822Z","steps":["trace[386276620] 'agreement among raft nodes before linearized reading' (duration: 10.182581748s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:40.208271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:30.025573Z","time spent":"10.18268753s","remote":"127.0.0.1:42806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":0,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:40.208333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.575380781s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:40.20837Z","caller":"traceutil/trace.go:171","msg":"trace[70555309] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; }","duration":"10.575469272s","start":"2026-02-13T06:57:29.632892Z","end":"2026-02-13T06:57:40.208362Z","steps":["trace[70555309] 'agreement among raft nodes before linearized reading' (duration: 10.575423911s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:40.208413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:29.632875Z","time spent":"10.575527492s","remote":"127.0.0.1:42850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":0,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:40.208467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.222465881s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:40.208503Z","caller":"traceutil/trace.go:171","msg":"trace[2007836408] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; }","duration":"13.222532072s","start":"2026-02-13T06:57:26.985963Z","end":"2026-02-13T06:57:40.208495Z","steps":["trace[2007836408] 'agreement among raft nodes before linearized reading' (duration: 13.222492752s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:40.208547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:26.985953Z","time spent":"13.222583083s","remote":"127.0.0.1:45842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:40.208599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.992415086s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:40.208635Z","caller":"traceutil/trace.go:171","msg":"trace[427649830] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; }","duration":"13.992471397s","start":"2026-02-13T06:57:26.216156Z","end":"2026-02-13T06:57:40.208627Z","steps":["trace[427649830] 'agreement among raft nodes before linearized reading' (duration: 13.992435176s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:40.208684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:26.216148Z","time spent":"13.992525918s","remote":"127.0.0.1:42610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":0,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-02-13T06:57:40.214283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:33.21368Z","time spent":"7.000596235s","remote":"127.0.0.1:42506","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:40.21914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:33.218461Z","time spent":"7.000676285s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:40.238852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999957223s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:40.239659Z","caller":"traceutil/trace.go:171","msg":"trace[729430709] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000810323s","start":"2026-02-13T06:57:38.238832Z","end":"2026-02-13T06:57:40.239643Z","steps":["trace[729430709] 'agreement among raft nodes before linearized reading' (duration: 1.999998493s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:40.239764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:38.238814Z","time spent":"2.000934804s","remote":"127.0.0.1:42420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:40 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:40.70783Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:40.911509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000561544s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:40.912257Z","caller":"traceutil/trace.go:171","msg":"trace[220901542] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001343094s","start":"2026-02-13T06:57:38.910869Z","end":"2026-02-13T06:57:40.912212Z","steps":["trace[220901542] 'agreement among raft nodes before linearized reading' (duration: 2.000594914s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:40.913218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:38.910855Z","time spent":"2.002344766s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:40 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:40.978398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:33.977953Z","time spent":"7.000439935s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:41.208632Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:41.709116Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:42.10336Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538819","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:42.210157Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:42.711385Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:42.920716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000695034s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:42.920823Z","caller":"traceutil/trace.go:171","msg":"trace[387220443] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000854277s","start":"2026-02-13T06:57:40.919943Z","end":"2026-02-13T06:57:42.920797Z","steps":["trace[387220443] 'agreement among raft nodes before linearized reading' (duration: 2.000729155s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:42.920897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:40.919927Z","time spent":"2.000956288s","remote":"127.0.0.1:42420","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-02-13T06:57:43.211738Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:43.712026Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:44.212572Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:44.712729Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:44.922464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000567537s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:44.922554Z","caller":"traceutil/trace.go:171","msg":"trace[2096012026] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000725349s","start":"2026-02-13T06:57:42.92181Z","end":"2026-02-13T06:57:44.922535Z","steps":["trace[2096012026] 'agreement among raft nodes before linearized reading' (duration: 2.000616988s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:44.922593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:42.921785Z","time spent":"2.0007991s","remote":"127.0.0.1:42432","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-02-13T06:57:45.109255Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538875","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:45.213407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:45.71432Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:46.214425Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:46.71485Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021173,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:46.929075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999859039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:46.929183Z","caller":"traceutil/trace.go:171","msg":"trace[98944201] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00000833s","start":"2026-02-13T06:57:44.929149Z","end":"2026-02-13T06:57:46.929158Z","steps":["trace[98944201] 'agreement among raft nodes before linearized reading' (duration: 1.999881809s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:46.929248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:44.929117Z","time spent":"2.000120562s","remote":"127.0.0.1:42420","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-02-13T06:57:47.208214Z","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-02-13T06:57:47.208364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.642978416s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:47.208419Z","caller":"traceutil/trace.go:171","msg":"trace[725819875] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; }","duration":"8.643095277s","start":"2026-02-13T06:57:38.565295Z","end":"2026-02-13T06:57:47.20839Z","steps":["trace[725819875] 'agreement among raft nodes before linearized reading' (duration: 8.643025516s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:47.208457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:38.565258Z","time spent":"8.643191209s","remote":"127.0.0.1:42534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":0,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:47.208501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.71618036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:47.208515Z","caller":"traceutil/trace.go:171","msg":"trace[753798644] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; }","duration":"12.716340512s","start":"2026-02-13T06:57:34.49217Z","end":"2026-02-13T06:57:47.208511Z","steps":["trace[753798644] 'agreement among raft nodes before linearized reading' (duration: 12.716326082s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:47.208536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:34.492145Z","time spent":"12.716386013s","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:47.208561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.996901696s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.33\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:47.208584Z","caller":"traceutil/trace.go:171","msg":"trace[1647904130] range","detail":"{range_begin:/registry/masterleases/199.204.45.33; range_end:; }","duration":"13.996957896s","start":"2026-02-13T06:57:33.211617Z","end":"2026-02-13T06:57:47.208575Z","steps":["trace[1647904130] 'agreement among raft nodes before linearized reading' (duration: 13.996940326s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:47.208599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:33.211599Z","time spent":"13.996996006s","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/199.204.45.33\" "} {"level":"warn","ts":"2026-02-13T06:57:47.223036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:40.222098Z","time spent":"7.000934375s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-02-13T06:57:47.708617Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:48.209283Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:48.710212Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:48.930608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000073085s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:48.930788Z","caller":"traceutil/trace.go:171","msg":"trace[35015926] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00027003s","start":"2026-02-13T06:57:46.930449Z","end":"2026-02-13T06:57:48.930719Z","steps":["trace[35015926] 'agreement among raft nodes before linearized reading' (duration: 2.000120387s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:48.93087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:46.930419Z","time spent":"2.000438471s","remote":"127.0.0.1:42432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/13 06:57:48 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:49.112413Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538819","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:49.211226Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:49.711688Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:50.212103Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:50.239331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999804014s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:50.239439Z","caller":"traceutil/trace.go:171","msg":"trace[1164998100] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999968786s","start":"2026-02-13T06:57:48.239443Z","end":"2026-02-13T06:57:50.239412Z","steps":["trace[1164998100] 'agreement among raft nodes before linearized reading' (duration: 1.999851265s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:50.239508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:48.239421Z","time spent":"2.000074047s","remote":"127.0.0.1:42420","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-02-13T06:57:50.713184Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:50.938685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000039686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:50.938898Z","caller":"traceutil/trace.go:171","msg":"trace[840119973] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00031004s","start":"2026-02-13T06:57:48.938556Z","end":"2026-02-13T06:57:50.938866Z","steps":["trace[840119973] 'agreement among raft nodes before linearized reading' (duration: 2.000067407s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:50.938985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:48.938538Z","time spent":"2.000430731s","remote":"127.0.0.1:42432","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-02-13T06:57:50.981609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.99949727s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-13T06:57:50.981684Z","caller":"traceutil/trace.go:171","msg":"trace[1962638503] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; }","duration":"9.999616651s","start":"2026-02-13T06:57:40.98205Z","end":"2026-02-13T06:57:50.981666Z","steps":["trace[1962638503] 'agreement among raft nodes before linearized reading' (duration: 9.99953272s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:50.981729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:40.982035Z","time spent":"9.999684862s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} 2026/02/13 06:57:50 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-13T06:57:51.213944Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:51.714404Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:52.115173Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538875","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:52.214927Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:52.715845Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:52.94914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000821403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:52.949303Z","caller":"traceutil/trace.go:171","msg":"trace[1658263558] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001048545s","start":"2026-02-13T06:57:50.948229Z","end":"2026-02-13T06:57:52.949278Z","steps":["trace[1658263558] 'agreement among raft nodes before linearized reading' (duration: 2.000845313s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:52.949387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:50.948213Z","time spent":"2.001159846s","remote":"127.0.0.1:42420","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-02-13T06:57:53.217022Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:53.718106Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021177,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:54.209374Z","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-02-13T06:57:54.20961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.639816007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:54.209681Z","caller":"traceutil/trace.go:171","msg":"trace[134847561] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; }","duration":"8.640035219s","start":"2026-02-13T06:57:45.569618Z","end":"2026-02-13T06:57:54.209653Z","steps":["trace[134847561] 'agreement among raft nodes before linearized reading' (duration: 8.639870167s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:54.209671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.416658156s","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":"warn","ts":"2026-02-13T06:57:54.20975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:45.569596Z","time spent":"8.640138251s","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"info","ts":"2026-02-13T06:57:54.209761Z","caller":"traceutil/trace.go:171","msg":"trace[263653859] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; }","duration":"12.416852049s","start":"2026-02-13T06:57:41.792889Z","end":"2026-02-13T06:57:54.209741Z","steps":["trace[263653859] 'agreement among raft nodes before linearized reading' (duration: 12.416695077s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:54.209812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:41.792855Z","time spent":"12.4169428s","remote":"127.0.0.1:42658","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":"warn","ts":"2026-02-13T06:57:54.209843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.996460651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:54.209873Z","caller":"traceutil/trace.go:171","msg":"trace[83993235] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; }","duration":"13.996535852s","start":"2026-02-13T06:57:40.213328Z","end":"2026-02-13T06:57:54.209864Z","steps":["trace[83993235] 'agreement among raft nodes before linearized reading' (duration: 13.996508342s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:54.209873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.723312889s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:54.2099Z","caller":"traceutil/trace.go:171","msg":"trace[632701759] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; }","duration":"10.72334514s","start":"2026-02-13T06:57:43.486549Z","end":"2026-02-13T06:57:54.209894Z","steps":["trace[632701759] 'agreement among raft nodes before linearized reading' (duration: 10.723312539s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:54.209899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:40.213307Z","time spent":"13.996585413s","remote":"127.0.0.1:42610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":0,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-02-13T06:57:54.209917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:43.486422Z","time spent":"10.723490652s","remote":"127.0.0.1:42904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":0,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:54.209817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.992807704s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1893bc0a484051e9\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-02-13T06:57:54.209953Z","caller":"traceutil/trace.go:171","msg":"trace[549752593] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1893bc0a484051e9; range_end:; }","duration":"13.992971746s","start":"2026-02-13T06:57:40.216975Z","end":"2026-02-13T06:57:54.209947Z","steps":["trace[549752593] 'agreement among raft nodes before linearized reading' (duration: 13.992833555s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:54.209969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:40.216968Z","time spent":"13.992996086s","remote":"127.0.0.1:42506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":0,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.1893bc0a484051e9\" "} {"level":"warn","ts":"2026-02-13T06:57:54.710401Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021180,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:54.950244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000427665s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:54.950338Z","caller":"traceutil/trace.go:171","msg":"trace[1414084448] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000543136s","start":"2026-02-13T06:57:52.949773Z","end":"2026-02-13T06:57:54.950317Z","steps":["trace[1414084448] 'agreement among raft nodes before linearized reading' (duration: 2.000422645s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:54.950387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:52.949693Z","time spent":"2.000683808s","remote":"127.0.0.1:42432","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-02-13T06:57:55.21086Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021180,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:55.711822Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021180,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:56.121686Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538819","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-02-13T06:57:56.212684Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021180,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:56.7135Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9088154465304021180,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-13T06:57:56.781882Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"51.58662265s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-13T06:57:56.96043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000419209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-13T06:57:56.960537Z","caller":"traceutil/trace.go:171","msg":"trace[2058722981] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000611641s","start":"2026-02-13T06:57:54.959904Z","end":"2026-02-13T06:57:56.960515Z","steps":["trace[2058722981] 'agreement among raft nodes before linearized reading' (duration: 2.000438179s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:56.960607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:54.959885Z","time spent":"2.000711482s","remote":"127.0.0.1:42420","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-02-13T06:57:57.026218Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"103.711µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.037311Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"2.810344ms","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.039783Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"15.5µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.040049Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"97.131µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.040116Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"6.83µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.07513Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"26.681µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.075194Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"2.89µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.075228Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"2.47µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.075244Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"2.65µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.075258Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"2.29µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.075272Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"2.07µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.075289Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"2.02µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"info","ts":"2026-02-13T06:57:57.075363Z","caller":"traceutil/trace.go:171","msg":"trace[2057721164] linearizableReadLoop","detail":"{readStateIndex:921; appliedIndex:888; }","duration":"2.865856074s","start":"2026-02-13T06:57:54.209456Z","end":"2026-02-13T06:57:57.075312Z","steps":["trace[2057721164] 'read index received' (duration: 2.572867888s)","trace[2057721164] 'applied index is now lower than readState.Index' (duration: 292.987166ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:57:57.075669Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538875","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.075685Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"7e1f9c55c8538819","error":"lease not found"} {"level":"warn","ts":"2026-02-13T06:57:57.075752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.129998144s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-13T06:57:57.075774Z","caller":"traceutil/trace.go:171","msg":"trace[1684693109] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:865; }","duration":"3.130030035s","start":"2026-02-13T06:57:53.945732Z","end":"2026-02-13T06:57:57.075762Z","steps":["trace[1684693109] 'agreement among raft nodes before linearized reading' (duration: 3.129962174s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.075796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:53.944728Z","time spent":"3.131062488s","remote":"127.0.0.1:42610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":11,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:57.075989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.210984712s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:57:57.076015Z","caller":"traceutil/trace.go:171","msg":"trace[1393013455] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:865; }","duration":"5.211007343s","start":"2026-02-13T06:57:51.864997Z","end":"2026-02-13T06:57:57.076004Z","steps":["trace[1393013455] 'agreement among raft nodes before linearized reading' (duration: 5.210962082s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.076032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:51.864894Z","time spent":"5.211132564s","remote":"127.0.0.1:45896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-13T06:57:57.07621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.892554649s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-02-13T06:57:57.076231Z","caller":"traceutil/trace.go:171","msg":"trace[22319915] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:865; }","duration":"5.89261472s","start":"2026-02-13T06:57:51.183605Z","end":"2026-02-13T06:57:57.07622Z","steps":["trace[22319915] 'agreement among raft nodes before linearized reading' (duration: 5.892531609s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.076246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:51.183586Z","time spent":"5.89265551s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-02-13T06:57:57.076388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.850393608s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:1 size:686"} {"level":"info","ts":"2026-02-13T06:57:57.076408Z","caller":"traceutil/trace.go:171","msg":"trace[208943119] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:1; response_revision:865; }","duration":"9.850435948s","start":"2026-02-13T06:57:47.225962Z","end":"2026-02-13T06:57:57.076398Z","steps":["trace[208943119] 'agreement among raft nodes before linearized reading' (duration: 9.850386968s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.076423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:47.225951Z","time spent":"9.850467919s","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":709,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-02-13T06:57:57.076535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.866686075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.33\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:57:57.076557Z","caller":"traceutil/trace.go:171","msg":"trace[1135666739] range","detail":"{range_begin:/registry/masterleases/199.204.45.33; range_end:; response_count:0; response_revision:865; }","duration":"9.866730875s","start":"2026-02-13T06:57:47.209816Z","end":"2026-02-13T06:57:57.076547Z","steps":["trace[1135666739] 'agreement among raft nodes before linearized reading' (duration: 9.866700375s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.076572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:47.209802Z","time spent":"9.866764626s","remote":"127.0.0.1:42446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.33\" "} {"level":"warn","ts":"2026-02-13T06:57:57.082368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.72456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:57:57.082446Z","caller":"traceutil/trace.go:171","msg":"trace[1340236206] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:865; }","duration":"266.852541ms","start":"2026-02-13T06:57:56.815575Z","end":"2026-02-13T06:57:57.082428Z","steps":["trace[1340236206] 'agreement among raft nodes before linearized reading' (duration: 265.92093ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.082564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.124247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:57:57.082583Z","caller":"traceutil/trace.go:171","msg":"trace[703490149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:865; }","duration":"121.182549ms","start":"2026-02-13T06:57:56.961394Z","end":"2026-02-13T06:57:57.082576Z","steps":["trace[703490149] 'agreement among raft nodes before linearized reading' (duration: 120.106065ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.082721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.867173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1893bc0a24c45d7a\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-13T06:57:57.087557Z","caller":"traceutil/trace.go:171","msg":"trace[398861050] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1893bc0a24c45d7a; range_end:; response_count:0; response_revision:865; }","duration":"2.86720938s","start":"2026-02-13T06:57:54.215529Z","end":"2026-02-13T06:57:57.082739Z","steps":["trace[398861050] 'agreement among raft nodes before linearized reading' (duration: 2.865973614s)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.087624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:54.21552Z","time spent":"2.87207995s","remote":"127.0.0.1:42506","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.1893bc0a24c45d7a\" "} {"level":"warn","ts":"2026-02-13T06:57:57.091156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.877457128s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7036"} {"level":"info","ts":"2026-02-13T06:57:57.091259Z","caller":"traceutil/trace.go:171","msg":"trace[638711672] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:865; }","duration":"2.877615829s","start":"2026-02-13T06:57:54.213612Z","end":"2026-02-13T06:57:57.091228Z","steps":["trace[638711672] 'agreement among raft nodes before linearized reading' (duration: 2.863068789s)","trace[638711672] 'get authentication metadata' (duration: 14.326928ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:57:57.091308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-13T06:57:54.21358Z","time spent":"2.877718761s","remote":"127.0.0.1:42610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7059,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-02-13T06:57:57.328894Z","caller":"traceutil/trace.go:171","msg":"trace[1043609603] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"118.445172ms","start":"2026-02-13T06:57:57.210418Z","end":"2026-02-13T06:57:57.328864Z","steps":["trace[1043609603] 'process raft request' (duration: 107.765111ms)","trace[1043609603] 'compare' (duration: 10.54046ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:57:57.330925Z","caller":"traceutil/trace.go:171","msg":"trace[873307167] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:930; }","duration":"102.478985ms","start":"2026-02-13T06:57:57.228429Z","end":"2026-02-13T06:57:57.330908Z","steps":["trace[873307167] 'read index received' (duration: 89.688097ms)","trace[873307167] 'applied index is now lower than readState.Index' (duration: 12.789768ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:57:57.33108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.625246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1893bc0a484051e9\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-02-13T06:57:57.331114Z","caller":"traceutil/trace.go:171","msg":"trace[557620265] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1893bc0a484051e9; range_end:; response_count:1; response_revision:873; }","duration":"102.701148ms","start":"2026-02-13T06:57:57.2284Z","end":"2026-02-13T06:57:57.331101Z","steps":["trace[557620265] 'agreement among raft nodes before linearized reading' (duration: 102.563706ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:57:57.578314Z","caller":"traceutil/trace.go:171","msg":"trace[1650465653] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"147.201667ms","start":"2026-02-13T06:57:57.431076Z","end":"2026-02-13T06:57:57.578278Z","steps":["trace[1650465653] 'process raft request' (duration: 146.507799ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:57:57.591988Z","caller":"traceutil/trace.go:171","msg":"trace[173347515] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"160.326069ms","start":"2026-02-13T06:57:57.431645Z","end":"2026-02-13T06:57:57.591971Z","steps":["trace[173347515] 'process raft request' (duration: 160.189988ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:57:57.591965Z","caller":"traceutil/trace.go:171","msg":"trace[414593220] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"160.144398ms","start":"2026-02-13T06:57:57.431786Z","end":"2026-02-13T06:57:57.59193Z","steps":["trace[414593220] 'read index received' (duration: 147.214599ms)","trace[414593220] 'applied index is now lower than readState.Index' (duration: 12.929229ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:57:57.592428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.522782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-13T06:57:57.592604Z","caller":"traceutil/trace.go:171","msg":"trace[1920695898] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:877; }","duration":"160.696665ms","start":"2026-02-13T06:57:57.431769Z","end":"2026-02-13T06:57:57.592466Z","steps":["trace[1920695898] 'agreement among raft nodes before linearized reading' (duration: 160.279109ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.592616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.257128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-13T06:57:57.592743Z","caller":"traceutil/trace.go:171","msg":"trace[1950546900] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:877; }","duration":"138.459541ms","start":"2026-02-13T06:57:57.454273Z","end":"2026-02-13T06:57:57.592733Z","steps":["trace[1950546900] 'agreement among raft nodes before linearized reading' (duration: 138.162817ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:57:57.794653Z","caller":"traceutil/trace.go:171","msg":"trace[2034809466] linearizableReadLoop","detail":"{readStateIndex:938; appliedIndex:937; }","duration":"173.957579ms","start":"2026-02-13T06:57:57.620643Z","end":"2026-02-13T06:57:57.7946Z","steps":["trace[2034809466] 'read index received' (duration: 99.153644ms)","trace[2034809466] 'applied index is now lower than readState.Index' (duration: 74.802505ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:57:57.795388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.680019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:471"} {"level":"info","ts":"2026-02-13T06:57:57.795481Z","caller":"traceutil/trace.go:171","msg":"trace[982552000] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:879; }","duration":"166.837481ms","start":"2026-02-13T06:57:57.628621Z","end":"2026-02-13T06:57:57.795459Z","steps":["trace[982552000] 'agreement among raft nodes before linearized reading' (duration: 166.588168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.796005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.355256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-cx6fr.1893bc0cbb3f13b7\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-02-13T06:57:57.796053Z","caller":"traceutil/trace.go:171","msg":"trace[175671885] range","detail":"{range_begin:/registry/events/kube-system/cilium-operator-7fcd8d6ffd-cx6fr.1893bc0cbb3f13b7; range_end:; response_count:1; response_revision:879; }","duration":"175.431746ms","start":"2026-02-13T06:57:57.620607Z","end":"2026-02-13T06:57:57.796039Z","steps":["trace[175671885] 'agreement among raft nodes before linearized reading' (duration: 175.312665ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:57:57.80028Z","caller":"traceutil/trace.go:171","msg":"trace[248104510] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"191.489215ms","start":"2026-02-13T06:57:57.603492Z","end":"2026-02-13T06:57:57.794981Z","steps":["trace[248104510] 'process raft request' (duration: 116.398478ms)","trace[248104510] 'compare' (duration: 74.45209ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:57:57.961555Z","caller":"traceutil/trace.go:171","msg":"trace[1721630249] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"120.70083ms","start":"2026-02-13T06:57:57.840805Z","end":"2026-02-13T06:57:57.961505Z","steps":["trace[1721630249] 'process raft request' (duration: 71.029858ms)","trace[1721630249] 'compare' (duration: 49.49723ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:57:57.978337Z","caller":"traceutil/trace.go:171","msg":"trace[469252482] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:940; }","duration":"135.163119ms","start":"2026-02-13T06:57:57.843155Z","end":"2026-02-13T06:57:57.978318Z","steps":["trace[469252482] 'read index received' (duration: 69.243716ms)","trace[469252482] 'applied index is now lower than readState.Index' (duration: 65.918483ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:57:57.978436Z","caller":"traceutil/trace.go:171","msg":"trace[1898843160] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"137.343277ms","start":"2026-02-13T06:57:57.841081Z","end":"2026-02-13T06:57:57.978425Z","steps":["trace[1898843160] 'process raft request' (duration: 137.105614ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.979398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.551104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-13T06:57:57.979447Z","caller":"traceutil/trace.go:171","msg":"trace[22325775] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:883; }","duration":"136.302364ms","start":"2026-02-13T06:57:57.843136Z","end":"2026-02-13T06:57:57.979439Z","steps":["trace[22325775] 'agreement among raft nodes before linearized reading' (duration: 135.437532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.98619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.19481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-13T06:57:57.986234Z","caller":"traceutil/trace.go:171","msg":"trace[1600221987] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:884; }","duration":"131.288102ms","start":"2026-02-13T06:57:57.854935Z","end":"2026-02-13T06:57:57.986223Z","steps":["trace[1600221987] 'agreement among raft nodes before linearized reading' (duration: 131.206781ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.986382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.16417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-02-13T06:57:57.986402Z","caller":"traceutil/trace.go:171","msg":"trace[1256776760] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:884; }","duration":"127.18449ms","start":"2026-02-13T06:57:57.859213Z","end":"2026-02-13T06:57:57.986397Z","steps":["trace[1256776760] 'agreement among raft nodes before linearized reading' (duration: 127.113329ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.986526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.322901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-02-13T06:57:57.986546Z","caller":"traceutil/trace.go:171","msg":"trace[315342181] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:884; }","duration":"127.371253ms","start":"2026-02-13T06:57:57.85917Z","end":"2026-02-13T06:57:57.986541Z","steps":["trace[315342181] 'agreement among raft nodes before linearized reading' (duration: 127.304162ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:57.986798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.933209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-13T06:57:57.986821Z","caller":"traceutil/trace.go:171","msg":"trace[1435162526] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:884; }","duration":"131.96701ms","start":"2026-02-13T06:57:57.854849Z","end":"2026-02-13T06:57:57.986816Z","steps":["trace[1435162526] 'agreement among raft nodes before linearized reading' (duration: 131.889839ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:58.004315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.235019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-13T06:57:58.004395Z","caller":"traceutil/trace.go:171","msg":"trace[159113603] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:884; }","duration":"156.557764ms","start":"2026-02-13T06:57:57.84781Z","end":"2026-02-13T06:57:58.004368Z","steps":["trace[159113603] 'agreement among raft nodes before linearized reading' (duration: 139.199668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:58.004933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.804453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-13T06:57:58.00496Z","caller":"traceutil/trace.go:171","msg":"trace[1926843893] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:884; }","duration":"159.846404ms","start":"2026-02-13T06:57:57.845107Z","end":"2026-02-13T06:57:58.004953Z","steps":["trace[1926843893] 'agreement among raft nodes before linearized reading' (duration: 139.909987ms)","trace[1926843893] 'range keys from in-memory index tree' (duration: 19.819334ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:57:58.45553Z","caller":"traceutil/trace.go:171","msg":"trace[1083084112] linearizableReadLoop","detail":"{readStateIndex:950; appliedIndex:949; }","duration":"164.555168ms","start":"2026-02-13T06:57:58.290944Z","end":"2026-02-13T06:57:58.455499Z","steps":["trace[1083084112] 'read index received' (duration: 60.83756ms)","trace[1083084112] 'applied index is now lower than readState.Index' (duration: 103.715958ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:57:58.456737Z","caller":"traceutil/trace.go:171","msg":"trace[658006822] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"197.747926ms","start":"2026-02-13T06:57:58.258972Z","end":"2026-02-13T06:57:58.45672Z","steps":["trace[658006822] 'process raft request' (duration: 175.925057ms)","trace[658006822] 'compare' (duration: 20.398712ms)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:57:58.457139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.626393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4358"} {"level":"info","ts":"2026-02-13T06:57:58.45727Z","caller":"traceutil/trace.go:171","msg":"trace[373193935] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:891; }","duration":"175.809166ms","start":"2026-02-13T06:57:58.281451Z","end":"2026-02-13T06:57:58.45726Z","steps":["trace[373193935] 'agreement among raft nodes before linearized reading' (duration: 175.590713ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:58.457695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.727391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-controller-manager-instance.1893bc0b8c2cb817\" ","response":"range_response_count:1 size:872"} {"level":"info","ts":"2026-02-13T06:57:58.457837Z","caller":"traceutil/trace.go:171","msg":"trace[1756022004] range","detail":"{range_begin:/registry/events/kube-system/kube-controller-manager-instance.1893bc0b8c2cb817; range_end:; response_count:1; response_revision:891; }","duration":"161.896114ms","start":"2026-02-13T06:57:58.295928Z","end":"2026-02-13T06:57:58.457825Z","steps":["trace[1756022004] 'agreement among raft nodes before linearized reading' (duration: 161.710252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:58.458739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.246036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-13T06:57:58.458861Z","caller":"traceutil/trace.go:171","msg":"trace[957027725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:891; }","duration":"100.402147ms","start":"2026-02-13T06:57:58.358449Z","end":"2026-02-13T06:57:58.458852Z","steps":["trace[957027725] 'agreement among raft nodes before linearized reading' (duration: 100.228315ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:57:58.599526Z","caller":"traceutil/trace.go:171","msg":"trace[470505549] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"116.88348ms","start":"2026-02-13T06:57:58.482622Z","end":"2026-02-13T06:57:58.599506Z","steps":["trace[470505549] 'process raft request' (duration: 116.631057ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:57:58.599887Z","caller":"traceutil/trace.go:171","msg":"trace[1806322263] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:953; }","duration":"113.195954ms","start":"2026-02-13T06:57:58.486682Z","end":"2026-02-13T06:57:58.599878Z","steps":["trace[1806322263] 'read index received' (duration: 113.192124ms)","trace[1806322263] 'applied index is now lower than readState.Index' (duration: 3.01µs)"],"step_count":2} {"level":"warn","ts":"2026-02-13T06:57:58.603594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.000895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-cx6fr.1893bc0de54a2aff\" ","response":"range_response_count:1 size:860"} {"level":"info","ts":"2026-02-13T06:57:58.603881Z","caller":"traceutil/trace.go:171","msg":"trace[1405019965] range","detail":"{range_begin:/registry/events/kube-system/cilium-operator-7fcd8d6ffd-cx6fr.1893bc0de54a2aff; range_end:; response_count:1; response_revision:894; }","duration":"119.31881ms","start":"2026-02-13T06:57:58.484542Z","end":"2026-02-13T06:57:58.603861Z","steps":["trace[1405019965] 'agreement among raft nodes before linearized reading' (duration: 115.506123ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:57:58.624656Z","caller":"traceutil/trace.go:171","msg":"trace[1600804237] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"131.853844ms","start":"2026-02-13T06:57:58.492791Z","end":"2026-02-13T06:57:58.624645Z","steps":["trace[1600804237] 'process raft request' (duration: 131.772133ms)"],"step_count":1} {"level":"info","ts":"2026-02-13T06:57:58.727372Z","caller":"traceutil/trace.go:171","msg":"trace[1266571828] linearizableReadLoop","detail":"{readStateIndex:955; appliedIndex:954; }","duration":"116.110511ms","start":"2026-02-13T06:57:58.611226Z","end":"2026-02-13T06:57:58.727336Z","steps":["trace[1266571828] 'read index received' (duration: 13.686139ms)","trace[1266571828] 'applied index is now lower than readState.Index' (duration: 102.423252ms)"],"step_count":2} {"level":"info","ts":"2026-02-13T06:57:58.727571Z","caller":"traceutil/trace.go:171","msg":"trace[2054968492] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"116.349774ms","start":"2026-02-13T06:57:58.611151Z","end":"2026-02-13T06:57:58.7275Z","steps":["trace[2054968492] 'process raft request' (duration: 115.727486ms)"],"step_count":1} {"level":"warn","ts":"2026-02-13T06:57:58.728245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.996492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4875"} {"level":"info","ts":"2026-02-13T06:57:58.728335Z","caller":"traceutil/trace.go:171","msg":"trace[1101265706] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:896; }","duration":"117.140243ms","start":"2026-02-13T06:57:58.611126Z","end":"2026-02-13T06:57:58.728266Z","steps":["trace[1101265706] 'agreement among raft nodes before linearized reading' (duration: 116.961531ms)"],"step_count":1}