{"level":"warn","ts":"2026-04-07T06:42:50.460465Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T06:42:50.460548Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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://162.253.55.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-07T06:42:50.460726Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T06:42:50.460743Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-04-07T06:42:50.460761Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T06:42:50.461471Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]} {"level":"info","ts":"2026-04-07T06:42:50.461636Z","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://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-07T06:42:50.559239Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"97.337382ms"} {"level":"info","ts":"2026-04-07T06:42:50.569511Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"} {"level":"info","ts":"2026-04-07T06:42:50.569669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T06:42:50.569715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"} {"level":"info","ts":"2026-04-07T06:42:50.569742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T06:42:50.569781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"} {"level":"info","ts":"2026-04-07T06:42:50.569831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"warn","ts":"2026-04-07T06:42:50.580044Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T06:42:50.581472Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T06:42:50.582725Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-07T06:42:50.586232Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T06:42:50.589215Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T06:42:50.589335Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T06:42:50.589351Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T06:42:50.589628Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T06:42:50.590685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"info","ts":"2026-04-07T06:42:50.590901Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-04-07T06:42:50.591492Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T06:42:50.59155Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-04-07T06:42:50.591599Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-04-07T06:42:50.592644Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T06:42:50.592695Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T06:42:51.571257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T06:42:51.571305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T06:42:51.571334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"} {"level":"info","ts":"2026-04-07T06:42:51.571349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"} {"level":"info","ts":"2026-04-07T06:42:51.571358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-04-07T06:42:51.571371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"} {"level":"info","ts":"2026-04-07T06:42:51.571382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-04-07T06:42:51.572208Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T06:42:51.572245Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T06:42:51.57254Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T06:42:51.572672Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T06:42:51.572852Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T06:42:51.57294Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T06:42:51.573419Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T06:42:51.573502Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T06:42:51.573529Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T06:42:51.575826Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"} {"level":"info","ts":"2026-04-07T06:42:51.577024Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T06:43:20.106915Z","caller":"traceutil/trace.go:171","msg":"trace[1535583776] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"115.932271ms","start":"2026-04-07T06:43:19.990957Z","end":"2026-04-07T06:43:20.106889Z","steps":["trace[1535583776] 'process raft request' (duration: 115.797736ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:43:20.114073Z","caller":"traceutil/trace.go:171","msg":"trace[1178288818] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"117.835983ms","start":"2026-04-07T06:43:19.996222Z","end":"2026-04-07T06:43:20.114058Z","steps":["trace[1178288818] 'process raft request' (duration: 117.510444ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:43:20.114182Z","caller":"traceutil/trace.go:171","msg":"trace[1690644442] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"110.050566ms","start":"2026-04-07T06:43:20.004125Z","end":"2026-04-07T06:43:20.114176Z","steps":["trace[1690644442] 'process raft request' (duration: 109.681736ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:43:20.114228Z","caller":"traceutil/trace.go:171","msg":"trace[615158395] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"109.752667ms","start":"2026-04-07T06:43:20.004472Z","end":"2026-04-07T06:43:20.114224Z","steps":["trace[615158395] 'process raft request' (duration: 109.367576ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:43:20.114417Z","caller":"traceutil/trace.go:171","msg":"trace[1597064548] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"109.786928ms","start":"2026-04-07T06:43:20.004609Z","end":"2026-04-07T06:43:20.114396Z","steps":["trace[1597064548] 'process raft request' (duration: 109.259023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:43:21.816687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.534543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:43:21.816829Z","caller":"traceutil/trace.go:171","msg":"trace[1598944795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"230.79823ms","start":"2026-04-07T06:43:21.586008Z","end":"2026-04-07T06:43:21.816807Z","steps":["trace[1598944795] 'range keys from in-memory index tree' (duration: 230.357937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:43:21.817794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.606528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-04-07T06:43:21.817988Z","caller":"traceutil/trace.go:171","msg":"trace[508662117] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:586; }","duration":"321.961168ms","start":"2026-04-07T06:43:21.495972Z","end":"2026-04-07T06:43:21.817933Z","steps":["trace[508662117] 'range keys from in-memory index tree' (duration: 320.59677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:43:21.818085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:43:21.495948Z","time spent":"322.120083ms","remote":"127.0.0.1:59408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":74793,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-04-07T06:43:25.978798Z","caller":"traceutil/trace.go:171","msg":"trace[895522696] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"194.242859ms","start":"2026-04-07T06:43:25.784524Z","end":"2026-04-07T06:43:25.978767Z","steps":["trace[895522696] 'process raft request' (duration: 193.617321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:43:26.801314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.669482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:43:26.801455Z","caller":"traceutil/trace.go:171","msg":"trace[1896733304] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"374.228639ms","start":"2026-04-07T06:43:26.427187Z","end":"2026-04-07T06:43:26.801415Z","steps":["trace[1896733304] 'read index received' (duration: 252.791764ms)","trace[1896733304] 'applied index is now lower than readState.Index' (duration: 121.435595ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:43:26.80165Z","caller":"traceutil/trace.go:171","msg":"trace[1207700558] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"646.960681ms","start":"2026-04-07T06:43:26.154613Z","end":"2026-04-07T06:43:26.801574Z","steps":["trace[1207700558] 'process raft request' (duration: 525.313291ms)","trace[1207700558] 'compare' (duration: 120.534309ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:43:26.801774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.598878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9f529\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-07T06:43:26.801825Z","caller":"traceutil/trace.go:171","msg":"trace[700571783] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9f529; range_end:; response_count:1; response_revision:614; }","duration":"374.667351ms","start":"2026-04-07T06:43:26.427134Z","end":"2026-04-07T06:43:26.801801Z","steps":["trace[700571783] 'agreement among raft nodes before linearized reading' (duration: 374.543488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:43:26.801868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:43:26.427111Z","time spent":"374.748683ms","remote":"127.0.0.1:59580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-9f529\" "} {"level":"warn","ts":"2026-04-07T06:43:26.801932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:43:26.154585Z","time spent":"647.227967ms","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:43:26.806547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.981086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:43:26.806565Z","caller":"traceutil/trace.go:171","msg":"trace[696670640] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"317.915295ms","start":"2026-04-07T06:43:26.488619Z","end":"2026-04-07T06:43:26.806534Z","steps":["trace[696670640] 'process raft request' (duration: 317.480753ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:43:26.806581Z","caller":"traceutil/trace.go:171","msg":"trace[858945975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"221.100659ms","start":"2026-04-07T06:43:26.585473Z","end":"2026-04-07T06:43:26.806574Z","steps":["trace[858945975] 'agreement among raft nodes before linearized reading' (duration: 221.032487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:43:26.806634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:43:26.488561Z","time spent":"318.028158ms","remote":"127.0.0.1:59466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:44:21.506151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.680836ms","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-04-07T06:44:21.506251Z","caller":"traceutil/trace.go:171","msg":"trace[1523008367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1010; }","duration":"244.82769ms","start":"2026-04-07T06:44:21.261403Z","end":"2026-04-07T06:44:21.506231Z","steps":["trace[1523008367] 'range keys from in-memory index tree' (duration: 244.527403ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:44:21.748271Z","caller":"traceutil/trace.go:171","msg":"trace[188662817] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"237.991764ms","start":"2026-04-07T06:44:21.510259Z","end":"2026-04-07T06:44:21.748251Z","steps":["trace[188662817] 'process raft request' (duration: 237.788088ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:44:21.748427Z","caller":"traceutil/trace.go:171","msg":"trace[645555662] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1048; }","duration":"162.073839ms","start":"2026-04-07T06:44:21.586134Z","end":"2026-04-07T06:44:21.748208Z","steps":["trace[645555662] 'read index received' (duration: 161.948536ms)","trace[645555662] 'applied index is now lower than readState.Index' (duration: 124.763µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:44:21.748565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.403688ms","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-04-07T06:44:21.748655Z","caller":"traceutil/trace.go:171","msg":"trace[155956586] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1011; }","duration":"162.539293ms","start":"2026-04-07T06:44:21.586094Z","end":"2026-04-07T06:44:21.748634Z","steps":["trace[155956586] 'agreement among raft nodes before linearized reading' (duration: 162.243734ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:44:21.978824Z","caller":"traceutil/trace.go:171","msg":"trace[1800054329] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"286.349015ms","start":"2026-04-07T06:44:21.692447Z","end":"2026-04-07T06:44:21.978796Z","steps":["trace[1800054329] 'process raft request' (duration: 204.604651ms)","trace[1800054329] 'compare' (duration: 81.367753ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:44:21.97883Z","caller":"traceutil/trace.go:171","msg":"trace[628926298] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"226.544691ms","start":"2026-04-07T06:44:21.752255Z","end":"2026-04-07T06:44:21.978799Z","steps":["trace[628926298] 'process raft request' (duration: 226.423038ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:44:42.115883Z","caller":"traceutil/trace.go:171","msg":"trace[1810637529] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"271.421398ms","start":"2026-04-07T06:44:41.844446Z","end":"2026-04-07T06:44:42.115867Z","steps":["trace[1810637529] 'process raft request' (duration: 271.327065ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:44:42.873739Z","caller":"traceutil/trace.go:171","msg":"trace[451475988] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"287.96931ms","start":"2026-04-07T06:44:42.585751Z","end":"2026-04-07T06:44:42.873721Z","steps":["trace[451475988] 'read index received' (duration: 287.822105ms)","trace[451475988] 'applied index is now lower than readState.Index' (duration: 146.505µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:44:42.873826Z","caller":"traceutil/trace.go:171","msg":"trace[1902857792] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"336.078943ms","start":"2026-04-07T06:44:42.537708Z","end":"2026-04-07T06:44:42.873787Z","steps":["trace[1902857792] 'process raft request' (duration: 335.915729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:44:42.873871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.106313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:44:42.87395Z","caller":"traceutil/trace.go:171","msg":"trace[336829676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1080; }","duration":"288.223346ms","start":"2026-04-07T06:44:42.58565Z","end":"2026-04-07T06:44:42.873936Z","steps":["trace[336829676] 'agreement among raft nodes before linearized reading' (duration: 288.082952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:44:42.874023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:44:42.537695Z","time spent":"336.210638ms","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:44:44.386947Z","caller":"traceutil/trace.go:171","msg":"trace[1041006869] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"240.525061ms","start":"2026-04-07T06:44:44.146395Z","end":"2026-04-07T06:44:44.38692Z","steps":["trace[1041006869] 'read index received' (duration: 161.065611ms)","trace[1041006869] 'applied index is now lower than readState.Index' (duration: 79.45852ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:44:44.387299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.882992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-07T06:44:44.38711Z","caller":"traceutil/trace.go:171","msg":"trace[150350455] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"264.313242ms","start":"2026-04-07T06:44:44.122766Z","end":"2026-04-07T06:44:44.387079Z","steps":["trace[150350455] 'process raft request' (duration: 184.747008ms)","trace[150350455] 'compare' (duration: 79.131333ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:44:44.38735Z","caller":"traceutil/trace.go:171","msg":"trace[1300797064] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1084; }","duration":"240.970254ms","start":"2026-04-07T06:44:44.146368Z","end":"2026-04-07T06:44:44.387338Z","steps":["trace[1300797064] 'agreement among raft nodes before linearized reading' (duration: 240.649945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:44:57.070853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.554741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T06:44:57.070928Z","caller":"traceutil/trace.go:171","msg":"trace[1244067244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1175; }","duration":"641.650004ms","start":"2026-04-07T06:44:56.429261Z","end":"2026-04-07T06:44:57.070911Z","steps":["trace[1244067244] 'range keys from in-memory index tree' (duration: 641.378657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:44:57.070941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.123214ms","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-04-07T06:44:57.070965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:44:56.429193Z","time spent":"641.763617ms","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T06:44:57.070994Z","caller":"traceutil/trace.go:171","msg":"trace[290191367] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1175; }","duration":"602.213607ms","start":"2026-04-07T06:44:56.468763Z","end":"2026-04-07T06:44:57.070977Z","steps":["trace[290191367] 'range keys from in-memory index tree' (duration: 601.991921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:44:57.071029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:44:56.468738Z","time spent":"602.280119ms","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T06:44:57.071433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.792967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T06:44:57.071469Z","caller":"traceutil/trace.go:171","msg":"trace[1866359418] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1175; }","duration":"144.854119ms","start":"2026-04-07T06:44:56.926605Z","end":"2026-04-07T06:44:57.071459Z","steps":["trace[1866359418] 'range keys from in-memory index tree' (duration: 144.697495ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:45:10.342405Z","caller":"traceutil/trace.go:171","msg":"trace[1799678249] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"111.078466ms","start":"2026-04-07T06:45:10.231303Z","end":"2026-04-07T06:45:10.342382Z","steps":["trace[1799678249] 'process raft request' (duration: 110.88011ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:45:13.51317Z","caller":"traceutil/trace.go:171","msg":"trace[755837094] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"162.370538ms","start":"2026-04-07T06:45:13.350774Z","end":"2026-04-07T06:45:13.513145Z","steps":["trace[755837094] 'process raft request' (duration: 162.248755ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:45:13.660716Z","caller":"traceutil/trace.go:171","msg":"trace[1919255417] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"137.539258ms","start":"2026-04-07T06:45:13.523143Z","end":"2026-04-07T06:45:13.660682Z","steps":["trace[1919255417] 'process raft request' (duration: 88.639532ms)","trace[1919255417] 'compare' (duration: 48.772673ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:45:14.512042Z","caller":"traceutil/trace.go:171","msg":"trace[1383916922] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"127.083273ms","start":"2026-04-07T06:45:14.384929Z","end":"2026-04-07T06:45:14.512012Z","steps":["trace[1383916922] 'process raft request' (duration: 48.970319ms)","trace[1383916922] 'compare' (duration: 77.949449ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:45:14.855835Z","caller":"traceutil/trace.go:171","msg":"trace[1005065423] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1302; }","duration":"271.026795ms","start":"2026-04-07T06:45:14.584782Z","end":"2026-04-07T06:45:14.855808Z","steps":["trace[1005065423] 'read index received' (duration: 11.058001ms)","trace[1005065423] 'applied index is now lower than readState.Index' (duration: 259.967364ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:45:14.856005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.1966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:45:14.856078Z","caller":"traceutil/trace.go:171","msg":"trace[48304219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1253; }","duration":"271.331345ms","start":"2026-04-07T06:45:14.584738Z","end":"2026-04-07T06:45:14.856069Z","steps":["trace[48304219] 'agreement among raft nodes before linearized reading' (duration: 271.16781ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:45:14.856132Z","caller":"traceutil/trace.go:171","msg":"trace[554223613] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"334.048497ms","start":"2026-04-07T06:45:14.521985Z","end":"2026-04-07T06:45:14.856033Z","steps":["trace[554223613] 'process raft request' (duration: 333.610046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:45:14.85632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:45:14.521942Z","time spent":"334.299825ms","remote":"127.0.0.1:59566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:45:14.868345Z","caller":"traceutil/trace.go:171","msg":"trace[1761257343] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"271.53814ms","start":"2026-04-07T06:45:14.596795Z","end":"2026-04-07T06:45:14.868333Z","steps":["trace[1761257343] 'process raft request' (duration: 271.414886ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:45:15.372543Z","caller":"traceutil/trace.go:171","msg":"trace[214917216] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"141.879096ms","start":"2026-04-07T06:45:15.230638Z","end":"2026-04-07T06:45:15.372517Z","steps":["trace[214917216] 'process raft request' (duration: 141.745982ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:45:15.587793Z","caller":"traceutil/trace.go:171","msg":"trace[1112041102] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"178.90037ms","start":"2026-04-07T06:45:15.408835Z","end":"2026-04-07T06:45:15.587736Z","steps":["trace[1112041102] 'process raft request' (duration: 178.682844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:45:15.805123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.433941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:45:15.805208Z","caller":"traceutil/trace.go:171","msg":"trace[36361425] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"136.82872ms","start":"2026-04-07T06:45:15.668363Z","end":"2026-04-07T06:45:15.805192Z","steps":["trace[36361425] 'process raft request' (duration: 35.256655ms)","trace[36361425] 'compare' (duration: 101.144073ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:45:16.055472Z","caller":"traceutil/trace.go:171","msg":"trace[175046303] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"195.690238ms","start":"2026-04-07T06:45:15.859757Z","end":"2026-04-07T06:45:16.055448Z","steps":["trace[175046303] 'process raft request' (duration: 194.340511ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:45:27.684517Z","caller":"traceutil/trace.go:171","msg":"trace[1119212099] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"371.735424ms","start":"2026-04-07T06:45:27.312722Z","end":"2026-04-07T06:45:27.684458Z","steps":["trace[1119212099] 'process raft request' (duration: 371.329272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:45:27.684794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:45:27.312702Z","time spent":"371.95657ms","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:45:27.710108Z","caller":"traceutil/trace.go:171","msg":"trace[1549162941] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1396; }","duration":"284.251607ms","start":"2026-04-07T06:45:27.425833Z","end":"2026-04-07T06:45:27.710085Z","steps":["trace[1549162941] 'read index received' (duration: 257.97133ms)","trace[1549162941] 'applied index is now lower than readState.Index' (duration: 26.279347ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:45:27.710467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.48164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:45:27.71061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.299274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-07T06:45:27.710677Z","caller":"traceutil/trace.go:171","msg":"trace[997859806] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1345; }","duration":"167.425058ms","start":"2026-04-07T06:45:27.543237Z","end":"2026-04-07T06:45:27.710662Z","steps":["trace[997859806] 'agreement among raft nodes before linearized reading' (duration: 167.14728ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:45:27.71064Z","caller":"traceutil/trace.go:171","msg":"trace[1819984518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1345; }","duration":"123.626953ms","start":"2026-04-07T06:45:27.586908Z","end":"2026-04-07T06:45:27.710535Z","steps":["trace[1819984518] 'agreement among raft nodes before linearized reading' (duration: 123.479138ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:45:27.710869Z","caller":"traceutil/trace.go:171","msg":"trace[1127451576] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"396.316905ms","start":"2026-04-07T06:45:27.314528Z","end":"2026-04-07T06:45:27.710845Z","steps":["trace[1127451576] 'process raft request' (duration: 395.396869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:45:27.711867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:45:27.314503Z","time spent":"397.001324ms","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:45:27.711031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.214073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T06:45:27.71201Z","caller":"traceutil/trace.go:171","msg":"trace[242483153] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1345; }","duration":"286.227831ms","start":"2026-04-07T06:45:27.425748Z","end":"2026-04-07T06:45:27.711976Z","steps":["trace[242483153] 'agreement among raft nodes before linearized reading' (duration: 284.523094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:05.189722Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:05.690919Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:06.191286Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:06.691879Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:07.192344Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:07.586853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000489447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:07.586958Z","caller":"traceutil/trace.go:171","msg":"trace[880371670] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000649291s","start":"2026-04-07T06:48:05.586283Z","end":"2026-04-07T06:48:07.586932Z","steps":["trace[880371670] 'agreement among raft nodes before linearized reading' (duration: 2.000517857s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:07.587008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:05.586258Z","time spent":"2.000741203s","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 06:48:07 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:07.693562Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:08.194209Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:08.694574Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:09.194857Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:09.587193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99988979s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:09.587309Z","caller":"traceutil/trace.go:171","msg":"trace[1421069777] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000074326s","start":"2026-04-07T06:48:07.587212Z","end":"2026-04-07T06:48:09.587286Z","steps":["trace[1421069777] 'agreement among raft nodes before linearized reading' (duration: 1.999929822s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:09.587385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:07.587189Z","time spent":"2.000185779s","remote":"127.0.0.1:59356","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-04-07T06:48:09.684981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:04.686879Z","time spent":"4.998094472s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-07T06:48:09.692477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000483557s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:09.692563Z","caller":"traceutil/trace.go:171","msg":"trace[1251363299] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.00060591s","start":"2026-04-07T06:48:04.691932Z","end":"2026-04-07T06:48:09.692538Z","steps":["trace[1251363299] 'agreement among raft nodes before linearized reading' (duration: 5.000496667s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:09.692643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:04.691919Z","time spent":"5.000700692s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T06:48:09.696061Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:09.69608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999633354s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:09.696235Z","caller":"traceutil/trace.go:171","msg":"trace[13291444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.99987837s","start":"2026-04-07T06:48:04.696307Z","end":"2026-04-07T06:48:09.696185Z","steps":["trace[13291444] 'agreement among raft nodes before linearized reading' (duration: 4.999722616s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:09.696326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:04.696276Z","time spent":"5.000011654s","remote":"127.0.0.1:59664","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/04/07 06:48:09 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:10.196598Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:10.200563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:05.202731Z","time spent":"4.997821985s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/07 06:48:10 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:10.69766Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:11.198017Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583917,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:11.59866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000467595s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:11.598761Z","caller":"traceutil/trace.go:171","msg":"trace[1581600616] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000685842s","start":"2026-04-07T06:48:09.598052Z","end":"2026-04-07T06:48:11.598738Z","steps":["trace[1581600616] 'agreement among raft nodes before linearized reading' (duration: 2.000546267s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:11.598881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:09.598028Z","time spent":"2.000839776s","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 06:48:11 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:11.689002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:04.688835Z","time spent":"7.000157851s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-07T06:48:11.689881Z","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-04-07T06:48:11.690035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.00051451s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-07T06:48:11.690107Z","caller":"traceutil/trace.go:171","msg":"trace[767037701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"7.000635125s","start":"2026-04-07T06:48:04.689444Z","end":"2026-04-07T06:48:11.690079Z","steps":["trace[767037701] 'agreement among raft nodes before linearized reading' (duration: 7.000547922s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:11.690164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:04.689433Z","time spent":"7.000717396s","remote":"127.0.0.1:59664","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\" "} {"level":"warn","ts":"2026-04-07T06:48:12.190596Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:12.690758Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:13.191583Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:13.599099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000232739s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:13.599201Z","caller":"traceutil/trace.go:171","msg":"trace[38161313] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000416095s","start":"2026-04-07T06:48:11.598761Z","end":"2026-04-07T06:48:13.599177Z","steps":["trace[38161313] 'agreement among raft nodes before linearized reading' (duration: 2.0002806s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:13.599265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:11.598737Z","time spent":"2.000515846s","remote":"127.0.0.1:59356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 06:48:13 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:13.692709Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:14.193586Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:14.681546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.99226399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:14.681653Z","caller":"traceutil/trace.go:171","msg":"trace[1120751126] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.99261913s","start":"2026-04-07T06:48:11.689014Z","end":"2026-04-07T06:48:14.681633Z","steps":["trace[1120751126] 'agreement among raft nodes before linearized reading' (duration: 2.992491086s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:14.68171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:11.688994Z","time spent":"2.992701332s","remote":"127.0.0.1:59664","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/04/07 06:48:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:14.686373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.33765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:14.686427Z","caller":"traceutil/trace.go:171","msg":"trace[499235712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"992.438142ms","start":"2026-04-07T06:48:13.693976Z","end":"2026-04-07T06:48:14.686414Z","steps":["trace[499235712] 'agreement among raft nodes before linearized reading' (duration: 992.378911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:14.686481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:13.693927Z","time spent":"992.546666ms","remote":"127.0.0.1:59664","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/04/07 06:48:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:14.689809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.846007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:14.689972Z","caller":"traceutil/trace.go:171","msg":"trace[2043941947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"995.070084ms","start":"2026-04-07T06:48:13.694881Z","end":"2026-04-07T06:48:14.689952Z","steps":["trace[2043941947] 'agreement among raft nodes before linearized reading' (duration: 994.861388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:14.69002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:13.694873Z","time spent":"995.137766ms","remote":"127.0.0.1:59664","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/04/07 06:48:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:14.692201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997268316s","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-04-07T06:48:14.692243Z","caller":"traceutil/trace.go:171","msg":"trace[256162992] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.997342889s","start":"2026-04-07T06:48:11.694891Z","end":"2026-04-07T06:48:14.692234Z","steps":["trace[256162992] 'agreement among raft nodes before linearized reading' (duration: 2.997295768s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:14.692265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:11.694882Z","time spent":"2.997377529s","remote":"127.0.0.1:59664","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/04/07 06:48:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:14.694396Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:14.696336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.998869409s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:14.69637Z","caller":"traceutil/trace.go:171","msg":"trace[1869516318] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.998975872s","start":"2026-04-07T06:48:11.697386Z","end":"2026-04-07T06:48:14.696362Z","steps":["trace[1869516318] 'agreement among raft nodes before linearized reading' (duration: 2.99893727s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:14.696439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:11.697359Z","time spent":"2.999030345s","remote":"127.0.0.1:59664","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/04/07 06:48:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:14.707332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.010151041s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:14.707408Z","caller":"traceutil/trace.go:171","msg":"trace[782961980] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; }","duration":"10.010264015s","start":"2026-04-07T06:48:04.697124Z","end":"2026-04-07T06:48:14.707388Z","steps":["trace[782961980] 'agreement among raft nodes before linearized reading' (duration: 10.010166202s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:14.707463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:04.697113Z","time spent":"10.010338207s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} 2026/04/07 06:48:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:14.838327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.003107271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:14.838402Z","caller":"traceutil/trace.go:171","msg":"trace[651341595] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; }","duration":"10.003241004s","start":"2026-04-07T06:48:04.835146Z","end":"2026-04-07T06:48:14.838387Z","steps":["trace[651341595] 'agreement among raft nodes before linearized reading' (duration: 10.003157132s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:14.838444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:04.835121Z","time spent":"10.003311956s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} 2026/04/07 06:48:14 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:15.170242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:08.16914Z","time spent":"7.001093947s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-07T06:48:15.194803Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:15.200313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998182114s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:15.200417Z","caller":"traceutil/trace.go:171","msg":"trace[453217464] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; }","duration":"4.99835728s","start":"2026-04-07T06:48:10.202037Z","end":"2026-04-07T06:48:15.200394Z","steps":["trace[453217464] 'agreement among raft nodes before linearized reading' (duration: 4.998231956s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:15.20048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:10.202022Z","time spent":"4.998448521s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":0,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} 2026/04/07 06:48:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:15.608087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000185049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:15.608173Z","caller":"traceutil/trace.go:171","msg":"trace[798941307] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000282162s","start":"2026-04-07T06:48:13.607871Z","end":"2026-04-07T06:48:15.608153Z","steps":["trace[798941307] 'agreement among raft nodes before linearized reading' (duration: 2.000181809s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:15.608221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:13.607792Z","time spent":"2.000419695s","remote":"127.0.0.1:59352","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-04-07T06:48:15.69495Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:16.19545Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:16.593252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:09.592684Z","time spent":"7.000556552s","remote":"127.0.0.1:59448","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-07T06:48:16.696106Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:16.948517Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"41f79d66adf85cec","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:17.196437Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:17.382054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.998521417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:17.382159Z","caller":"traceutil/trace.go:171","msg":"trace[1825951788] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; }","duration":"9.998701592s","start":"2026-04-07T06:48:07.383432Z","end":"2026-04-07T06:48:17.382133Z","steps":["trace[1825951788] 'agreement among raft nodes before linearized reading' (duration: 9.998572579s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:17.38222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:07.38341Z","time spent":"9.998796885s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} 2026/04/07 06:48:17 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:17.609208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000087276s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:17.609338Z","caller":"traceutil/trace.go:171","msg":"trace[1481241641] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000297452s","start":"2026-04-07T06:48:15.609014Z","end":"2026-04-07T06:48:17.609312Z","steps":["trace[1481241641] 'agreement among raft nodes before linearized reading' (duration: 2.000132287s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:17.609405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:15.608992Z","time spent":"2.000401355s","remote":"127.0.0.1:59356","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-04-07T06:48:17.696942Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898583925,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:18.00045Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"13.313439063s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T06:48:18.028845Z","caller":"traceutil/trace.go:171","msg":"trace[1146165080] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"5.44436422s","start":"2026-04-07T06:48:12.584443Z","end":"2026-04-07T06:48:18.028807Z","steps":["trace[1146165080] 'process raft request' (duration: 5.444063442s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:18.028876Z","caller":"traceutil/trace.go:171","msg":"trace[733794786] transaction","detail":"{read_only:false; number_of_response:1; response_revision:2069; }","duration":"3.345147877s","start":"2026-04-07T06:48:14.683689Z","end":"2026-04-07T06:48:18.028837Z","steps":["trace[733794786] 'process raft request' (duration: 3.345007863s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:18.028999Z","caller":"traceutil/trace.go:171","msg":"trace[1965400962] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"3.337603723s","start":"2026-04-07T06:48:14.691382Z","end":"2026-04-07T06:48:18.028985Z","steps":["trace[1965400962] 'process raft request' (duration: 3.337386577s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.029045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:12.584414Z","time spent":"5.444530634s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:48:18.02908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:14.683653Z","time spent":"3.345321961s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":47,"response count":0,"response size":514,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:48:18.029131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:14.69137Z","time spent":"3.337674894s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":411,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:48:18.02886Z","caller":"traceutil/trace.go:171","msg":"trace[1177197791] transaction","detail":"{read_only:false; number_of_response:1; response_revision:2069; }","duration":"3.338955968s","start":"2026-04-07T06:48:14.689876Z","end":"2026-04-07T06:48:18.028831Z","steps":["trace[1177197791] 'process raft request' (duration: 3.338861496s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.029275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:14.689853Z","time spent":"3.339392161s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":48,"response count":0,"response size":474,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:48:18.02933Z","caller":"traceutil/trace.go:171","msg":"trace[1693818933] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"3.334635162s","start":"2026-04-07T06:48:14.694682Z","end":"2026-04-07T06:48:18.029317Z","steps":["trace[1693818933] 'process raft request' (duration: 3.334267372s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.029318Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"90.722µs","request":"header: lease_revoke:","response":"size:29","error":"lease not found"} {"level":"info","ts":"2026-04-07T06:48:18.029383Z","caller":"traceutil/trace.go:171","msg":"trace[1677812509] transaction","detail":"{read_only:false; number_of_response:1; response_revision:2071; }","duration":"2.854879297s","start":"2026-04-07T06:48:15.174491Z","end":"2026-04-07T06:48:18.029371Z","steps":["trace[1677812509] 'process raft request' (duration: 2.85459522s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.029401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:14.694671Z","time spent":"3.334692893s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:48:18.029433Z","caller":"traceutil/trace.go:171","msg":"trace[1601047394] linearizableReadLoop","detail":"{readStateIndex:2163; appliedIndex:2149; }","duration":"6.339451723s","start":"2026-04-07T06:48:11.689957Z","end":"2026-04-07T06:48:18.029408Z","steps":["trace[1601047394] 'read index received' (duration: 6.310686302s)","trace[1601047394] 'applied index is now lower than readState.Index' (duration: 28.76409ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:48:18.029442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:15.174468Z","time spent":"2.854940159s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":721,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:48:18.029534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:16.594965Z","time spent":"1.434564477s","remote":"127.0.0.1:59448","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-07T06:48:18.029591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.67789342s","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-04-07T06:48:18.029639Z","caller":"traceutil/trace.go:171","msg":"trace[103006787] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2071; }","duration":"8.677990333s","start":"2026-04-07T06:48:09.351638Z","end":"2026-04-07T06:48:18.029628Z","steps":["trace[103006787] 'agreement among raft nodes before linearized reading' (duration: 8.67789744s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.029655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.359605039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"warn","ts":"2026-04-07T06:48:18.029696Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"41f79d66adf85cec","error":"lease not found"} {"level":"info","ts":"2026-04-07T06:48:18.029706Z","caller":"traceutil/trace.go:171","msg":"trace[1206602958] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2071; }","duration":"9.359714011s","start":"2026-04-07T06:48:08.669977Z","end":"2026-04-07T06:48:18.029691Z","steps":["trace[1206602958] 'agreement among raft nodes before linearized reading' (duration: 9.359551867s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.029742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:08.669952Z","time spent":"9.359782144s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-07T06:48:18.029745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.173890836s","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-04-07T06:48:18.029773Z","caller":"traceutil/trace.go:171","msg":"trace[1666015571] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2071; }","duration":"9.173961546s","start":"2026-04-07T06:48:08.855802Z","end":"2026-04-07T06:48:18.029763Z","steps":["trace[1666015571] 'agreement among raft nodes before linearized reading' (duration: 9.173920214s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.029671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:09.351607Z","time spent":"8.678056463s","remote":"127.0.0.1:59830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:18.029798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:08.855786Z","time spent":"9.174005988s","remote":"127.0.0.1:59792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":31,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:18.029944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.307483886s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-04-07T06:48:18.029924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.91598619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-04-07T06:48:18.02999Z","caller":"traceutil/trace.go:171","msg":"trace[170176081] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2071; }","duration":"6.307558718s","start":"2026-04-07T06:48:11.722419Z","end":"2026-04-07T06:48:18.029978Z","steps":["trace[170176081] 'agreement among raft nodes before linearized reading' (duration: 6.307328762s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.030034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:11.722411Z","time spent":"6.307613279s","remote":"127.0.0.1:59922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":162,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:18.030066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432192161s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a4004e58dee78c\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:48:18.030105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.383863246s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:48:18.030109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.894033909s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:48:18.030114Z","caller":"traceutil/trace.go:171","msg":"trace[1454861279] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a4004e58dee78c; range_end:; response_count:0; response_revision:2071; }","duration":"1.432275094s","start":"2026-04-07T06:48:16.597827Z","end":"2026-04-07T06:48:18.030102Z","steps":["trace[1454861279] 'agreement among raft nodes before linearized reading' (duration: 1.432194212s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.030178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:16.59779Z","time spent":"1.432359747s","remote":"127.0.0.1:59448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":29,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a4004e58dee78c\" "} {"level":"info","ts":"2026-04-07T06:48:18.030148Z","caller":"traceutil/trace.go:171","msg":"trace[1140954161] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2071; }","duration":"2.894131731s","start":"2026-04-07T06:48:15.136005Z","end":"2026-04-07T06:48:18.030137Z","steps":["trace[1140954161] 'agreement among raft nodes before linearized reading' (duration: 2.894064559s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:18.03014Z","caller":"traceutil/trace.go:171","msg":"trace[1914979183] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2071; }","duration":"9.383956439s","start":"2026-04-07T06:48:08.646174Z","end":"2026-04-07T06:48:18.03013Z","steps":["trace[1914979183] 'agreement among raft nodes before linearized reading' (duration: 9.383884997s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.030213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:15.135983Z","time spent":"2.894221213s","remote":"127.0.0.1:43394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-07T06:48:18.030022Z","caller":"traceutil/trace.go:171","msg":"trace[1460821491] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2071; }","duration":"9.916139934s","start":"2026-04-07T06:48:08.113858Z","end":"2026-04-07T06:48:18.029998Z","steps":["trace[1460821491] 'agreement among raft nodes before linearized reading' (duration: 9.915812815s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.030227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.541648733s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-07T06:48:18.030238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:08.646148Z","time spent":"9.384078042s","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-04-07T06:48:18.030265Z","caller":"traceutil/trace.go:171","msg":"trace[1311003312] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:2071; }","duration":"3.541802667s","start":"2026-04-07T06:48:14.488452Z","end":"2026-04-07T06:48:18.030254Z","steps":["trace[1311003312] 'agreement among raft nodes before linearized reading' (duration: 3.541639783s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.030266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:08.113832Z","time spent":"9.916419932s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-07T06:48:18.030295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:14.488425Z","time spent":"3.541863589s","remote":"127.0.0.1:59406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.204\" "} {"level":"warn","ts":"2026-04-07T06:48:18.030383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.992844179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:48:18.0304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.095784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7111"} {"level":"info","ts":"2026-04-07T06:48:18.030414Z","caller":"traceutil/trace.go:171","msg":"trace[1990849910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2071; }","duration":"1.992901391s","start":"2026-04-07T06:48:16.037504Z","end":"2026-04-07T06:48:18.030406Z","steps":["trace[1990849910] 'agreement among raft nodes before linearized reading' (duration: 1.99285198s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:18.030435Z","caller":"traceutil/trace.go:171","msg":"trace[1621528288] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:2071; }","duration":"414.139897ms","start":"2026-04-07T06:48:17.616284Z","end":"2026-04-07T06:48:18.030424Z","steps":["trace[1621528288] 'agreement among raft nodes before linearized reading' (duration: 414.065044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.030446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:16.037489Z","time spent":"1.992947212s","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T06:48:18.030461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.46630648s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:48:18.030468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:17.616277Z","time spent":"414.184217ms","remote":"127.0.0.1:59580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7135,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-04-07T06:48:18.030486Z","caller":"traceutil/trace.go:171","msg":"trace[1782935177] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2071; }","duration":"3.466355761s","start":"2026-04-07T06:48:14.564123Z","end":"2026-04-07T06:48:18.030479Z","steps":["trace[1782935177] 'agreement among raft nodes before linearized reading' (duration: 3.46631264s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.030509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:14.564111Z","time spent":"3.466391544s","remote":"127.0.0.1:43624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:18.030613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.203700846s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T06:48:18.030642Z","caller":"traceutil/trace.go:171","msg":"trace[499958742] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2071; }","duration":"2.203786707s","start":"2026-04-07T06:48:15.826847Z","end":"2026-04-07T06:48:18.030634Z","steps":["trace[499958742] 'agreement among raft nodes before linearized reading' (duration: 2.203726535s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.030649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.426824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:48:18.03067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:15.826825Z","time spent":"2.203838839s","remote":"127.0.0.1:59750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-04-07T06:48:18.030682Z","caller":"traceutil/trace.go:171","msg":"trace[2225084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2071; }","duration":"414.488235ms","start":"2026-04-07T06:48:17.61618Z","end":"2026-04-07T06:48:18.030669Z","steps":["trace[2225084] 'agreement among raft nodes before linearized reading' (duration: 414.442604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:18.030713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:17.616165Z","time spent":"414.542538ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T06:48:40.087219Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:40.588273Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:41.089611Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:41.5868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000174852s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:41.586905Z","caller":"traceutil/trace.go:171","msg":"trace[1259330348] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000342547s","start":"2026-04-07T06:48:39.586541Z","end":"2026-04-07T06:48:41.586884Z","steps":["trace[1259330348] 'agreement among raft nodes before linearized reading' (duration: 2.000217364s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:41.587012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:39.58652Z","time spent":"2.00047334s","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 06:48:41 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:41.590284Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:42.09101Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:42.591203Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:43.091359Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:43.587628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000189983s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:43.587758Z","caller":"traceutil/trace.go:171","msg":"trace[834436773] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000386058s","start":"2026-04-07T06:48:41.587346Z","end":"2026-04-07T06:48:43.587732Z","steps":["trace[834436773] 'agreement among raft nodes before linearized reading' (duration: 2.000213414s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:43.587819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:41.587335Z","time spent":"2.000472381s","remote":"127.0.0.1:59356","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-04-07T06:48:43.592428Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:44.092607Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:44.593376Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:45.093757Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:45.393817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999565448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:45.393907Z","caller":"traceutil/trace.go:171","msg":"trace[1643436959] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999708571s","start":"2026-04-07T06:48:40.394173Z","end":"2026-04-07T06:48:45.393882Z","steps":["trace[1643436959] 'agreement among raft nodes before linearized reading' (duration: 4.999605809s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:45.393954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:40.394151Z","time spent":"4.999793855s","remote":"127.0.0.1:59664","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/04/07 06:48:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:45.593931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:45.597233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000371298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:45.597324Z","caller":"traceutil/trace.go:171","msg":"trace[77285480] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000531883s","start":"2026-04-07T06:48:43.596772Z","end":"2026-04-07T06:48:45.597304Z","steps":["trace[77285480] 'agreement among raft nodes before linearized reading' (duration: 2.00041263s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:45.597369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:43.596753Z","time spent":"2.000607165s","remote":"127.0.0.1:59352","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-04-07T06:48:45.619309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998818908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:45.619439Z","caller":"traceutil/trace.go:171","msg":"trace[1248874827] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999015402s","start":"2026-04-07T06:48:40.620392Z","end":"2026-04-07T06:48:45.619408Z","steps":["trace[1248874827] 'agreement among raft nodes before linearized reading' (duration: 4.998836098s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:45.619508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:40.620377Z","time spent":"4.999118335s","remote":"127.0.0.1:59664","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/04/07 06:48:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:46.053656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999395123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:46.053744Z","caller":"traceutil/trace.go:171","msg":"trace[1634754739] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999551146s","start":"2026-04-07T06:48:41.054176Z","end":"2026-04-07T06:48:46.053727Z","steps":["trace[1634754739] 'agreement among raft nodes before linearized reading' (duration: 4.999444724s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:46.053793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:41.054154Z","time spent":"4.999629099s","remote":"127.0.0.1:59664","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/04/07 06:48:46 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:46.09437Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:46.196339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:39.195271Z","time spent":"7.001062616s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-04-07T06:48:46.58687Z","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-04-07T06:48:46.987812Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"41f79d66adf85e09","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:47.087212Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:47.588095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:47.598684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000570354s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:47.598769Z","caller":"traceutil/trace.go:171","msg":"trace[1175777037] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000692998s","start":"2026-04-07T06:48:45.598055Z","end":"2026-04-07T06:48:47.598748Z","steps":["trace[1175777037] 'agreement among raft nodes before linearized reading' (duration: 2.000587905s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:47.59882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:45.598037Z","time spent":"2.000773779s","remote":"127.0.0.1:59356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 06:48:47 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:48.037084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000359668s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:48.03719Z","caller":"traceutil/trace.go:171","msg":"trace[1995485123] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000538083s","start":"2026-04-07T06:48:46.036625Z","end":"2026-04-07T06:48:48.037164Z","steps":["trace[1995485123] 'agreement among raft nodes before linearized reading' (duration: 2.00041202s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:48.037245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:46.036583Z","time spent":"2.000651586s","remote":"127.0.0.1:59352","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-04-07T06:48:48.089109Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:48.590337Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:49.091381Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:49.188796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.132843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:49.188899Z","caller":"traceutil/trace.go:171","msg":"trace[1717647666] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; }","duration":"987.300078ms","start":"2026-04-07T06:48:48.201575Z","end":"2026-04-07T06:48:49.188875Z","steps":["trace[1717647666] 'agreement among raft nodes before linearized reading' (duration: 987.178125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:49.188957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:48.201534Z","time spent":"987.40617ms","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} 2026/04/07 06:48:49 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:49.592548Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:49.607684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000362207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:49.607799Z","caller":"traceutil/trace.go:171","msg":"trace[1453277070] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000544463s","start":"2026-04-07T06:48:47.607235Z","end":"2026-04-07T06:48:49.60778Z","steps":["trace[1453277070] 'agreement among raft nodes before linearized reading' (duration: 2.000408779s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:49.607838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:47.607208Z","time spent":"2.000622985s","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 06:48:49 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:50.093206Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:50.39456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.998204943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:50.394655Z","caller":"traceutil/trace.go:171","msg":"trace[1633735634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.998346097s","start":"2026-04-07T06:48:47.396286Z","end":"2026-04-07T06:48:50.394632Z","steps":["trace[1633735634] 'agreement among raft nodes before linearized reading' (duration: 2.998226073s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:50.39471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:47.396274Z","time spent":"2.998425509s","remote":"127.0.0.1:59664","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/04/07 06:48:50 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:50.593648Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:50.61921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997460322s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:50.619334Z","caller":"traceutil/trace.go:171","msg":"trace[695526621] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.997654698s","start":"2026-04-07T06:48:47.621652Z","end":"2026-04-07T06:48:50.619307Z","steps":["trace[695526621] 'agreement among raft nodes before linearized reading' (duration: 2.997483013s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:50.619471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:47.621639Z","time spent":"2.997816332s","remote":"127.0.0.1:59664","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/04/07 06:48:50 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:50.865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000305707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:50.865086Z","caller":"traceutil/trace.go:171","msg":"trace[1729226904] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000538843s","start":"2026-04-07T06:48:48.864527Z","end":"2026-04-07T06:48:50.865066Z","steps":["trace[1729226904] 'agreement among raft nodes before linearized reading' (duration: 2.00043357s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:50.865121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:48.864488Z","time spent":"2.000626655s","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 06:48:50 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:50.935323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999398313s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:50.935422Z","caller":"traceutil/trace.go:171","msg":"trace[1183236919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"9.999573698s","start":"2026-04-07T06:48:40.935825Z","end":"2026-04-07T06:48:50.935399Z","steps":["trace[1183236919] 'agreement among raft nodes before linearized reading' (duration: 9.999447545s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:50.935475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:40.935803Z","time spent":"9.99966263s","remote":"127.0.0.1:59664","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/04/07 06:48:50 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:50.93593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999847616s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:50.935981Z","caller":"traceutil/trace.go:171","msg":"trace[1772861247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"9.999970298s","start":"2026-04-07T06:48:40.935993Z","end":"2026-04-07T06:48:50.935964Z","steps":["trace[1772861247] 'agreement among raft nodes before linearized reading' (duration: 9.999904867s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:50.936008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:40.935951Z","time spent":"10.000050822s","remote":"127.0.0.1:59664","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/04/07 06:48:50 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:51.053631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.998308896s","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-04-07T06:48:51.053662Z","caller":"traceutil/trace.go:171","msg":"trace[1451495641] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.998392988s","start":"2026-04-07T06:48:48.055262Z","end":"2026-04-07T06:48:51.053655Z","steps":["trace[1451495641] 'agreement among raft nodes before linearized reading' (duration: 2.998358297s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:51.053681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:48.055234Z","time spent":"2.998441989s","remote":"127.0.0.1:59664","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/04/07 06:48:51 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:51.093862Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:51.59434Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:51.608738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00042184s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T06:48:51.608897Z","caller":"traceutil/trace.go:171","msg":"trace[250307129] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000649037s","start":"2026-04-07T06:48:49.60822Z","end":"2026-04-07T06:48:51.608869Z","steps":["trace[250307129] 'agreement among raft nodes before linearized reading' (duration: 2.000438231s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:51.608961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:49.608198Z","time spent":"2.000750999s","remote":"127.0.0.1:59356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 06:48:51 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:52.094765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:52.595277Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:53.09585Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813032898584322,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T06:48:53.113104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999867307s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:53.113198Z","caller":"traceutil/trace.go:171","msg":"trace[957663792] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; }","duration":"10.000029471s","start":"2026-04-07T06:48:43.113145Z","end":"2026-04-07T06:48:53.113174Z","steps":["trace[957663792] 'agreement among raft nodes before linearized reading' (duration: 9.999915348s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.113247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:43.113123Z","time spent":"10.000115123s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} 2026/04/07 06:48:53 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:53.125605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.999756392s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:53.125764Z","caller":"traceutil/trace.go:171","msg":"trace[976093085] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; }","duration":"10.0000237s","start":"2026-04-07T06:48:43.125716Z","end":"2026-04-07T06:48:53.12574Z","steps":["trace[976093085] 'agreement among raft nodes before linearized reading' (duration: 9.999759373s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.125865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:43.125686Z","time spent":"10.000131234s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} 2026/04/07 06:48:53 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" 2026/04/07 06:48:53 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:53.587321Z","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-04-07T06:48:53.587534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.75726309s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:53.587539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.747200515s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-07T06:48:53.5876Z","caller":"traceutil/trace.go:171","msg":"trace[233386137] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; }","duration":"9.757398573s","start":"2026-04-07T06:48:43.830176Z","end":"2026-04-07T06:48:53.587575Z","steps":["trace[233386137] 'agreement among raft nodes before linearized reading' (duration: 9.757309631s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:53.5876Z","caller":"traceutil/trace.go:171","msg":"trace[706307095] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; }","duration":"9.747348088s","start":"2026-04-07T06:48:43.840235Z","end":"2026-04-07T06:48:53.587583Z","steps":["trace[706307095] 'agreement among raft nodes before linearized reading' (duration: 9.747257616s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.587653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:43.830155Z","time spent":"9.757486795s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-07T06:48:53.587612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.612817957s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff\" ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:53.587725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.460049924s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-07T06:48:53.587753Z","caller":"traceutil/trace.go:171","msg":"trace[526013821] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff; range_end:; }","duration":"12.612983711s","start":"2026-04-07T06:48:40.974741Z","end":"2026-04-07T06:48:53.587725Z","steps":["trace[526013821] 'agreement among raft nodes before linearized reading' (duration: 12.612810937s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:53.587773Z","caller":"traceutil/trace.go:171","msg":"trace[1037532487] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; }","duration":"7.460133876s","start":"2026-04-07T06:48:46.127614Z","end":"2026-04-07T06:48:53.587748Z","steps":["trace[1037532487] 'agreement among raft nodes before linearized reading' (duration: 7.460099596s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.587745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.71605736s","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":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:53.587813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:40.974702Z","time spent":"12.613098213s","remote":"127.0.0.1:59580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":0,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff\" "} {"level":"warn","ts":"2026-04-07T06:48:53.587838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.598128445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:53.587793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"13.64392276s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-07T06:48:53.587867Z","caller":"traceutil/trace.go:171","msg":"trace[360250663] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; }","duration":"7.598181175s","start":"2026-04-07T06:48:45.989678Z","end":"2026-04-07T06:48:53.587859Z","steps":["trace[360250663] 'agreement among raft nodes before linearized reading' (duration: 7.598149975s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.587887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.61294483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff.18a40050ff5d865f\" ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:53.587809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:46.127582Z","time spent":"7.460217948s","remote":"127.0.0.1:59770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":0,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.587836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.022282106s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-07T06:48:53.587921Z","caller":"traceutil/trace.go:171","msg":"trace[357787748] range","detail":"{range_begin:/registry/events/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff.18a40050ff5d865f; range_end:; }","duration":"12.613025421s","start":"2026-04-07T06:48:40.974886Z","end":"2026-04-07T06:48:53.587911Z","steps":["trace[357787748] 'agreement among raft nodes before linearized reading' (duration: 12.612992721s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:53.587913Z","caller":"traceutil/trace.go:171","msg":"trace[106706412] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; }","duration":"13.644232239s","start":"2026-04-07T06:48:39.943657Z","end":"2026-04-07T06:48:53.587889Z","steps":["trace[106706412] 'agreement among raft nodes before linearized reading' (duration: 13.644014143s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.587955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:40.974844Z","time spent":"12.613103054s","remote":"127.0.0.1:59448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":0,"request content":"key:\"/registry/events/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff.18a40050ff5d865f\" "} {"level":"warn","ts":"2026-04-07T06:48:53.587932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.722258656s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:53.587665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:43.84021Z","time spent":"9.747442112s","remote":"127.0.0.1:43656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.587991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:39.943634Z","time spent":"13.644343272s","remote":"127.0.0.1:59622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":0,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-04-07T06:48:53.588004Z","caller":"traceutil/trace.go:171","msg":"trace[2036598040] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; }","duration":"7.722375839s","start":"2026-04-07T06:48:45.865617Z","end":"2026-04-07T06:48:53.587993Z","steps":["trace[2036598040] 'agreement among raft nodes before linearized reading' (duration: 7.722304687s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.58801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.773419743s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-07T06:48:53.588074Z","caller":"traceutil/trace.go:171","msg":"trace[458773160] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; }","duration":"12.773538505s","start":"2026-04-07T06:48:40.814527Z","end":"2026-04-07T06:48:53.588065Z","steps":["trace[458773160] 'agreement among raft nodes before linearized reading' (duration: 12.773466674s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.58808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:45.865594Z","time spent":"7.722472301s","remote":"127.0.0.1:43608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.588077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.064218496s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-07T06:48:53.588119Z","caller":"traceutil/trace.go:171","msg":"trace[1595810546] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; }","duration":"8.064306219s","start":"2026-04-07T06:48:45.5238Z","end":"2026-04-07T06:48:53.588107Z","steps":["trace[1595810546] 'agreement among raft nodes before linearized reading' (duration: 8.064259437s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.588116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:40.814501Z","time spent":"12.773602429s","remote":"127.0.0.1:59710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":0,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.588155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:45.523771Z","time spent":"8.064374381s","remote":"127.0.0.1:59526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":0,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.588159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.097435837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:53.588197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.047937452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-07T06:48:53.587862Z","caller":"traceutil/trace.go:171","msg":"trace[1616283848] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; }","duration":"13.716212194s","start":"2026-04-07T06:48:39.87162Z","end":"2026-04-07T06:48:53.587832Z","steps":["trace[1616283848] 'agreement among raft nodes before linearized reading' (duration: 13.71607152s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:53.588188Z","caller":"traceutil/trace.go:171","msg":"trace[1581547532] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; }","duration":"9.097525189s","start":"2026-04-07T06:48:44.490654Z","end":"2026-04-07T06:48:53.588179Z","steps":["trace[1581547532] 'agreement among raft nodes before linearized reading' (duration: 9.097490279s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:53.588221Z","caller":"traceutil/trace.go:171","msg":"trace[557794944] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; }","duration":"8.047963543s","start":"2026-04-07T06:48:45.54025Z","end":"2026-04-07T06:48:53.588213Z","steps":["trace[557794944] 'agreement among raft nodes before linearized reading' (duration: 8.047937262s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.588244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:44.490621Z","time spent":"9.097614342s","remote":"127.0.0.1:59406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/162.253.55.204\" "} {"level":"warn","ts":"2026-04-07T06:48:53.588252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:45.540239Z","time spent":"8.048000083s","remote":"127.0.0.1:43544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":0,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-07T06:48:53.58796Z","caller":"traceutil/trace.go:171","msg":"trace[2016769130] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; }","duration":"12.022496933s","start":"2026-04-07T06:48:41.565434Z","end":"2026-04-07T06:48:53.587931Z","steps":["trace[2016769130] 'agreement among raft nodes before linearized reading' (duration: 12.022335479s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.588307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:41.56541Z","time spent":"12.022880682s","remote":"127.0.0.1:59688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":0,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.588359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.652780206s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"","error":"etcdserver: request timed out"} {"level":"warn","ts":"2026-04-07T06:48:53.5879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:45.989663Z","time spent":"7.598228719s","remote":"127.0.0.1:43450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"info","ts":"2026-04-07T06:48:53.588389Z","caller":"traceutil/trace.go:171","msg":"trace[210382835] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; }","duration":"9.652830177s","start":"2026-04-07T06:48:43.935548Z","end":"2026-04-07T06:48:53.588378Z","steps":["trace[210382835] 'agreement among raft nodes before linearized reading' (duration: 9.652803726s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.588418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:43.935534Z","time spent":"9.652877149s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-07T06:48:53.588249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:39.871568Z","time spent":"13.716665666s","remote":"127.0.0.1:43502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":0,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.588757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.272561853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-04-07T06:48:53.588791Z","caller":"traceutil/trace.go:171","msg":"trace[1833402026] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; }","duration":"12.273762725s","start":"2026-04-07T06:48:41.315019Z","end":"2026-04-07T06:48:53.588781Z","steps":["trace[1833402026] 'agreement among raft nodes before linearized reading' (duration: 12.272585553s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.588892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:41.315002Z","time spent":"12.273879638s","remote":"127.0.0.1:59580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":0,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"warn","ts":"2026-04-07T06:48:53.616782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999828144s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T06:48:53.616847Z","caller":"traceutil/trace.go:171","msg":"trace[698968649] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999951916s","start":"2026-04-07T06:48:51.61688Z","end":"2026-04-07T06:48:53.616832Z","steps":["trace[698968649] 'agreement among raft nodes before linearized reading' (duration: 1.999876545s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.616924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:51.616858Z","time spent":"2.000054769s","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 06:48:53 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T06:48:53.919865Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"14.724441514s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T06:48:53.964897Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"21.461µs","request":"header: lease_revoke:","response":"size:29","error":"lease not found"} {"level":"info","ts":"2026-04-07T06:48:53.965359Z","caller":"traceutil/trace.go:171","msg":"trace[1464986737] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"5.124230343s","start":"2026-04-07T06:48:48.841107Z","end":"2026-04-07T06:48:53.965338Z","steps":["trace[1464986737] 'process raft request' (duration: 5.123980286s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:53.965397Z","caller":"traceutil/trace.go:171","msg":"trace[665197723] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"5.238834904s","start":"2026-04-07T06:48:48.726518Z","end":"2026-04-07T06:48:53.965353Z","steps":["trace[665197723] 'process raft request' (duration: 5.238466284s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.965466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:48.841073Z","time spent":"5.124328676s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:48:53.965337Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"41f79d66adf85e09","error":"lease not found"} {"level":"warn","ts":"2026-04-07T06:48:53.965772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:48.726487Z","time spent":"5.239009859s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:48:53.967855Z","caller":"traceutil/trace.go:171","msg":"trace[780653431] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"3.346197438s","start":"2026-04-07T06:48:50.621642Z","end":"2026-04-07T06:48:53.967839Z","steps":["trace[780653431] 'process raft request' (duration: 3.345791807s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.967924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:50.621607Z","time spent":"3.3462873s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:48:53.968143Z","caller":"traceutil/trace.go:171","msg":"trace[607650120] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"3.029759715s","start":"2026-04-07T06:48:50.938375Z","end":"2026-04-07T06:48:53.968135Z","steps":["trace[607650120] 'process raft request' (duration: 3.029282962s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.968185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:50.938337Z","time spent":"3.029828127s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":411,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T06:48:53.968235Z","caller":"traceutil/trace.go:171","msg":"trace[1048944483] linearizableReadLoop","detail":"{readStateIndex:2304; appliedIndex:2293; }","duration":"380.75734ms","start":"2026-04-07T06:48:53.587452Z","end":"2026-04-07T06:48:53.968209Z","steps":["trace[1048944483] 'read index received' (duration: 332.655617ms)","trace[1048944483] 'applied index is now lower than readState.Index' (duration: 48.100213ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:48:53.968362Z","caller":"traceutil/trace.go:171","msg":"trace[40091302] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"3.029483938s","start":"2026-04-07T06:48:50.938866Z","end":"2026-04-07T06:48:53.96835Z","steps":["trace[40091302] 'process raft request' (duration: 3.029125778s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.968459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:50.93886Z","time spent":"3.029543199s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:48:53.968538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.983268649s","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-04-07T06:48:53.968569Z","caller":"traceutil/trace.go:171","msg":"trace[1350768904] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2204; }","duration":"3.983355961s","start":"2026-04-07T06:48:49.985204Z","end":"2026-04-07T06:48:53.96856Z","steps":["trace[1350768904] 'agreement among raft nodes before linearized reading' (duration: 3.98330026s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.968595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:49.985174Z","time spent":"3.983414973s","remote":"127.0.0.1:43430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.968668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.696201542s","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-04-07T06:48:53.96871Z","caller":"traceutil/trace.go:171","msg":"trace[16067630] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"2.912181254s","start":"2026-04-07T06:48:51.056517Z","end":"2026-04-07T06:48:53.968698Z","steps":["trace[16067630] 'process raft request' (duration: 2.911563096s)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:48:53.968719Z","caller":"traceutil/trace.go:171","msg":"trace[730875626] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:2204; }","duration":"4.696311696s","start":"2026-04-07T06:48:49.272393Z","end":"2026-04-07T06:48:53.968705Z","steps":["trace[730875626] 'agreement among raft nodes before linearized reading' (duration: 4.696226913s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.968749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:51.056509Z","time spent":"2.912217864s","remote":"127.0.0.1:59664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":456,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T06:48:53.968763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:49.27237Z","time spent":"4.696382977s","remote":"127.0.0.1:43520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.968873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060680332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:48:53.968901Z","caller":"traceutil/trace.go:171","msg":"trace[1319003642] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2204; }","duration":"1.060768364s","start":"2026-04-07T06:48:52.908124Z","end":"2026-04-07T06:48:53.968893Z","steps":["trace[1319003642] 'agreement among raft nodes before linearized reading' (duration: 1.060721532s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.968921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:52.908098Z","time spent":"1.060817715s","remote":"127.0.0.1:43650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.968953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.927951742s","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-04-07T06:48:53.968992Z","caller":"traceutil/trace.go:171","msg":"trace[886051028] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2204; }","duration":"4.928024474s","start":"2026-04-07T06:48:49.040958Z","end":"2026-04-07T06:48:53.968983Z","steps":["trace[886051028] 'agreement among raft nodes before linearized reading' (duration: 4.927961783s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.969028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:49.040938Z","time spent":"4.928083726s","remote":"127.0.0.1:59886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.969045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.175615611s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-04-07T06:48:53.969066Z","caller":"traceutil/trace.go:171","msg":"trace[717162278] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2204; }","duration":"1.175683123s","start":"2026-04-07T06:48:52.793376Z","end":"2026-04-07T06:48:53.969059Z","steps":["trace[717162278] 'agreement among raft nodes before linearized reading' (duration: 1.175638752s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.969084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:52.793355Z","time spent":"1.175724383s","remote":"127.0.0.1:59434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-04-07T06:48:53.969231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.29674776s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T06:48:53.969263Z","caller":"traceutil/trace.go:171","msg":"trace[1676886184] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2204; }","duration":"6.296798811s","start":"2026-04-07T06:48:47.672454Z","end":"2026-04-07T06:48:53.969253Z","steps":["trace[1676886184] 'agreement among raft nodes before linearized reading' (duration: 6.296717968s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.969292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:47.672443Z","time spent":"6.296840231s","remote":"127.0.0.1:59854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.969364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.648516577s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:48:53.969387Z","caller":"traceutil/trace.go:171","msg":"trace[1740128197] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2204; }","duration":"1.648584199s","start":"2026-04-07T06:48:52.320796Z","end":"2026-04-07T06:48:53.96938Z","steps":["trace[1740128197] 'agreement among raft nodes before linearized reading' (duration: 1.648520427s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.969408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:52.320773Z","time spent":"1.64862985s","remote":"127.0.0.1:43462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.969525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.963663044s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T06:48:53.969541Z","caller":"traceutil/trace.go:171","msg":"trace[1549519682] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2204; }","duration":"1.963726148s","start":"2026-04-07T06:48:52.005811Z","end":"2026-04-07T06:48:53.969537Z","steps":["trace[1549519682] 'agreement among raft nodes before linearized reading' (duration: 1.963684626s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.969557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:52.005785Z","time spent":"1.963768519s","remote":"127.0.0.1:59466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":11,"response size":31,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.969638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.645571467s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:48:53.96968Z","caller":"traceutil/trace.go:171","msg":"trace[732152366] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2204; }","duration":"6.645680231s","start":"2026-04-07T06:48:47.323989Z","end":"2026-04-07T06:48:53.969669Z","steps":["trace[732152366] 'agreement among raft nodes before linearized reading' (duration: 6.645593569s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.969716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:47.323967Z","time spent":"6.645736262s","remote":"127.0.0.1:59694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-07T06:48:53.969962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff\" ","response":"range_response_count:1 size:5487"} {"level":"info","ts":"2026-04-07T06:48:53.969982Z","caller":"traceutil/trace.go:171","msg":"trace[1155423794] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff; range_end:; response_count:1; response_revision:2204; }","duration":"375.345383ms","start":"2026-04-07T06:48:53.59463Z","end":"2026-04-07T06:48:53.969975Z","steps":["trace[1155423794] 'agreement among raft nodes before linearized reading' (duration: 375.23973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.97001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:53.594608Z","time spent":"375.397294ms","remote":"127.0.0.1:59580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":5511,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff\" "} {"level":"warn","ts":"2026-04-07T06:48:53.969298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176261168s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:104744"} {"level":"info","ts":"2026-04-07T06:48:53.970056Z","caller":"traceutil/trace.go:171","msg":"trace[289492287] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2204; }","duration":"1.177088131s","start":"2026-04-07T06:48:52.792961Z","end":"2026-04-07T06:48:53.970049Z","steps":["trace[289492287] 'agreement among raft nodes before linearized reading' (duration: 1.176213627s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.97008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:52.792913Z","time spent":"1.177161443s","remote":"127.0.0.1:59418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":104768,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-04-07T06:48:53.970293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.037704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:48:53.970332Z","caller":"traceutil/trace.go:171","msg":"trace[251560325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2204; }","duration":"353.110625ms","start":"2026-04-07T06:48:53.617211Z","end":"2026-04-07T06:48:53.970322Z","steps":["trace[251560325] 'agreement among raft nodes before linearized reading' (duration: 353.064553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.970384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:53.617171Z","time spent":"353.209297ms","remote":"127.0.0.1:59356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T06:48:53.970542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.414604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff.18a40050ff5d865f\" ","response":"range_response_count:1 size:881"} {"level":"info","ts":"2026-04-07T06:48:53.97057Z","caller":"traceutil/trace.go:171","msg":"trace[1647806186] range","detail":"{range_begin:/registry/events/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff.18a40050ff5d865f; range_end:; response_count:1; response_revision:2204; }","duration":"375.462685ms","start":"2026-04-07T06:48:53.5951Z","end":"2026-04-07T06:48:53.970563Z","steps":["trace[1647806186] 'agreement among raft nodes before linearized reading' (duration: 375.381733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:48:53.97059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:48:53.595091Z","time spent":"375.494036ms","remote":"127.0.0.1:59448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":1,"response size":905,"request content":"key:\"/registry/events/envoy-gateway-system/envoy-gateway-78446f96c9-wcmff.18a40050ff5d865f\" "} {"level":"warn","ts":"2026-04-07T06:49:27.210996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.946904ms","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-04-07T06:49:27.21111Z","caller":"traceutil/trace.go:171","msg":"trace[566953084] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2388; }","duration":"106.108838ms","start":"2026-04-07T06:49:27.104982Z","end":"2026-04-07T06:49:27.211091Z","steps":["trace[566953084] 'range keys from in-memory index tree' (duration: 105.760779ms)"],"step_count":1}