{"level":"warn","ts":"2026-07-08T02:59:25.250422Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T02:59:25.250501Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-07-08T02:59:25.250643Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T02:59:25.250657Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-08T02:59:25.250675Z","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-07-08T02:59:25.251789Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-07-08T02:59:25.251864Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-07-08T02:59:25.259306Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.98199ms"} {"level":"info","ts":"2026-07-08T02:59:25.266848Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-07-08T02:59:25.266967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T02:59:25.267008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-07-08T02:59:25.267024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T02:59:25.267037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-07-08T02:59:25.267101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-07-08T02:59:25.273938Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T02:59:25.275431Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T02:59:25.276551Z","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-07-08T02:59:25.27854Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T02:59:25.278672Z","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-07-08T02:59:25.278731Z","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-07-08T02:59:25.278774Z","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-07-08T02:59:25.278892Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T02:59:25.282779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-07-08T02:59:25.282981Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-08T02:59:25.283887Z","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-07-08T02:59:25.284104Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-08T02:59:25.284148Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-08T02:59:25.284789Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T02:59:25.284952Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T02:59:25.868313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T02:59:25.868388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T02:59:25.868447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-07-08T02:59:25.868466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-07-08T02:59:25.868477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-08T02:59:25.868493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-07-08T02:59:25.868506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-08T02:59:25.869488Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T02:59:25.869495Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T02:59:25.869531Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T02:59:25.869492Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:59:25.870362Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T02:59:25.870438Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T02:59:25.870639Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:59:25.870753Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:59:25.870797Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:59:25.872423Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-07-08T02:59:25.873835Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T03:00:06.671476Z","caller":"traceutil/trace.go:171","msg":"trace[1836836412] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"259.208243ms","start":"2026-07-08T03:00:06.412251Z","end":"2026-07-08T03:00:06.671459Z","steps":["trace[1836836412] 'process raft request' (duration: 258.765301ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:00:08.924124Z","caller":"traceutil/trace.go:171","msg":"trace[762164671] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"382.212581ms","start":"2026-07-08T03:00:08.54186Z","end":"2026-07-08T03:00:08.924072Z","steps":["trace[762164671] 'process raft request' (duration: 380.214178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:08.925458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:08.541823Z","time spent":"382.420571ms","remote":"127.0.0.1:46260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:00:23.228187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.262939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gqglg\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-08T03:00:23.228387Z","caller":"traceutil/trace.go:171","msg":"trace[1226793021] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gqglg; range_end:; response_count:1; response_revision:788; }","duration":"107.479448ms","start":"2026-07-08T03:00:23.120841Z","end":"2026-07-08T03:00:23.228321Z","steps":["trace[1226793021] 'range keys from in-memory index tree' (duration: 107.079773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:26.634784Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469430,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:27.135448Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469430,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:27.477066Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.741571341s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T03:00:27.477537Z","caller":"traceutil/trace.go:171","msg":"trace[1463528483] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"1.34309362s","start":"2026-07-08T03:00:26.13441Z","end":"2026-07-08T03:00:27.477503Z","steps":["trace[1463528483] 'read index received' (duration: 1.342796298s)","trace[1463528483] 'applied index is now lower than readState.Index' (duration: 296.402µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:00:27.477707Z","caller":"traceutil/trace.go:171","msg":"trace[377807820] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"1.742228547s","start":"2026-07-08T03:00:25.735393Z","end":"2026-07-08T03:00:27.477621Z","steps":["trace[377807820] 'process raft request' (duration: 1.741907005s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:27.477899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:25.735354Z","time spent":"1.742395472s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:00:27.477891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.302615515s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-08T03:00:27.477965Z","caller":"traceutil/trace.go:171","msg":"trace[1112497040] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:798; }","duration":"1.302713918s","start":"2026-07-08T03:00:26.175231Z","end":"2026-07-08T03:00:27.477945Z","steps":["trace[1112497040] 'agreement among raft nodes before linearized reading' (duration: 1.302530032s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:27.477959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.997907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T03:00:27.478065Z","caller":"traceutil/trace.go:171","msg":"trace[1742833486] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:798; }","duration":"280.158784ms","start":"2026-07-08T03:00:27.197883Z","end":"2026-07-08T03:00:27.478041Z","steps":["trace[1742833486] 'agreement among raft nodes before linearized reading' (duration: 279.980557ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:27.478091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.620714ms","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-07-08T03:00:27.478125Z","caller":"traceutil/trace.go:171","msg":"trace[1538438834] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"918.688747ms","start":"2026-07-08T03:00:26.559425Z","end":"2026-07-08T03:00:27.478114Z","steps":["trace[1538438834] 'agreement among raft nodes before linearized reading' (duration: 918.610824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:27.478162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:26.559401Z","time spent":"918.751059ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T03:00:27.478299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.422032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-08T03:00:27.4783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.343859409s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gqglg\" ","response":"range_response_count:1 size:4229"} {"level":"info","ts":"2026-07-08T03:00:27.478348Z","caller":"traceutil/trace.go:171","msg":"trace[1325319090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"951.485604ms","start":"2026-07-08T03:00:26.526839Z","end":"2026-07-08T03:00:27.478325Z","steps":["trace[1325319090] 'agreement among raft nodes before linearized reading' (duration: 951.407141ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:27.478383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:26.526578Z","time spent":"951.798856ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T03:00:27.478376Z","caller":"traceutil/trace.go:171","msg":"trace[160367064] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gqglg; range_end:; response_count:1; response_revision:798; }","duration":"1.343989874s","start":"2026-07-08T03:00:26.134366Z","end":"2026-07-08T03:00:27.478356Z","steps":["trace[160367064] 'agreement among raft nodes before linearized reading' (duration: 1.343522466s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:27.478428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:26.134344Z","time spent":"1.344072637s","remote":"127.0.0.1:46352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":4251,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gqglg\" "} {"level":"warn","ts":"2026-07-08T03:00:27.478014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:26.175221Z","time spent":"1.302784591s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T03:00:27.478607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.735049ms","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-07-08T03:00:27.478715Z","caller":"traceutil/trace.go:171","msg":"trace[453718409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"202.884075ms","start":"2026-07-08T03:00:27.275807Z","end":"2026-07-08T03:00:27.478691Z","steps":["trace[453718409] 'agreement among raft nodes before linearized reading' (duration: 202.515591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:28.054082Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469433,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:28.554966Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469433,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:29.055811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469433,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:29.55363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000653228s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-08T03:00:29.553745Z","caller":"traceutil/trace.go:171","msg":"trace[169169178] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000818263s","start":"2026-07-08T03:00:27.552909Z","end":"2026-07-08T03:00:29.553727Z","steps":["trace[169169178] 'agreement among raft nodes before linearized reading' (duration: 2.000680058s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:29.553796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:27.552892Z","time spent":"2.000893837s","remote":"127.0.0.1:46192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/08 03:00:29 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-08T03:00:29.555969Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469433,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:29.958267Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.464085956s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T03:00:29.959935Z","caller":"traceutil/trace.go:171","msg":"trace[1962759214] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"2.476322839s","start":"2026-07-08T03:00:27.483563Z","end":"2026-07-08T03:00:29.959886Z","steps":["trace[1962759214] 'process raft request' (duration: 2.474962819s)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:00:29.959985Z","caller":"traceutil/trace.go:171","msg":"trace[802170336] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"2.474837864s","start":"2026-07-08T03:00:27.485105Z","end":"2026-07-08T03:00:29.959943Z","steps":["trace[802170336] 'process raft request' (duration: 2.474769781s)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:00:29.960022Z","caller":"traceutil/trace.go:171","msg":"trace[972105099] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"2.474241321s","start":"2026-07-08T03:00:27.485764Z","end":"2026-07-08T03:00:29.960006Z","steps":["trace[972105099] 'process raft request' (duration: 2.474151268s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:29.960095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:27.483539Z","time spent":"2.476472114s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:00:29.960113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:27.485755Z","time spent":"2.474309794s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:00:29.960124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:27.485096Z","time spent":"2.474950098s","remote":"127.0.0.1:46352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4216,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:00:29.960227Z","caller":"traceutil/trace.go:171","msg":"trace[460115506] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"2.47638531s","start":"2026-07-08T03:00:27.483829Z","end":"2026-07-08T03:00:29.960214Z","steps":["trace[460115506] 'process raft request' (duration: 2.475982976s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:29.960407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:27.483809Z","time spent":"2.476558947s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:00:29.963676Z","caller":"traceutil/trace.go:171","msg":"trace[998954280] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:826; }","duration":"2.410712447s","start":"2026-07-08T03:00:27.552946Z","end":"2026-07-08T03:00:29.963659Z","steps":["trace[998954280] 'read index received' (duration: 2.405594442s)","trace[998954280] 'applied index is now lower than readState.Index' (duration: 5.116865ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:00:29.96395Z","caller":"traceutil/trace.go:171","msg":"trace[51644434] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"1.469990132s","start":"2026-07-08T03:00:28.493729Z","end":"2026-07-08T03:00:29.963719Z","steps":["trace[51644434] 'process raft request' (duration: 1.469865857s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:29.964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.405926781s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:00:29.964051Z","caller":"traceutil/trace.go:171","msg":"trace[1918624700] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:804; }","duration":"2.406023614s","start":"2026-07-08T03:00:27.558018Z","end":"2026-07-08T03:00:29.964042Z","steps":["trace[1918624700] 'agreement among raft nodes before linearized reading' (duration: 2.405942891s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:29.964059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:28.493703Z","time spent":"1.470304523s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:00:29.964086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:27.558004Z","time spent":"2.406073786s","remote":"127.0.0.1:46460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:00:29.964229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.618963ms","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-07-08T03:00:29.964281Z","caller":"traceutil/trace.go:171","msg":"trace[1088245721] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:804; }","duration":"466.695066ms","start":"2026-07-08T03:00:29.497574Z","end":"2026-07-08T03:00:29.964269Z","steps":["trace[1088245721] 'agreement among raft nodes before linearized reading' (duration: 466.450617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:29.964313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:29.497563Z","time spent":"466.743398ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T03:00:29.964359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.661711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-08T03:00:29.964362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.256096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:00:29.964391Z","caller":"traceutil/trace.go:171","msg":"trace[527003959] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:804; }","duration":"480.722173ms","start":"2026-07-08T03:00:29.483659Z","end":"2026-07-08T03:00:29.964382Z","steps":["trace[527003959] 'agreement among raft nodes before linearized reading' (duration: 480.582198ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:00:29.964398Z","caller":"traceutil/trace.go:171","msg":"trace[1806674544] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:804; }","duration":"410.311458ms","start":"2026-07-08T03:00:29.554076Z","end":"2026-07-08T03:00:29.964387Z","steps":["trace[1806674544] 'agreement among raft nodes before linearized reading' (duration: 410.256226ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:29.96442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:29.483639Z","time spent":"480.775255ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T03:00:29.964426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:29.554061Z","time spent":"410.359511ms","remote":"127.0.0.1:46202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T03:00:29.964594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.73062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-08T03:00:29.964631Z","caller":"traceutil/trace.go:171","msg":"trace[674852432] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:804; }","duration":"911.804003ms","start":"2026-07-08T03:00:29.052818Z","end":"2026-07-08T03:00:29.964622Z","steps":["trace[674852432] 'agreement among raft nodes before linearized reading' (duration: 911.678028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:29.964702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:29.052794Z","time spent":"911.895896ms","remote":"127.0.0.1:46206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.205\" "} {"level":"warn","ts":"2026-07-08T03:00:29.964851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.648275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T03:00:29.964897Z","caller":"traceutil/trace.go:171","msg":"trace[2015274317] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:804; }","duration":"681.722217ms","start":"2026-07-08T03:00:29.283162Z","end":"2026-07-08T03:00:29.964884Z","steps":["trace[2015274317] 'agreement among raft nodes before linearized reading' (duration: 681.659905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:29.964928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:29.283141Z","time spent":"681.779711ms","remote":"127.0.0.1:46698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:00:39.052978Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469684,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:39.553383Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469684,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:40.054016Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469684,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:41.044115Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469684,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:41.044148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.491557257s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-08T03:00:41.044291Z","caller":"traceutil/trace.go:171","msg":"trace[31838072] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.491746962s","start":"2026-07-08T03:00:38.552519Z","end":"2026-07-08T03:00:41.044266Z","steps":["trace[31838072] 'agreement among raft nodes before linearized reading' (duration: 2.491589848s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:41.04437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:38.552498Z","time spent":"2.491838136s","remote":"127.0.0.1:46192","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-07-08T03:00:41.545095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469684,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:42.045873Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469684,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:42.54673Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844603584469684,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T03:00:42.694909Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.200560623s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T03:00:42.695396Z","caller":"traceutil/trace.go:171","msg":"trace[1050983412] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"4.201029388s","start":"2026-07-08T03:00:38.49427Z","end":"2026-07-08T03:00:42.695299Z","steps":["trace[1050983412] 'process raft request' (duration: 4.200875353s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.695539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:38.494251Z","time spent":"4.201222354s","remote":"127.0.0.1:45056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1669,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T03:00:42.712962Z","caller":"traceutil/trace.go:171","msg":"trace[1511761140] linearizableReadLoop","detail":"{readStateIndex:972; appliedIndex:969; }","duration":"4.160372026s","start":"2026-07-08T03:00:38.55256Z","end":"2026-07-08T03:00:42.712932Z","steps":["trace[1511761140] 'read index received' (duration: 4.142727095s)","trace[1511761140] 'applied index is now lower than readState.Index' (duration: 17.643841ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:00:42.713437Z","caller":"traceutil/trace.go:171","msg":"trace[326687301] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"1.660836237s","start":"2026-07-08T03:00:41.052577Z","end":"2026-07-08T03:00:42.713413Z","steps":["trace[326687301] 'process raft request' (duration: 1.660141645s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.713588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.052568Z","time spent":"1.660928259s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:00:42.713838Z","caller":"traceutil/trace.go:171","msg":"trace[280651404] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"1.661111996s","start":"2026-07-08T03:00:41.052714Z","end":"2026-07-08T03:00:42.713826Z","steps":["trace[280651404] 'process raft request' (duration: 1.660135285s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.713908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.052709Z","time spent":"1.661164387s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:00:42.71398Z","caller":"traceutil/trace.go:171","msg":"trace[659459591] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"336.119166ms","start":"2026-07-08T03:00:42.377835Z","end":"2026-07-08T03:00:42.713954Z","steps":["trace[659459591] 'process raft request' (duration: 335.058693ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.71413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:42.377791Z","time spent":"336.2632ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:00:42.720955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.668532648s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-08T03:00:42.721018Z","caller":"traceutil/trace.go:171","msg":"trace[577671096] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:943; }","duration":"1.668640081s","start":"2026-07-08T03:00:41.052363Z","end":"2026-07-08T03:00:42.721003Z","steps":["trace[577671096] 'agreement among raft nodes before linearized reading' (duration: 1.668459496s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.721049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.052343Z","time spent":"1.668700032s","remote":"127.0.0.1:46206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.205\" "} {"level":"warn","ts":"2026-07-08T03:00:42.721267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.668501486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-08T03:00:42.721296Z","caller":"traceutil/trace.go:171","msg":"trace[490815720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:943; }","duration":"1.668548068s","start":"2026-07-08T03:00:41.052741Z","end":"2026-07-08T03:00:42.721289Z","steps":["trace[490815720] 'agreement among raft nodes before linearized reading' (duration: 1.668478766s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.721315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.052734Z","time spent":"1.668575949s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T03:00:42.72143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.668835457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T03:00:42.72145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.668725354s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-08T03:00:42.721457Z","caller":"traceutil/trace.go:171","msg":"trace[905535867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:943; }","duration":"1.668873298s","start":"2026-07-08T03:00:41.052577Z","end":"2026-07-08T03:00:42.72145Z","steps":["trace[905535867] 'agreement among raft nodes before linearized reading' (duration: 1.668829967s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.721476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.05257Z","time spent":"1.668901249s","remote":"127.0.0.1:46202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-08T03:00:42.721477Z","caller":"traceutil/trace.go:171","msg":"trace[1342044414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:943; }","duration":"1.668767115s","start":"2026-07-08T03:00:41.0527Z","end":"2026-07-08T03:00:42.721468Z","steps":["trace[1342044414] 'agreement among raft nodes before linearized reading' (duration: 1.668692642s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.721498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.052691Z","time spent":"1.668799995s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T03:00:42.721657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.669105076s","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-07-08T03:00:42.721746Z","caller":"traceutil/trace.go:171","msg":"trace[1081803986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:943; }","duration":"1.669230389s","start":"2026-07-08T03:00:41.052493Z","end":"2026-07-08T03:00:42.721723Z","steps":["trace[1081803986] 'agreement among raft nodes before linearized reading' (duration: 1.669016233s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.721801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.052478Z","time spent":"1.669308771s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T03:00:42.721823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.669102695s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T03:00:42.721848Z","caller":"traceutil/trace.go:171","msg":"trace[69133145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:943; }","duration":"1.669147866s","start":"2026-07-08T03:00:41.052693Z","end":"2026-07-08T03:00:42.721841Z","steps":["trace[69133145] 'agreement among raft nodes before linearized reading' (duration: 1.669077474s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.721855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040080416s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-08T03:00:42.721868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.052687Z","time spent":"1.669176598s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T03:00:42.721933Z","caller":"traceutil/trace.go:171","msg":"trace[286921189] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:943; }","duration":"1.040156559s","start":"2026-07-08T03:00:41.681715Z","end":"2026-07-08T03:00:42.721871Z","steps":["trace[286921189] 'agreement among raft nodes before linearized reading' (duration: 1.040095667s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.721966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.681692Z","time spent":"1.040264852s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":29,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:00:42.722029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.275409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:00:42.722053Z","caller":"traceutil/trace.go:171","msg":"trace[536038050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:943; }","duration":"629.299309ms","start":"2026-07-08T03:00:42.092747Z","end":"2026-07-08T03:00:42.722046Z","steps":["trace[536038050] 'agreement among raft nodes before linearized reading' (duration: 629.262348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.722071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:42.092686Z","time spent":"629.380312ms","remote":"127.0.0.1:46192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T03:00:42.722146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.558000116s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T03:00:42.722174Z","caller":"traceutil/trace.go:171","msg":"trace[1648073084] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:943; }","duration":"1.558075109s","start":"2026-07-08T03:00:41.164093Z","end":"2026-07-08T03:00:42.722168Z","steps":["trace[1648073084] 'agreement among raft nodes before linearized reading' (duration: 1.558031638s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.722195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.164065Z","time spent":"1.55812363s","remote":"127.0.0.1:46548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:00:42.722249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.665743367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:00:42.722269Z","caller":"traceutil/trace.go:171","msg":"trace[1770176375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:943; }","duration":"1.665773969s","start":"2026-07-08T03:00:41.056489Z","end":"2026-07-08T03:00:42.722263Z","steps":["trace[1770176375] 'agreement among raft nodes before linearized reading' (duration: 1.665742098s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.722291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.056482Z","time spent":"1.66580475s","remote":"127.0.0.1:46192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T03:00:42.722335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.349576876s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-498cp\" ","response":"range_response_count:1 size:5674"} {"level":"info","ts":"2026-07-08T03:00:42.722365Z","caller":"traceutil/trace.go:171","msg":"trace[1188845331] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-498cp; range_end:; response_count:1; response_revision:943; }","duration":"1.349647968s","start":"2026-07-08T03:00:41.372709Z","end":"2026-07-08T03:00:42.722357Z","steps":["trace[1188845331] 'agreement among raft nodes before linearized reading' (duration: 1.349577706s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.722385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.372687Z","time spent":"1.34969234s","remote":"127.0.0.1:46352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5696,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-498cp\" "} {"level":"warn","ts":"2026-07-08T03:00:42.722402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.669707824s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-08T03:00:42.72243Z","caller":"traceutil/trace.go:171","msg":"trace[250007679] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:943; }","duration":"1.669753285s","start":"2026-07-08T03:00:41.052668Z","end":"2026-07-08T03:00:42.722422Z","steps":["trace[250007679] 'agreement among raft nodes before linearized reading' (duration: 1.668675102s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.722454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.052663Z","time spent":"1.669786336s","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T03:00:42.725075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.668376842s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T03:00:42.725723Z","caller":"traceutil/trace.go:171","msg":"trace[114848064] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:943; }","duration":"1.672911544s","start":"2026-07-08T03:00:41.052796Z","end":"2026-07-08T03:00:42.725707Z","steps":["trace[114848064] 'agreement among raft nodes before linearized reading' (duration: 1.668192617s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:42.726328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:00:41.05276Z","time spent":"1.673546294s","remote":"127.0.0.1:46682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":29,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:02:37.753507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.072871ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T03:02:37.7536Z","caller":"traceutil/trace.go:171","msg":"trace[826461370] linearizableReadLoop","detail":"{readStateIndex:1443; appliedIndex:1442; }","duration":"379.399329ms","start":"2026-07-08T03:02:37.374164Z","end":"2026-07-08T03:02:37.753563Z","steps":["trace[826461370] 'read index received' (duration: 105.725867ms)","trace[826461370] 'applied index is now lower than readState.Index' (duration: 273.672442ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:02:37.753825Z","caller":"traceutil/trace.go:171","msg":"trace[1308129472] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"384.652067ms","start":"2026-07-08T03:02:37.369163Z","end":"2026-07-08T03:02:37.753815Z","steps":["trace[1308129472] 'process raft request' (duration: 110.769502ms)","trace[1308129472] 'compare' (duration: 271.97569ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:02:37.753876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:02:37.369152Z","time spent":"384.703209ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:02:37.754646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.477563ms","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-07-08T03:02:37.754675Z","caller":"traceutil/trace.go:171","msg":"trace[1442998509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1386; }","duration":"380.518243ms","start":"2026-07-08T03:02:37.37415Z","end":"2026-07-08T03:02:37.754669Z","steps":["trace[1442998509] 'agreement among raft nodes before linearized reading' (duration: 380.103708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:02:37.754773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:02:37.374146Z","time spent":"380.542683ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T03:02:37.754775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.312473ms","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-07-08T03:02:37.754844Z","caller":"traceutil/trace.go:171","msg":"trace[152623193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1386; }","duration":"349.407075ms","start":"2026-07-08T03:02:37.405406Z","end":"2026-07-08T03:02:37.754813Z","steps":["trace[152623193] 'agreement among raft nodes before linearized reading' (duration: 349.261443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:02:37.754902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.813861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/envoy-gateway-system/\" range_end:\"/registry/persistentvolumeclaims/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T03:02:37.755049Z","caller":"traceutil/trace.go:171","msg":"trace[1286799200] range","detail":"{range_begin:/registry/persistentvolumeclaims/envoy-gateway-system/; range_end:/registry/persistentvolumeclaims/envoy-gateway-system0; response_count:0; response_revision:1386; }","duration":"344.023175ms","start":"2026-07-08T03:02:37.410969Z","end":"2026-07-08T03:02:37.754992Z","steps":["trace[1286799200] 'agreement among raft nodes before linearized reading' (duration: 343.429287ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:02:37.755077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.212831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T03:02:37.755118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:02:37.410922Z","time spent":"344.174517ms","remote":"127.0.0.1:46334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumeclaims/envoy-gateway-system/\" range_end:\"/registry/persistentvolumeclaims/envoy-gateway-system0\" limit:500 "} {"level":"warn","ts":"2026-07-08T03:02:37.754951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:02:37.40538Z","time spent":"349.560528ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-08T03:02:37.755181Z","caller":"traceutil/trace.go:171","msg":"trace[299257412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1386; }","duration":"201.289302ms","start":"2026-07-08T03:02:37.553843Z","end":"2026-07-08T03:02:37.755132Z","steps":["trace[299257412] 'agreement among raft nodes before linearized reading' (duration: 200.534891ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:02:37.755206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.437967ms","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-07-08T03:02:37.756369Z","caller":"traceutil/trace.go:171","msg":"trace[413273473] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1386; }","duration":"378.529868ms","start":"2026-07-08T03:02:37.376734Z","end":"2026-07-08T03:02:37.755263Z","steps":["trace[413273473] 'agreement among raft nodes before linearized reading' (duration: 377.637855ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:02:37.75645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:02:37.37673Z","time spent":"379.702884ms","remote":"127.0.0.1:46448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}