{"level":"warn","ts":"2026-08-12T10:59:04.743486Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-12T10:59:04.743614Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.121: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.19.213.121:2380","--initial-cluster=instance=https://199.19.213.121:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.121:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.121: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-08-12T10:59:04.74371Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-12T10:59:04.743731Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.121:2380"]} {"level":"info","ts":"2026-08-12T10:59:04.743763Z","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-08-12T10:59:04.744758Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"]} {"level":"info","ts":"2026-08-12T10:59:04.744928Z","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.19.213.121:2380"],"listen-peer-urls":["https://199.19.213.121:2380"],"advertise-client-urls":["https://199.19.213.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.121: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-08-12T10:59:04.748743Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.514511ms"} {"level":"info","ts":"2026-08-12T10:59:04.754508Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"31541ae44470b70","cluster-id":"8ae2d89c48d1447d"} {"level":"info","ts":"2026-08-12T10:59:04.754593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=()"} {"level":"info","ts":"2026-08-12T10:59:04.754622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became follower at term 0"} {"level":"info","ts":"2026-08-12T10:59:04.754645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 31541ae44470b70 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-12T10:59:04.75466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became follower at term 1"} {"level":"info","ts":"2026-08-12T10:59:04.754712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=(222155973350329200)"} {"level":"warn","ts":"2026-08-12T10:59:04.760634Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-12T10:59:04.761876Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-12T10:59:04.764191Z","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-08-12T10:59:04.766676Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"31541ae44470b70","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-12T10:59:04.766855Z","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-08-12T10:59:04.766921Z","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-08-12T10:59:04.766929Z","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-08-12T10:59:04.767189Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"31541ae44470b70","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-12T10:59:04.768056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=(222155973350329200)"} {"level":"info","ts":"2026-08-12T10:59:04.76826Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ae2d89c48d1447d","local-member-id":"31541ae44470b70","added-peer-id":"31541ae44470b70","added-peer-peer-urls":["https://199.19.213.121:2380"]} {"level":"info","ts":"2026-08-12T10:59:04.772056Z","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-08-12T10:59:04.77222Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.121:2380"} {"level":"info","ts":"2026-08-12T10:59:04.772278Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.121:2380"} {"level":"info","ts":"2026-08-12T10:59:04.772552Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"31541ae44470b70","initial-advertise-peer-urls":["https://199.19.213.121:2380"],"listen-peer-urls":["https://199.19.213.121:2380"],"advertise-client-urls":["https://199.19.213.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-12T10:59:04.772615Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-12T10:59:04.95568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 is starting a new election at term 1"} {"level":"info","ts":"2026-08-12T10:59:04.955897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-12T10:59:04.955974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 received MsgPreVoteResp from 31541ae44470b70 at term 1"} {"level":"info","ts":"2026-08-12T10:59:04.956056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became candidate at term 2"} {"level":"info","ts":"2026-08-12T10:59:04.956083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 received MsgVoteResp from 31541ae44470b70 at term 2"} {"level":"info","ts":"2026-08-12T10:59:04.956092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became leader at term 2"} {"level":"info","ts":"2026-08-12T10:59:04.956102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 31541ae44470b70 elected leader 31541ae44470b70 at term 2"} {"level":"info","ts":"2026-08-12T10:59:05.174458Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"31541ae44470b70","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.121:2379]}","request-path":"/0/members/31541ae44470b70/attributes","cluster-id":"8ae2d89c48d1447d","publish-timeout":"7s"} {"level":"info","ts":"2026-08-12T10:59:05.174645Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T10:59:05.174667Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T10:59:05.174611Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T10:59:05.175207Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-12T10:59:05.175224Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-12T10:59:05.177521Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.121:2379"} {"level":"info","ts":"2026-08-12T10:59:05.178919Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-12T10:59:05.200923Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ae2d89c48d1447d","local-member-id":"31541ae44470b70","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T10:59:05.201286Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T10:59:05.216076Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-12T10:59:43.155836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.478155ms","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-08-12T10:59:43.155936Z","caller":"traceutil/trace.go:171","msg":"trace[1477345707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"123.619476ms","start":"2026-08-12T10:59:43.032301Z","end":"2026-08-12T10:59:43.155921Z","steps":["trace[1477345707] 'range keys from in-memory index tree' (duration: 123.267912ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:45.65415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.055736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:45.654238Z","caller":"traceutil/trace.go:171","msg":"trace[1280939858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:623; }","duration":"171.171077ms","start":"2026-08-12T10:59:45.48305Z","end":"2026-08-12T10:59:45.654221Z","steps":["trace[1280939858] 'range keys from in-memory index tree' (duration: 171.017746ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:45.654429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.828546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:45.654473Z","caller":"traceutil/trace.go:171","msg":"trace[304371498] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:623; }","duration":"171.886627ms","start":"2026-08-12T10:59:45.482577Z","end":"2026-08-12T10:59:45.654463Z","steps":["trace[304371498] 'count revisions from in-memory index tree' (duration: 171.794065ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:45.654599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.253541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:45.654648Z","caller":"traceutil/trace.go:171","msg":"trace[1498474578] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:623; }","duration":"172.343622ms","start":"2026-08-12T10:59:45.482291Z","end":"2026-08-12T10:59:45.654635Z","steps":["trace[1498474578] 'range keys from in-memory index tree' (duration: 171.932427ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:46.171396Z","caller":"traceutil/trace.go:171","msg":"trace[1092458193] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"370.785437ms","start":"2026-08-12T10:59:45.800583Z","end":"2026-08-12T10:59:46.171369Z","steps":["trace[1092458193] 'read index received' (duration: 369.696863ms)","trace[1092458193] 'applied index is now lower than readState.Index' (duration: 1.087774ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:59:46.171547Z","caller":"traceutil/trace.go:171","msg":"trace[174233949] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"387.291639ms","start":"2026-08-12T10:59:45.784159Z","end":"2026-08-12T10:59:46.17145Z","steps":["trace[174233949] 'process raft request' (duration: 386.454438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.171815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.745425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.171873Z","caller":"traceutil/trace.go:171","msg":"trace[1421666200] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"225.933307ms","start":"2026-08-12T10:59:45.94592Z","end":"2026-08-12T10:59:46.171854Z","steps":["trace[1421666200] 'agreement among raft nodes before linearized reading' (duration: 225.822826ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.171878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.283773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.171919Z","caller":"traceutil/trace.go:171","msg":"trace[215794334] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:624; }","duration":"371.371354ms","start":"2026-08-12T10:59:45.800538Z","end":"2026-08-12T10:59:46.17191Z","steps":["trace[215794334] 'agreement among raft nodes before linearized reading' (duration: 370.952509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.171948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:45.800521Z","time spent":"371.417025ms","remote":"127.0.0.1:45310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-08-12T10:59:46.172178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.328722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-12T10:59:46.172189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.414365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-srpp8\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-12T10:59:46.172218Z","caller":"traceutil/trace.go:171","msg":"trace[1181977967] range","detail":"{range_begin:/registry/pods/kube-system/cilium-srpp8; range_end:; response_count:1; response_revision:624; }","duration":"156.493887ms","start":"2026-08-12T10:59:46.015718Z","end":"2026-08-12T10:59:46.172211Z","steps":["trace[1181977967] 'agreement among raft nodes before linearized reading' (duration: 156.374085ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:46.172226Z","caller":"traceutil/trace.go:171","msg":"trace[1158148931] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"226.407154ms","start":"2026-08-12T10:59:45.945801Z","end":"2026-08-12T10:59:46.172208Z","steps":["trace[1158148931] 'agreement among raft nodes before linearized reading' (duration: 226.344493ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.172197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.943048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.172257Z","caller":"traceutil/trace.go:171","msg":"trace[836363852] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:624; }","duration":"371.02502ms","start":"2026-08-12T10:59:45.801225Z","end":"2026-08-12T10:59:46.17225Z","steps":["trace[836363852] 'agreement among raft nodes before linearized reading' (duration: 370.946779ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.172293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:45.801215Z","time spent":"371.069091ms","remote":"127.0.0.1:45310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-12T10:59:46.174278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.254279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.175043Z","caller":"traceutil/trace.go:171","msg":"trace[1054819329] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:624; }","duration":"373.976387ms","start":"2026-08-12T10:59:45.800632Z","end":"2026-08-12T10:59:46.174608Z","steps":["trace[1054819329] 'agreement among raft nodes before linearized reading' (duration: 370.875078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.17566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:45.800625Z","time spent":"374.560575ms","remote":"127.0.0.1:45310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-12T10:59:46.180401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:45.784103Z","time spent":"387.695834ms","remote":"127.0.0.1:46772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:59:46.395554Z","caller":"traceutil/trace.go:171","msg":"trace[259166106] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"162.387092ms","start":"2026-08-12T10:59:46.23314Z","end":"2026-08-12T10:59:46.395527Z","steps":["trace[259166106] 'read index received' (duration: 162.23494ms)","trace[259166106] 'applied index is now lower than readState.Index' (duration: 150.762µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:59:46.395604Z","caller":"traceutil/trace.go:171","msg":"trace[1962510221] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"202.741737ms","start":"2026-08-12T10:59:46.192824Z","end":"2026-08-12T10:59:46.395566Z","steps":["trace[1962510221] 'process raft request' (duration: 202.489854ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.395763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.589925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.395999Z","caller":"traceutil/trace.go:171","msg":"trace[474391795] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:625; }","duration":"162.846468ms","start":"2026-08-12T10:59:46.233132Z","end":"2026-08-12T10:59:46.395979Z","steps":["trace[474391795] 'agreement among raft nodes before linearized reading' (duration: 162.508124ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.397685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.324187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.397927Z","caller":"traceutil/trace.go:171","msg":"trace[252996918] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"164.591471ms","start":"2026-08-12T10:59:46.233306Z","end":"2026-08-12T10:59:46.397897Z","steps":["trace[252996918] 'agreement among raft nodes before linearized reading' (duration: 164.249666ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.398774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.035295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.399144Z","caller":"traceutil/trace.go:171","msg":"trace[898217006] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"107.422361ms","start":"2026-08-12T10:59:46.291697Z","end":"2026-08-12T10:59:46.39912Z","steps":["trace[898217006] 'agreement among raft nodes before linearized reading' (duration: 107.032505ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.399503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.572206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-12T10:59:46.40003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.933149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.40053Z","caller":"traceutil/trace.go:171","msg":"trace[101483723] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"138.453686ms","start":"2026-08-12T10:59:46.262062Z","end":"2026-08-12T10:59:46.400516Z","steps":["trace[101483723] 'agreement among raft nodes before linearized reading' (duration: 137.914089ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:46.400474Z","caller":"traceutil/trace.go:171","msg":"trace[1286543164] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"109.543198ms","start":"2026-08-12T10:59:46.290905Z","end":"2026-08-12T10:59:46.400449Z","steps":["trace[1286543164] 'agreement among raft nodes before linearized reading' (duration: 108.541195ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.400027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.072161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.400756Z","caller":"traceutil/trace.go:171","msg":"trace[829967383] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"138.812661ms","start":"2026-08-12T10:59:46.261903Z","end":"2026-08-12T10:59:46.400715Z","steps":["trace[829967383] 'agreement among raft nodes before linearized reading' (duration: 138.02708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.400083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.421606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.401201Z","caller":"traceutil/trace.go:171","msg":"trace[1950046627] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:626; }","duration":"110.54399ms","start":"2026-08-12T10:59:46.290638Z","end":"2026-08-12T10:59:46.401182Z","steps":["trace[1950046627] 'agreement among raft nodes before linearized reading' (duration: 109.424126ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:46.400088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.102691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:46.401404Z","caller":"traceutil/trace.go:171","msg":"trace[401479720] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"139.420068ms","start":"2026-08-12T10:59:46.261967Z","end":"2026-08-12T10:59:46.401387Z","steps":["trace[401479720] 'agreement among raft nodes before linearized reading' (duration: 138.098741ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:46.39803Z","caller":"traceutil/trace.go:171","msg":"trace[1344487075] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"160.327986ms","start":"2026-08-12T10:59:46.237686Z","end":"2026-08-12T10:59:46.398014Z","steps":["trace[1344487075] 'process raft request' (duration: 159.715008ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:48.912326Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112348566,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T10:59:49.413386Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112348566,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T10:59:49.914117Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112348566,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T10:59:50.303697Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.954015328s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-12T10:59:50.36888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.198648748s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:50.36899Z","caller":"traceutil/trace.go:171","msg":"trace[1014413924] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"2.019443454s","start":"2026-08-12T10:59:48.349513Z","end":"2026-08-12T10:59:50.368956Z","steps":["trace[1014413924] 'process raft request' (duration: 1.954561036s)","trace[1014413924] 'compare' (duration: 64.364511ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:59:50.369017Z","caller":"traceutil/trace.go:171","msg":"trace[1992434622] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:667; }","duration":"1.198795899s","start":"2026-08-12T10:59:49.170202Z","end":"2026-08-12T10:59:50.368998Z","steps":["trace[1992434622] 'range keys from in-memory index tree' (duration: 1.198629578s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.369174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:48.349479Z","time spent":"2.019591155s","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:59:50.451942Z","caller":"traceutil/trace.go:171","msg":"trace[1769166342] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"1.909963861s","start":"2026-08-12T10:59:48.541925Z","end":"2026-08-12T10:59:50.451888Z","steps":["trace[1769166342] 'process raft request' (duration: 1.909757219s)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:50.452034Z","caller":"traceutil/trace.go:171","msg":"trace[1707010766] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"1.708555762s","start":"2026-08-12T10:59:48.743422Z","end":"2026-08-12T10:59:50.451978Z","steps":["trace[1707010766] 'process raft request' (duration: 1.70838174s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.452104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:48.541902Z","time spent":"1.910135124s","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-12T10:59:50.452135Z","caller":"traceutil/trace.go:171","msg":"trace[734788406] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:694; }","duration":"2.040062472s","start":"2026-08-12T10:59:48.412056Z","end":"2026-08-12T10:59:50.452119Z","steps":["trace[734788406] 'read index received' (duration: 1.892085139s)","trace[734788406] 'applied index is now lower than readState.Index' (duration: 147.976553ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:59:50.452223Z","caller":"traceutil/trace.go:171","msg":"trace[70729472] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"1.508239647s","start":"2026-08-12T10:59:48.943974Z","end":"2026-08-12T10:59:50.452214Z","steps":["trace[70729472] 'process raft request' (duration: 1.507863633s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.452236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:48.743386Z","time spent":"1.708746675s","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-12T10:59:50.452286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:48.943944Z","time spent":"1.508314047s","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-12T10:59:50.45236Z","caller":"traceutil/trace.go:171","msg":"trace[483178081] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"1.411301508s","start":"2026-08-12T10:59:49.041052Z","end":"2026-08-12T10:59:50.452353Z","steps":["trace[483178081] 'process raft request' (duration: 1.410829942s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.452388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:49.041027Z","time spent":"1.411346298s","remote":"127.0.0.1:46754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":765,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-12T10:59:50.452463Z","caller":"traceutil/trace.go:171","msg":"trace[183159715] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"1.107266567s","start":"2026-08-12T10:59:49.345184Z","end":"2026-08-12T10:59:50.452451Z","steps":["trace[183159715] 'process raft request' (duration: 1.106882391s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.452568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.040518158s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-12T10:59:50.452575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:49.34512Z","time spent":"1.107400818s","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-12T10:59:50.452687Z","caller":"traceutil/trace.go:171","msg":"trace[785069327] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"1.306913729s","start":"2026-08-12T10:59:49.145761Z","end":"2026-08-12T10:59:50.452674Z","steps":["trace[785069327] 'process raft request' (duration: 1.306248911s)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:50.452598Z","caller":"traceutil/trace.go:171","msg":"trace[1036737806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:674; }","duration":"2.040598179s","start":"2026-08-12T10:59:48.411993Z","end":"2026-08-12T10:59:50.452591Z","steps":["trace[1036737806] 'agreement among raft nodes before linearized reading' (duration: 2.040499208s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.452744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:49.145708Z","time spent":"1.307012581s","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-12T10:59:50.452775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:48.411967Z","time spent":"2.040788471s","remote":"127.0.0.1:46932","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":"info","ts":"2026-08-12T10:59:50.614536Z","caller":"traceutil/trace.go:171","msg":"trace[2057857494] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"162.305613ms","start":"2026-08-12T10:59:50.452174Z","end":"2026-08-12T10:59:50.61448Z","steps":["trace[2057857494] 'read index received' (duration: 138.594148ms)","trace[2057857494] 'applied index is now lower than readState.Index' (duration: 23.709635ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:59:50.614698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.958726ms","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":"warn","ts":"2026-08-12T10:59:50.614747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.761929641s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-12T10:59:50.614801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.321504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:50.614844Z","caller":"traceutil/trace.go:171","msg":"trace[570710578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:675; }","duration":"1.762060853s","start":"2026-08-12T10:59:48.852756Z","end":"2026-08-12T10:59:50.614817Z","steps":["trace[570710578] 'agreement among raft nodes before linearized reading' (duration: 1.761887931s)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:50.61486Z","caller":"traceutil/trace.go:171","msg":"trace[1858886516] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:675; }","duration":"874.410435ms","start":"2026-08-12T10:59:49.74043Z","end":"2026-08-12T10:59:50.61484Z","steps":["trace[1858886516] 'agreement among raft nodes before linearized reading' (duration: 874.317124ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.614876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.317221ms","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":"warn","ts":"2026-08-12T10:59:50.614856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.918386304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-12T10:59:50.614941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074295702s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-12T10:59:50.614894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:48.852742Z","time spent":"1.762143125s","remote":"127.0.0.1:46686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-12T10:59:50.614978Z","caller":"traceutil/trace.go:171","msg":"trace[1705710992] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:675; }","duration":"1.074371333s","start":"2026-08-12T10:59:49.540597Z","end":"2026-08-12T10:59:50.614969Z","steps":["trace[1705710992] 'agreement among raft nodes before linearized reading' (duration: 1.074324252s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.614975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.026075ms","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":"warn","ts":"2026-08-12T10:59:50.614993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.49933ms","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":"warn","ts":"2026-08-12T10:59:50.615006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:49.540579Z","time spent":"1.074420483s","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-08-12T10:59:50.615031Z","caller":"traceutil/trace.go:171","msg":"trace[2130703236] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:675; }","duration":"674.565701ms","start":"2026-08-12T10:59:49.940456Z","end":"2026-08-12T10:59:50.615022Z","steps":["trace[2130703236] 'agreement among raft nodes before linearized reading' (duration: 674.47826ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:50.615081Z","caller":"traceutil/trace.go:171","msg":"trace[717682260] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"240.558398ms","start":"2026-08-12T10:59:50.374509Z","end":"2026-08-12T10:59:50.615068Z","steps":["trace[717682260] 'process raft request' (duration: 216.243325ms)","trace[717682260] 'compare' (duration: 23.428032ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:59:50.615092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:49.940436Z","time spent":"674.634642ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9343,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-08-12T10:59:50.614899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:49.740411Z","time spent":"874.479597ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-08-12T10:59:50.615124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.575247901s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-srpp8\" ","response":"range_response_count:1 size:17524"} {"level":"info","ts":"2026-08-12T10:59:50.614977Z","caller":"traceutil/trace.go:171","msg":"trace[1529244330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:675; }","duration":"1.918574758s","start":"2026-08-12T10:59:48.696379Z","end":"2026-08-12T10:59:50.614954Z","steps":["trace[1529244330] 'agreement among raft nodes before linearized reading' (duration: 1.918336154s)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:50.615176Z","caller":"traceutil/trace.go:171","msg":"trace[1270824911] range","detail":"{range_begin:/registry/pods/kube-system/cilium-srpp8; range_end:; response_count:1; response_revision:675; }","duration":"1.575341591s","start":"2026-08-12T10:59:49.039825Z","end":"2026-08-12T10:59:50.615166Z","steps":["trace[1270824911] 'agreement among raft nodes before linearized reading' (duration: 1.574859825s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.615184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:48.696351Z","time spent":"1.91882472s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-12T10:59:50.615031Z","caller":"traceutil/trace.go:171","msg":"trace[1193108033] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:675; }","duration":"274.145696ms","start":"2026-08-12T10:59:50.340871Z","end":"2026-08-12T10:59:50.615017Z","steps":["trace[1193108033] 'agreement among raft nodes before linearized reading' (duration: 273.901193ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:50.614779Z","caller":"traceutil/trace.go:171","msg":"trace[1358497893] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:675; }","duration":"865.077787ms","start":"2026-08-12T10:59:49.749681Z","end":"2026-08-12T10:59:50.614759Z","steps":["trace[1358497893] 'agreement among raft nodes before linearized reading' (duration: 864.826884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.615416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:49.749671Z","time spent":"865.734416ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-12T10:59:50.614912Z","caller":"traceutil/trace.go:171","msg":"trace[1827043272] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:675; }","duration":"474.376132ms","start":"2026-08-12T10:59:50.14052Z","end":"2026-08-12T10:59:50.614897Z","steps":["trace[1827043272] 'agreement among raft nodes before linearized reading' (duration: 474.2942ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.615479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.140504Z","time spent":"474.965309ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-08-12T10:59:50.61469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.409061596s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-12T10:59:50.615544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.776317784s","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-08-12T10:59:50.615552Z","caller":"traceutil/trace.go:171","msg":"trace[1213497611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:675; }","duration":"1.409944908s","start":"2026-08-12T10:59:49.205594Z","end":"2026-08-12T10:59:50.615539Z","steps":["trace[1213497611] 'agreement among raft nodes before linearized reading' (duration: 1.408923975s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.615936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:49.205527Z","time spent":"1.410396803s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-12T10:59:50.615658Z","caller":"traceutil/trace.go:171","msg":"trace[1727826615] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:675; }","duration":"1.776481745s","start":"2026-08-12T10:59:48.839161Z","end":"2026-08-12T10:59:50.615643Z","steps":["trace[1727826615] 'agreement among raft nodes before linearized reading' (duration: 1.776171491s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.615215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:49.039795Z","time spent":"1.575412632s","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17547,"request content":"key:\"/registry/pods/kube-system/cilium-srpp8\" "} {"level":"warn","ts":"2026-08-12T10:59:50.616062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:48.839133Z","time spent":"1.776916201s","remote":"127.0.0.1:46932","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":"warn","ts":"2026-08-12T10:59:50.857743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.626637ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T10:59:50.857954Z","caller":"traceutil/trace.go:171","msg":"trace[1145672823] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"399.863262ms","start":"2026-08-12T10:59:50.45805Z","end":"2026-08-12T10:59:50.857913Z","steps":["trace[1145672823] 'process raft request' (duration: 297.83588ms)","trace[1145672823] 'compare' (duration: 101.484176ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:59:50.858029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.45802Z","time spent":"399.976115ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:59:50.85834Z","caller":"traceutil/trace.go:171","msg":"trace[240523798] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"398.441045ms","start":"2026-08-12T10:59:50.459871Z","end":"2026-08-12T10:59:50.858313Z","steps":["trace[240523798] 'process raft request' (duration: 397.978719ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:50.858385Z","caller":"traceutil/trace.go:171","msg":"trace[286302345] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:702; }","duration":"243.627746ms","start":"2026-08-12T10:59:50.614684Z","end":"2026-08-12T10:59:50.858311Z","steps":["trace[286302345] 'read index received' (duration: 141.22616ms)","trace[286302345] 'applied index is now lower than readState.Index' (duration: 102.398536ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T10:59:50.858616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.899217ms","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":"warn","ts":"2026-08-12T10:59:50.858645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.459859Z","time spent":"398.639048ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:59:50.858701Z","caller":"traceutil/trace.go:171","msg":"trace[1576244971] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:677; }","duration":"316.041179ms","start":"2026-08-12T10:59:50.542639Z","end":"2026-08-12T10:59:50.858681Z","steps":["trace[1576244971] 'agreement among raft nodes before linearized reading' (duration: 315.774745ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.858734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.542619Z","time spent":"316.10963ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4203,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"info","ts":"2026-08-12T10:59:50.930239Z","caller":"traceutil/trace.go:171","msg":"trace[366270788] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"308.979351ms","start":"2026-08-12T10:59:50.621232Z","end":"2026-08-12T10:59:50.930211Z","steps":["trace[366270788] 'process raft request' (duration: 308.732068ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.930479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.621212Z","time spent":"309.170753ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:59:50.930596Z","caller":"traceutil/trace.go:171","msg":"trace[504659079] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"309.112972ms","start":"2026-08-12T10:59:50.621461Z","end":"2026-08-12T10:59:50.930574Z","steps":["trace[504659079] 'process raft request' (duration: 308.645557ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.930734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.621452Z","time spent":"309.210103ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:59:50.931006Z","caller":"traceutil/trace.go:171","msg":"trace[1366020160] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"308.841048ms","start":"2026-08-12T10:59:50.622126Z","end":"2026-08-12T10:59:50.930967Z","steps":["trace[1366020160] 'process raft request' (duration: 308.365782ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:50.931202Z","caller":"traceutil/trace.go:171","msg":"trace[1195335220] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"308.387773ms","start":"2026-08-12T10:59:50.622802Z","end":"2026-08-12T10:59:50.93119Z","steps":["trace[1195335220] 'process raft request' (duration: 308.073839ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:50.931233Z","caller":"traceutil/trace.go:171","msg":"trace[856850503] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"301.877022ms","start":"2026-08-12T10:59:50.629323Z","end":"2026-08-12T10:59:50.9312Z","steps":["trace[856850503] 'process raft request' (duration: 301.70201ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:50.931308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.622796Z","time spent":"308.459523ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T10:59:50.931197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.622119Z","time spent":"308.957089ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T10:59:50.931422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.629315Z","time spent":"302.012334ms","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17775,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T10:59:51.089711Z","caller":"traceutil/trace.go:171","msg":"trace[514163431] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:704; }","duration":"231.208775ms","start":"2026-08-12T10:59:50.858477Z","end":"2026-08-12T10:59:51.089686Z","steps":["trace[514163431] 'read index received' (duration: 71.514272ms)","trace[514163431] 'applied index is now lower than readState.Index' (duration: 159.693673ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:59:51.08978Z","caller":"traceutil/trace.go:171","msg":"trace[204496367] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"299.200853ms","start":"2026-08-12T10:59:50.790544Z","end":"2026-08-12T10:59:51.089745Z","steps":["trace[204496367] 'process raft request' (duration: 298.868488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:51.089855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.930555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:51.089912Z","caller":"traceutil/trace.go:171","msg":"trace[1086536481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:685; }","duration":"472.028826ms","start":"2026-08-12T10:59:50.61787Z","end":"2026-08-12T10:59:51.089899Z","steps":["trace[1086536481] 'agreement among raft nodes before linearized reading' (duration: 471.906654ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:51.089972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T10:59:50.617848Z","time spent":"472.115647ms","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-12T10:59:51.089767Z","caller":"traceutil/trace.go:171","msg":"trace[1557321965] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"226.230263ms","start":"2026-08-12T10:59:50.863498Z","end":"2026-08-12T10:59:51.089729Z","steps":["trace[1557321965] 'process raft request' (duration: 226.094161ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:51.090247Z","caller":"traceutil/trace.go:171","msg":"trace[953469197] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"225.492313ms","start":"2026-08-12T10:59:50.864702Z","end":"2026-08-12T10:59:51.090194Z","steps":["trace[953469197] 'process raft request' (duration: 224.940747ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:51.227371Z","caller":"traceutil/trace.go:171","msg":"trace[2111160113] linearizableReadLoop","detail":"{readStateIndex:714; appliedIndex:712; }","duration":"137.501084ms","start":"2026-08-12T10:59:51.089846Z","end":"2026-08-12T10:59:51.227347Z","steps":["trace[2111160113] 'read index received' (duration: 97.007032ms)","trace[2111160113] 'applied index is now lower than readState.Index' (duration: 40.492952ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:59:51.227487Z","caller":"traceutil/trace.go:171","msg":"trace[1272068689] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"250.830909ms","start":"2026-08-12T10:59:50.976645Z","end":"2026-08-12T10:59:51.227476Z","steps":["trace[1272068689] 'process raft request' (duration: 210.286207ms)","trace[1272068689] 'compare' (duration: 39.788073ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:59:51.227874Z","caller":"traceutil/trace.go:171","msg":"trace[2109627713] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"139.870213ms","start":"2026-08-12T10:59:51.087984Z","end":"2026-08-12T10:59:51.227855Z","steps":["trace[2109627713] 'process raft request' (duration: 139.253205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:51.228208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.412363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-srpp8\" ","response":"range_response_count:1 size:17790"} {"level":"info","ts":"2026-08-12T10:59:51.228416Z","caller":"traceutil/trace.go:171","msg":"trace[1369329831] range","detail":"{range_begin:/registry/pods/kube-system/cilium-srpp8; range_end:; response_count:1; response_revision:687; }","duration":"286.585926ms","start":"2026-08-12T10:59:50.941707Z","end":"2026-08-12T10:59:51.228293Z","steps":["trace[1369329831] 'agreement among raft nodes before linearized reading' (duration: 286.090809ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:51.25606Z","caller":"traceutil/trace.go:171","msg":"trace[1234733527] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"158.627815ms","start":"2026-08-12T10:59:51.097411Z","end":"2026-08-12T10:59:51.256039Z","steps":["trace[1234733527] 'process raft request' (duration: 158.488103ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:51.256266Z","caller":"traceutil/trace.go:171","msg":"trace[1669963683] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"134.7465ms","start":"2026-08-12T10:59:51.121513Z","end":"2026-08-12T10:59:51.256259Z","steps":["trace[1669963683] 'process raft request' (duration: 134.493556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:51.256289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.738807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T10:59:51.256351Z","caller":"traceutil/trace.go:171","msg":"trace[447220321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:689; }","duration":"158.849248ms","start":"2026-08-12T10:59:51.097486Z","end":"2026-08-12T10:59:51.256335Z","steps":["trace[447220321] 'agreement among raft nodes before linearized reading' (duration: 158.732147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:51.256434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.138024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10368"} {"level":"info","ts":"2026-08-12T10:59:51.256496Z","caller":"traceutil/trace.go:171","msg":"trace[443968462] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:689; }","duration":"114.250896ms","start":"2026-08-12T10:59:51.142231Z","end":"2026-08-12T10:59:51.256482Z","steps":["trace[443968462] 'agreement among raft nodes before linearized reading' (duration: 114.123525ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:51.538582Z","caller":"traceutil/trace.go:171","msg":"trace[2124537650] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"164.872443ms","start":"2026-08-12T10:59:51.373683Z","end":"2026-08-12T10:59:51.538555Z","steps":["trace[2124537650] 'process raft request' (duration: 164.484339ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:51.538794Z","caller":"traceutil/trace.go:171","msg":"trace[274571459] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"163.806259ms","start":"2026-08-12T10:59:51.374922Z","end":"2026-08-12T10:59:51.538728Z","steps":["trace[274571459] 'process raft request' (duration: 163.509946ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:51.633411Z","caller":"traceutil/trace.go:171","msg":"trace[171694024] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"142.8436ms","start":"2026-08-12T10:59:51.490545Z","end":"2026-08-12T10:59:51.633389Z","steps":["trace[171694024] 'process raft request' (duration: 102.077855ms)","trace[171694024] 'compare' (duration: 40.578863ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:59:51.829654Z","caller":"traceutil/trace.go:171","msg":"trace[1124454725] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"114.857823ms","start":"2026-08-12T10:59:51.714774Z","end":"2026-08-12T10:59:51.829632Z","steps":["trace[1124454725] 'process raft request' (duration: 114.677511ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T10:59:51.854697Z","caller":"traceutil/trace.go:171","msg":"trace[887500136] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:724; }","duration":"108.418163ms","start":"2026-08-12T10:59:51.746255Z","end":"2026-08-12T10:59:51.854673Z","steps":["trace[887500136] 'read index received' (duration: 83.107229ms)","trace[887500136] 'applied index is now lower than readState.Index' (duration: 25.309864ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T10:59:51.854897Z","caller":"traceutil/trace.go:171","msg":"trace[118835767] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"139.714011ms","start":"2026-08-12T10:59:51.715165Z","end":"2026-08-12T10:59:51.854879Z","steps":["trace[118835767] 'process raft request' (duration: 139.272336ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T10:59:51.855167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.886258ms","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-08-12T10:59:51.855232Z","caller":"traceutil/trace.go:171","msg":"trace[1387720679] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:699; }","duration":"108.99689ms","start":"2026-08-12T10:59:51.746221Z","end":"2026-08-12T10:59:51.855218Z","steps":["trace[1387720679] 'agreement among raft nodes before linearized reading' (duration: 108.757927ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:04.258924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.562872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-md2cz\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-12T11:00:04.258987Z","caller":"traceutil/trace.go:171","msg":"trace[2049095917] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-md2cz; range_end:; response_count:1; response_revision:790; }","duration":"132.670083ms","start":"2026-08-12T11:00:04.126304Z","end":"2026-08-12T11:00:04.258975Z","steps":["trace[2049095917] 'range keys from in-memory index tree' (duration: 132.42216ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T11:00:04.392518Z","caller":"traceutil/trace.go:171","msg":"trace[1972224206] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"125.092206ms","start":"2026-08-12T11:00:04.267395Z","end":"2026-08-12T11:00:04.392487Z","steps":["trace[1972224206] 'process raft request' (duration: 124.938044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:23.185387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.33876ms","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-08-12T11:00:23.185487Z","caller":"traceutil/trace.go:171","msg":"trace[397356652] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:981; }","duration":"110.485053ms","start":"2026-08-12T11:00:23.074984Z","end":"2026-08-12T11:00:23.185469Z","steps":["trace[397356652] 'range keys from in-memory index tree' (duration: 110.19367ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:23.185576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.587857ms","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-08-12T11:00:23.185755Z","caller":"traceutil/trace.go:171","msg":"trace[1132316855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:981; }","duration":"100.716888ms","start":"2026-08-12T11:00:23.084934Z","end":"2026-08-12T11:00:23.185651Z","steps":["trace[1132316855] 'range keys from in-memory index tree' (duration: 100.378945ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:24.09258Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:24.593805Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:25.094773Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:25.595286Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:26.09609Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:26.596559Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:26.8532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999723429s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-12T11:00:26.85331Z","caller":"traceutil/trace.go:171","msg":"trace[761859255] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999879321s","start":"2026-08-12T11:00:24.853412Z","end":"2026-08-12T11:00:26.853292Z","steps":["trace[761859255] 'agreement among raft nodes before linearized reading' (duration: 1.99975629s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:26.853354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:24.853393Z","time spent":"1.999951802s","remote":"127.0.0.1:46686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/12 11:00:26 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:27.097399Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:27.598362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:28.098996Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:28.188116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:23.189041Z","time spent":"4.99905227s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-08-12T11:00:28.188208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:23.188547Z","time spent":"4.999654147s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-08-12T11:00:28.188261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:23.188905Z","time spent":"4.999351712s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/08/12 11:00:28 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:28.243428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:23.244947Z","time spent":"4.998464103s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/08/12 11:00:28 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:28.599213Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:28.853813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000119331s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-12T11:00:28.854012Z","caller":"traceutil/trace.go:171","msg":"trace[154704104] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000388524s","start":"2026-08-12T11:00:26.853603Z","end":"2026-08-12T11:00:28.853992Z","steps":["trace[154704104] 'agreement among raft nodes before linearized reading' (duration: 2.000173021s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:28.854131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:26.853578Z","time spent":"2.000539475s","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/12 11:00:28 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:29.099827Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:29.599955Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:30.100618Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349172,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:30.190337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:23.189048Z","time spent":"7.001274725s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-08-12T11:00:30.367595Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"0b709ff5a033b8ac","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-08-12T11:00:30.59262Z","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-08-12T11:00:30.592734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.000813168s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-08-12T11:00:30.592782Z","caller":"traceutil/trace.go:171","msg":"trace[93434330] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; }","duration":"7.000863429s","start":"2026-08-12T11:00:23.591887Z","end":"2026-08-12T11:00:30.59275Z","steps":["trace[93434330] 'agreement among raft nodes before linearized reading' (duration: 7.000813348s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:30.59281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:23.591761Z","time spent":"7.00104128s","remote":"127.0.0.1:46892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":0,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-08-12T11:00:30.862256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00085933s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-12T11:00:30.862344Z","caller":"traceutil/trace.go:171","msg":"trace[231777741] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000999351s","start":"2026-08-12T11:00:28.861326Z","end":"2026-08-12T11:00:30.862325Z","steps":["trace[231777741] 'agreement among raft nodes before linearized reading' (duration: 2.00089532s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:30.862395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:28.861305Z","time spent":"2.001078291s","remote":"127.0.0.1:46686","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-08-12T11:00:31.093321Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:31.59399Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:32.094321Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:32.595233Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:32.863329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.0003451s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-12T11:00:32.863385Z","caller":"traceutil/trace.go:171","msg":"trace[1550667067] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000442942s","start":"2026-08-12T11:00:30.862927Z","end":"2026-08-12T11:00:32.86337Z","steps":["trace[1550667067] 'agreement among raft nodes before linearized reading' (duration: 2.000369601s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:32.863412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:30.862909Z","time spent":"2.000498112s","remote":"127.0.0.1:46674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/12 11:00:32 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:33.074415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.883706105s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-12T11:00:33.074507Z","caller":"traceutil/trace.go:171","msg":"trace[1041917767] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.883848697s","start":"2026-08-12T11:00:30.190633Z","end":"2026-08-12T11:00:33.074482Z","steps":["trace[1041917767] 'agreement among raft nodes before linearized reading' (duration: 2.883734845s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:33.074602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:30.190615Z","time spent":"2.883931947s","remote":"127.0.0.1:46932","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/08/12 11:00:33 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:33.085081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.891639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-12T11:00:33.085189Z","caller":"traceutil/trace.go:171","msg":"trace[139384234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"891.040651ms","start":"2026-08-12T11:00:32.194129Z","end":"2026-08-12T11:00:33.085169Z","steps":["trace[139384234] 'agreement among raft nodes before linearized reading' (duration: 890.92631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:33.085263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:32.194109Z","time spent":"891.141212ms","remote":"127.0.0.1:46932","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/08/12 11:00:33 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:33.089811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.899177233s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-12T11:00:33.089884Z","caller":"traceutil/trace.go:171","msg":"trace[439038710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.899330104s","start":"2026-08-12T11:00:30.190539Z","end":"2026-08-12T11:00:33.089869Z","steps":["trace[439038710] 'agreement among raft nodes before linearized reading' (duration: 2.899209473s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:33.090713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:30.190511Z","time spent":"2.900149133s","remote":"127.0.0.1:46932","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/08/12 11:00:33 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:33.093083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.902450576s","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-08-12T11:00:33.093148Z","caller":"traceutil/trace.go:171","msg":"trace[790807548] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.902533877s","start":"2026-08-12T11:00:30.190601Z","end":"2026-08-12T11:00:33.093135Z","steps":["trace[790807548] 'agreement among raft nodes before linearized reading' (duration: 2.902463616s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:33.094173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:30.190595Z","time spent":"2.903302485s","remote":"127.0.0.1:46932","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/08/12 11:00:33 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:33.095552Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:33.244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999392598s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-12T11:00:33.244094Z","caller":"traceutil/trace.go:171","msg":"trace[1871262487] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; }","duration":"4.999621631s","start":"2026-08-12T11:00:28.244451Z","end":"2026-08-12T11:00:33.244072Z","steps":["trace[1871262487] 'agreement among raft nodes before linearized reading' (duration: 4.999489659s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:33.244143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:28.244429Z","time spent":"4.999704402s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-08-12T11:00:33.595817Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:34.096969Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:34.597752Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:34.870991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000564186s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-12T11:00:34.87108Z","caller":"traceutil/trace.go:171","msg":"trace[960117161] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000688567s","start":"2026-08-12T11:00:32.870368Z","end":"2026-08-12T11:00:34.871057Z","steps":["trace[960117161] 'agreement among raft nodes before linearized reading' (duration: 2.000580976s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:34.871124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:32.870359Z","time spent":"2.000757368s","remote":"127.0.0.1:46686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/12 11:00:34 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:35.059158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999242984s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-12T11:00:35.059241Z","caller":"traceutil/trace.go:171","msg":"trace[777149610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"9.999399456s","start":"2026-08-12T11:00:25.059823Z","end":"2026-08-12T11:00:35.059222Z","steps":["trace[777149610] 'agreement among raft nodes before linearized reading' (duration: 9.999292915s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:35.059288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:25.059798Z","time spent":"9.999478706s","remote":"127.0.0.1:46932","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/08/12 11:00:35 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-12T11:00:35.098213Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:35.598811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334609112349182,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-12T11:00:35.694629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:28.694019Z","time spent":"7.000600365s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-08-12T11:00:35.85846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:28.857619Z","time spent":"7.000834846s","remote":"127.0.0.1:46754","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-08-12T11:00:36.017138Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"12.828458124s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-12T11:00:36.060298Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"150.571µs","request":"header: lease_revoke:","response":"size:28","error":"lease not found"} {"level":"info","ts":"2026-08-12T11:00:36.060491Z","caller":"traceutil/trace.go:171","msg":"trace[2071565669] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"3.967043206s","start":"2026-08-12T11:00:32.093428Z","end":"2026-08-12T11:00:36.060471Z","steps":["trace[2071565669] 'process raft request' (duration: 3.966952205s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.060528Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"0b709ff5a033b8ac","error":"lease not found"} {"level":"warn","ts":"2026-08-12T11:00:36.06063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:32.093405Z","time spent":"3.967136887s","remote":"127.0.0.1:46932","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-08-12T11:00:36.06077Z","caller":"traceutil/trace.go:171","msg":"trace[366864417] transaction","detail":"{read_only:false; number_of_response:1; response_revision:989; }","duration":"2.965477713s","start":"2026-08-12T11:00:33.095267Z","end":"2026-08-12T11:00:36.060745Z","steps":["trace[366864417] 'process raft request' (duration: 2.965385952s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.061089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:33.095241Z","time spent":"2.965597114s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":62,"response count":0,"response size":525,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T11:00:36.061129Z","caller":"traceutil/trace.go:171","msg":"trace[182304095] transaction","detail":"{read_only:false; number_of_response:1; response_revision:989; }","duration":"2.973808408s","start":"2026-08-12T11:00:33.087295Z","end":"2026-08-12T11:00:36.061103Z","steps":["trace[182304095] 'process raft request' (duration: 2.973136972s)"],"step_count":1} {"level":"info","ts":"2026-08-12T11:00:36.061213Z","caller":"traceutil/trace.go:171","msg":"trace[1995196461] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"2.813149837s","start":"2026-08-12T11:00:33.248053Z","end":"2026-08-12T11:00:36.061203Z","steps":["trace[1995196461] 'process raft request' (duration: 2.812620482s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.061262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:33.087267Z","time spent":"2.973931519s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":48,"response count":0,"response size":471,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T11:00:36.061267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:33.248032Z","time spent":"2.813210787s","remote":"127.0.0.1:46754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":904,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-12T11:00:36.061342Z","caller":"traceutil/trace.go:171","msg":"trace[253032736] transaction","detail":"{read_only:false; number_of_response:1; response_revision:989; }","duration":"2.967782625s","start":"2026-08-12T11:00:33.093552Z","end":"2026-08-12T11:00:36.061334Z","steps":["trace[253032736] 'process raft request' (duration: 2.967042498s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.06139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:33.093533Z","time spent":"2.967833336s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":47,"response count":0,"response size":512,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T11:00:36.072413Z","caller":"traceutil/trace.go:171","msg":"trace[1599653047] linearizableReadLoop","detail":"{readStateIndex:1033; appliedIndex:1017; }","duration":"5.479702456s","start":"2026-08-12T11:00:30.592679Z","end":"2026-08-12T11:00:36.072382Z","steps":["trace[1599653047] 'read index received' (duration: 5.424759541s)","trace[1599653047] 'applied index is now lower than readState.Index' (duration: 54.941275ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T11:00:36.072484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.804639406s","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-08-12T11:00:36.07253Z","caller":"traceutil/trace.go:171","msg":"trace[1825517355] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:992; }","duration":"6.804730377s","start":"2026-08-12T11:00:29.267787Z","end":"2026-08-12T11:00:36.072517Z","steps":["trace[1825517355] 'agreement among raft nodes before linearized reading' (duration: 6.804608346s)"],"step_count":1} {"level":"info","ts":"2026-08-12T11:00:36.07251Z","caller":"traceutil/trace.go:171","msg":"trace[691228419] transaction","detail":"{read_only:false; number_of_response:1; response_revision:992; }","duration":"372.06061ms","start":"2026-08-12T11:00:35.700417Z","end":"2026-08-12T11:00:36.072478Z","steps":["trace[691228419] 'process raft request' (duration: 371.897068ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.072557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:29.267765Z","time spent":"6.804786407s","remote":"127.0.0.1:47056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-12T11:00:36.072644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.102198481s","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":"info","ts":"2026-08-12T11:00:36.072686Z","caller":"traceutil/trace.go:171","msg":"trace[1663842485] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:992; }","duration":"7.102304783s","start":"2026-08-12T11:00:28.97037Z","end":"2026-08-12T11:00:36.072675Z","steps":["trace[1663842485] 'agreement among raft nodes before linearized reading' (duration: 7.10219081s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.072707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.984086435s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T11:00:36.072725Z","caller":"traceutil/trace.go:171","msg":"trace[1898600989] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:992; }","duration":"5.984142555s","start":"2026-08-12T11:00:30.088577Z","end":"2026-08-12T11:00:36.07272Z","steps":["trace[1898600989] 'agreement among raft nodes before linearized reading' (duration: 5.984105245s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.072739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:30.088557Z","time spent":"5.984177865s","remote":"127.0.0.1:46920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":30,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-08-12T11:00:36.072739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:28.970356Z","time spent":"7.102368823s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-08-12T11:00:36.072835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.668641856s","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-08-12T11:00:36.072855Z","caller":"traceutil/trace.go:171","msg":"trace[485285272] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:992; }","duration":"6.668693837s","start":"2026-08-12T11:00:29.404154Z","end":"2026-08-12T11:00:36.072847Z","steps":["trace[485285272] 'agreement among raft nodes before linearized reading' (duration: 6.668660387s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.072867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:29.404135Z","time spent":"6.668729347s","remote":"127.0.0.1:46874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":13,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-08-12T11:00:36.072829Z","caller":"traceutil/trace.go:171","msg":"trace[702432843] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"1.010810408s","start":"2026-08-12T11:00:35.06201Z","end":"2026-08-12T11:00:36.07282Z","steps":["trace[702432843] 'process raft request' (duration: 1.010129261s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.072986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:35.061986Z","time spent":"1.010970969s","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":409,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T11:00:36.073031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.092717472s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T11:00:36.073059Z","caller":"traceutil/trace.go:171","msg":"trace[727316301] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:992; }","duration":"11.092836273s","start":"2026-08-12T11:00:24.980216Z","end":"2026-08-12T11:00:36.073052Z","steps":["trace[727316301] 'agreement among raft nodes before linearized reading' (duration: 11.092750592s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.07308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:24.980196Z","time spent":"11.092879203s","remote":"127.0.0.1:46882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-08-12T11:00:36.073175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.02119698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-12T11:00:36.073233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.971918809s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.121\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-12T11:00:36.072648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:35.700387Z","time spent":"372.183531ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":721,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T11:00:36.073265Z","caller":"traceutil/trace.go:171","msg":"trace[483819585] range","detail":"{range_begin:/registry/masterleases/199.19.213.121; range_end:; response_count:0; response_revision:992; }","duration":"7.971979819s","start":"2026-08-12T11:00:28.101279Z","end":"2026-08-12T11:00:36.073259Z","steps":["trace[483819585] 'agreement among raft nodes before linearized reading' (duration: 7.971921449s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.073287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:28.101265Z","time spent":"7.97201622s","remote":"127.0.0.1:46720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.19.213.121\" "} {"level":"warn","ts":"2026-08-12T11:00:36.073337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.608795342s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T11:00:36.073357Z","caller":"traceutil/trace.go:171","msg":"trace[1665818203] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:992; }","duration":"9.608863112s","start":"2026-08-12T11:00:26.464488Z","end":"2026-08-12T11:00:36.073351Z","steps":["trace[1665818203] 'agreement among raft nodes before linearized reading' (duration: 9.608764691s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.073373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:26.464466Z","time spent":"9.608903313s","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":120,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-08-12T11:00:36.073387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.428946825s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T11:00:36.073455Z","caller":"traceutil/trace.go:171","msg":"trace[44210509] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:992; }","duration":"10.429063236s","start":"2026-08-12T11:00:25.644368Z","end":"2026-08-12T11:00:36.073432Z","steps":["trace[44210509] 'agreement among raft nodes before linearized reading' (duration: 10.428923644s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.073476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.34247288s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T11:00:36.073492Z","caller":"traceutil/trace.go:171","msg":"trace[1635028243] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:992; }","duration":"9.34251872s","start":"2026-08-12T11:00:26.730969Z","end":"2026-08-12T11:00:36.073487Z","steps":["trace[1635028243] 'agreement among raft nodes before linearized reading' (duration: 9.34248004s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.073489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:25.644349Z","time spent":"10.429133376s","remote":"127.0.0.1:46764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-08-12T11:00:36.073506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:26.730954Z","time spent":"9.34254851s","remote":"127.0.0.1:47184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-08-12T11:00:36.07323Z","caller":"traceutil/trace.go:171","msg":"trace[167989052] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:992; }","duration":"3.021292292s","start":"2026-08-12T11:00:33.051924Z","end":"2026-08-12T11:00:36.073216Z","steps":["trace[167989052] 'agreement among raft nodes before linearized reading' (duration: 3.0211295s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.073637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:33.051908Z","time spent":"3.021721466s","remote":"127.0.0.1:47032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":69,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-08-12T11:00:36.073712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.882996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T11:00:36.073728Z","caller":"traceutil/trace.go:171","msg":"trace[1106130349] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:992; }","duration":"927.901906ms","start":"2026-08-12T11:00:35.145821Z","end":"2026-08-12T11:00:36.073723Z","steps":["trace[1106130349] 'agreement among raft nodes before linearized reading' (duration: 927.852476ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.073744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:35.145766Z","time spent":"927.973818ms","remote":"127.0.0.1:47102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-08-12T11:00:36.073776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.201276974s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T11:00:36.073791Z","caller":"traceutil/trace.go:171","msg":"trace[988986941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:992; }","duration":"1.201317185s","start":"2026-08-12T11:00:34.872469Z","end":"2026-08-12T11:00:36.073786Z","steps":["trace[988986941] 'agreement among raft nodes before linearized reading' (duration: 1.201291425s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.073837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:34.872457Z","time spent":"1.201343765s","remote":"127.0.0.1:46674","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-08-12T11:00:36.073948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.31697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18cb09c75198e828\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-08-12T11:00:36.073966Z","caller":"traceutil/trace.go:171","msg":"trace[1942349347] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18cb09c75198e828; range_end:; response_count:1; response_revision:992; }","duration":"211.381711ms","start":"2026-08-12T11:00:35.862578Z","end":"2026-08-12T11:00:36.07396Z","steps":["trace[1942349347] 'agreement among raft nodes before linearized reading' (duration: 211.26633ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.074337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.447021326s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T11:00:36.074355Z","caller":"traceutil/trace.go:171","msg":"trace[1554325817] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:992; }","duration":"2.447079936s","start":"2026-08-12T11:00:33.62727Z","end":"2026-08-12T11:00:36.07435Z","steps":["trace[1554325817] 'agreement among raft nodes before linearized reading' (duration: 2.447046136s)"],"step_count":1} {"level":"warn","ts":"2026-08-12T11:00:36.074368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T11:00:33.627251Z","time spent":"2.447113597s","remote":"127.0.0.1:46924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}