{"level":"warn","ts":"2026-04-20T14:23:47.998346Z","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-20T14:23:47.998443Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.161:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.161:2380","--initial-cluster=instance=https://199.19.213.161:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.161:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.161: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-20T14:23:47.998515Z","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-20T14:23:47.998529Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.161:2380"]} {"level":"info","ts":"2026-04-20T14:23:47.998544Z","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-20T14:23:47.99916Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.161:2379"]} {"level":"info","ts":"2026-04-20T14:23:47.999253Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.161:2380"],"listen-peer-urls":["https://199.19.213.161:2380"],"advertise-client-urls":["https://199.19.213.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.161: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-20T14:23:48.00407Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.562684ms"} {"level":"info","ts":"2026-04-20T14:23:48.011416Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2460b0ba85bf91ab","cluster-id":"c077309761674c46"} {"level":"info","ts":"2026-04-20T14:23:48.011537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T14:23:48.011572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became follower at term 0"} {"level":"info","ts":"2026-04-20T14:23:48.011589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2460b0ba85bf91ab [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T14:23:48.011607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became follower at term 1"} {"level":"info","ts":"2026-04-20T14:23:48.01165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab switched to configuration voters=(2621289298283958699)"} {"level":"warn","ts":"2026-04-20T14:23:48.018649Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T14:23:48.020324Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T14:23:48.021674Z","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-20T14:23:48.026648Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2460b0ba85bf91ab","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T14:23:48.026893Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2460b0ba85bf91ab","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T14:23:48.026967Z","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-20T14:23:48.027004Z","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-20T14:23:48.027011Z","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-20T14:23:48.027993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab switched to configuration voters=(2621289298283958699)"} {"level":"info","ts":"2026-04-20T14:23:48.028197Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c077309761674c46","local-member-id":"2460b0ba85bf91ab","added-peer-id":"2460b0ba85bf91ab","added-peer-peer-urls":["https://199.19.213.161:2380"]} {"level":"info","ts":"2026-04-20T14:23:48.032405Z","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-20T14:23:48.032513Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.161:2380"} {"level":"info","ts":"2026-04-20T14:23:48.03258Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.161:2380"} {"level":"info","ts":"2026-04-20T14:23:48.032681Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2460b0ba85bf91ab","initial-advertise-peer-urls":["https://199.19.213.161:2380"],"listen-peer-urls":["https://199.19.213.161:2380"],"advertise-client-urls":["https://199.19.213.161:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.161:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T14:23:48.032718Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T14:23:48.912576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T14:23:48.91274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T14:23:48.912839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab received MsgPreVoteResp from 2460b0ba85bf91ab at term 1"} {"level":"info","ts":"2026-04-20T14:23:48.912998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became candidate at term 2"} {"level":"info","ts":"2026-04-20T14:23:48.913037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab received MsgVoteResp from 2460b0ba85bf91ab at term 2"} {"level":"info","ts":"2026-04-20T14:23:48.913118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2460b0ba85bf91ab became leader at term 2"} {"level":"info","ts":"2026-04-20T14:23:48.913311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2460b0ba85bf91ab elected leader 2460b0ba85bf91ab at term 2"} {"level":"info","ts":"2026-04-20T14:23:49.182989Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:23:49.184827Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2460b0ba85bf91ab","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.161:2379]}","request-path":"/0/members/2460b0ba85bf91ab/attributes","cluster-id":"c077309761674c46","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T14:23:49.185043Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:23:49.185116Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T14:23:49.185719Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T14:23:49.185839Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T14:23:49.185952Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c077309761674c46","local-member-id":"2460b0ba85bf91ab","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:23:49.186132Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:23:49.186808Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T14:23:49.188791Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T14:23:49.18947Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.161:2379"} {"level":"info","ts":"2026-04-20T14:23:52.925409Z","caller":"traceutil/trace.go:171","msg":"trace[1984897740] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"135.869224ms","start":"2026-04-20T14:23:52.789356Z","end":"2026-04-20T14:23:52.925225Z","steps":["trace[1984897740] 'process raft request' (duration: 135.657719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:23:53.32256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.4184ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:23:53.322788Z","caller":"traceutil/trace.go:171","msg":"trace[83587213] linearizableReadLoop","detail":"{readStateIndex:213; appliedIndex:212; }","duration":"334.211427ms","start":"2026-04-20T14:23:52.988557Z","end":"2026-04-20T14:23:53.322769Z","steps":["trace[83587213] 'read index received' (duration: 48.461µs)","trace[83587213] 'applied index is now lower than readState.Index' (duration: 334.161666ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:23:53.32294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.378931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:23:53.323065Z","caller":"traceutil/trace.go:171","msg":"trace[568843681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:208; }","duration":"334.530585ms","start":"2026-04-20T14:23:52.988517Z","end":"2026-04-20T14:23:53.323047Z","steps":["trace[568843681] 'agreement among raft nodes before linearized reading' (duration: 334.340401ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:23:53.322972Z","caller":"traceutil/trace.go:171","msg":"trace[1295056178] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"390.331146ms","start":"2026-04-20T14:23:52.932614Z","end":"2026-04-20T14:23:53.322945Z","steps":["trace[1295056178] 'process raft request' (duration: 51.944982ms)","trace[1295056178] 'compare' (duration: 337.302427ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:23:53.323166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:23:52.988501Z","time spent":"334.646688ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T14:23:53.323333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:23:52.932591Z","time spent":"390.683654ms","remote":"127.0.0.1:46670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:23:53.827983Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467533562,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T14:23:54.102714Z","caller":"traceutil/trace.go:171","msg":"trace[1545006609] linearizableReadLoop","detail":"{readStateIndex:214; appliedIndex:213; }","duration":"775.191693ms","start":"2026-04-20T14:23:53.327499Z","end":"2026-04-20T14:23:54.102691Z","steps":["trace[1545006609] 'read index received' (duration: 704.025505ms)","trace[1545006609] 'applied index is now lower than readState.Index' (duration: 71.155907ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:23:54.102874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.359727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-ha5jm7\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:23:54.102905Z","caller":"traceutil/trace.go:171","msg":"trace[1539125380] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-ha5jm7; range_end:; response_count:0; response_revision:209; }","duration":"775.430709ms","start":"2026-04-20T14:23:53.327465Z","end":"2026-04-20T14:23:54.102896Z","steps":["trace[1539125380] 'agreement among raft nodes before linearized reading' (duration: 775.342727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:23:54.102935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:23:53.32745Z","time spent":"775.47969ms","remote":"127.0.0.1:46594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-ha5jm7\" "} {"level":"info","ts":"2026-04-20T14:23:54.102867Z","caller":"traceutil/trace.go:171","msg":"trace[855705056] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"775.821319ms","start":"2026-04-20T14:23:53.32701Z","end":"2026-04-20T14:23:54.102831Z","steps":["trace[855705056] 'process raft request' (duration: 704.559009ms)","trace[855705056] 'compare' (duration: 70.979293ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:23:54.103043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.91905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:23:54.103288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:23:53.326983Z","time spent":"776.238081ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T14:23:54.10334Z","caller":"traceutil/trace.go:171","msg":"trace[1201122482] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:209; }","duration":"685.244389ms","start":"2026-04-20T14:23:53.418079Z","end":"2026-04-20T14:23:54.103323Z","steps":["trace[1201122482] 'agreement among raft nodes before linearized reading' (duration: 684.89113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:23:54.103388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:23:53.418064Z","time spent":"685.311772ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-20T14:23:54.27847Z","caller":"traceutil/trace.go:171","msg":"trace[534763518] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"171.831393ms","start":"2026-04-20T14:23:54.106605Z","end":"2026-04-20T14:23:54.278437Z","steps":["trace[534763518] 'process raft request' (duration: 168.658233ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:23:54.278499Z","caller":"traceutil/trace.go:171","msg":"trace[1301059886] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"170.765876ms","start":"2026-04-20T14:23:54.107704Z","end":"2026-04-20T14:23:54.27847Z","steps":["trace[1301059886] 'process raft request' (duration: 170.664723ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:23:54.278503Z","caller":"traceutil/trace.go:171","msg":"trace[1998552787] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"169.433042ms","start":"2026-04-20T14:23:54.109054Z","end":"2026-04-20T14:23:54.278487Z","steps":["trace[1998552787] 'process raft request' (duration: 169.34761ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:21.244377Z","caller":"traceutil/trace.go:171","msg":"trace[1317444799] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"136.249629ms","start":"2026-04-20T14:24:21.108095Z","end":"2026-04-20T14:24:21.244344Z","steps":["trace[1317444799] 'process raft request' (duration: 135.928781ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:21.288006Z","caller":"traceutil/trace.go:171","msg":"trace[1389645674] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"118.401654ms","start":"2026-04-20T14:24:21.169525Z","end":"2026-04-20T14:24:21.287927Z","steps":["trace[1389645674] 'process raft request' (duration: 118.153567ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:21.288096Z","caller":"traceutil/trace.go:171","msg":"trace[1994819971] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"110.68708ms","start":"2026-04-20T14:24:21.177398Z","end":"2026-04-20T14:24:21.288085Z","steps":["trace[1994819971] 'process raft request' (duration: 110.511876ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:21.288007Z","caller":"traceutil/trace.go:171","msg":"trace[669495826] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"118.064506ms","start":"2026-04-20T14:24:21.169897Z","end":"2026-04-20T14:24:21.287962Z","steps":["trace[669495826] 'process raft request' (duration: 117.908282ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:21.288262Z","caller":"traceutil/trace.go:171","msg":"trace[17862006] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"118.21336ms","start":"2026-04-20T14:24:21.170039Z","end":"2026-04-20T14:24:21.288252Z","steps":["trace[17862006] 'process raft request' (duration: 117.80366ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:21.288298Z","caller":"traceutil/trace.go:171","msg":"trace[2100862776] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"112.77636ms","start":"2026-04-20T14:24:21.175509Z","end":"2026-04-20T14:24:21.288285Z","steps":["trace[2100862776] 'process raft request' (duration: 112.36493ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:21.288334Z","caller":"traceutil/trace.go:171","msg":"trace[479457539] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"104.959314ms","start":"2026-04-20T14:24:21.183367Z","end":"2026-04-20T14:24:21.288326Z","steps":["trace[479457539] 'process raft request' (duration: 104.615806ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:21.288444Z","caller":"traceutil/trace.go:171","msg":"trace[802724843] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"107.616157ms","start":"2026-04-20T14:24:21.18081Z","end":"2026-04-20T14:24:21.288426Z","steps":["trace[802724843] 'process raft request' (duration: 107.138046ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:21.288628Z","caller":"traceutil/trace.go:171","msg":"trace[1869240702] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"105.080306ms","start":"2026-04-20T14:24:21.183536Z","end":"2026-04-20T14:24:21.288616Z","steps":["trace[1869240702] 'process raft request' (duration: 104.486713ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:24.979413Z","caller":"traceutil/trace.go:171","msg":"trace[508219924] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"157.260979ms","start":"2026-04-20T14:24:24.822131Z","end":"2026-04-20T14:24:24.979392Z","steps":["trace[508219924] 'process raft request' (duration: 155.399455ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:27.695391Z","caller":"traceutil/trace.go:171","msg":"trace[1113425542] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"101.731786ms","start":"2026-04-20T14:24:27.593632Z","end":"2026-04-20T14:24:27.695364Z","steps":["trace[1113425542] 'read index received' (duration: 2.041889ms)","trace[1113425542] 'applied index is now lower than readState.Index' (duration: 99.688507ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:24:27.695567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.89772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:27.695716Z","caller":"traceutil/trace.go:171","msg":"trace[459735747] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:583; }","duration":"102.047664ms","start":"2026-04-20T14:24:27.593595Z","end":"2026-04-20T14:24:27.695642Z","steps":["trace[459735747] 'agreement among raft nodes before linearized reading' (duration: 101.86975ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:28.486813Z","caller":"traceutil/trace.go:171","msg":"trace[1265628559] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"394.857604ms","start":"2026-04-20T14:24:28.091927Z","end":"2026-04-20T14:24:28.486784Z","steps":["trace[1265628559] 'process raft request' (duration: 394.059315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:28.486972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.091446Z","time spent":"395.443848ms","remote":"127.0.0.1:46594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:24:29.068874Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467534306,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:24:29.224634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.599539ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:24:29.224931Z","caller":"traceutil/trace.go:171","msg":"trace[1888718828] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"732.094415ms","start":"2026-04-20T14:24:28.492778Z","end":"2026-04-20T14:24:29.224872Z","steps":["trace[1888718828] 'compare' (duration: 722.401894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.225041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.492752Z","time spent":"732.239759ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:24:29.225682Z","caller":"traceutil/trace.go:171","msg":"trace[731596911] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:607; }","duration":"658.135612ms","start":"2026-04-20T14:24:28.567521Z","end":"2026-04-20T14:24:29.225656Z","steps":["trace[731596911] 'read index received' (duration: 623.65207ms)","trace[731596911] 'applied index is now lower than readState.Index' (duration: 34.482632ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:24:29.225878Z","caller":"traceutil/trace.go:171","msg":"trace[228188267] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"718.277285ms","start":"2026-04-20T14:24:28.507586Z","end":"2026-04-20T14:24:29.225864Z","steps":["trace[228188267] 'process raft request' (duration: 717.957687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.226037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.507567Z","time spent":"718.374647ms","remote":"127.0.0.1:46676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:24:29.226158Z","caller":"traceutil/trace.go:171","msg":"trace[1676493787] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"731.584723ms","start":"2026-04-20T14:24:28.49455Z","end":"2026-04-20T14:24:29.226135Z","steps":["trace[1676493787] 'process raft request' (duration: 730.911857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.226254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.494541Z","time spent":"731.669715ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:24:29.22638Z","caller":"traceutil/trace.go:171","msg":"trace[1542712195] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"733.513899ms","start":"2026-04-20T14:24:28.492856Z","end":"2026-04-20T14:24:29.22637Z","steps":["trace[1542712195] 'process raft request' (duration: 731.950463ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.226451Z","caller":"traceutil/trace.go:171","msg":"trace[1908768070] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"679.023659ms","start":"2026-04-20T14:24:28.547403Z","end":"2026-04-20T14:24:29.226427Z","steps":["trace[1908768070] 'process raft request' (duration: 678.193919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.226485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.492829Z","time spent":"733.624951ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:24:29.226591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.547379Z","time spent":"679.125532ms","remote":"127.0.0.1:46718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T14:24:29.226625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.960802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.226676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.234973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.226656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.120595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.226758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.750861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.226796Z","caller":"traceutil/trace.go:171","msg":"trace[1734470913] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:589; }","duration":"217.793672ms","start":"2026-04-20T14:24:29.00899Z","end":"2026-04-20T14:24:29.226784Z","steps":["trace[1734470913] 'agreement among raft nodes before linearized reading' (duration: 217.744571ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.22679Z","caller":"traceutil/trace.go:171","msg":"trace[1391477670] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:589; }","duration":"460.351756ms","start":"2026-04-20T14:24:28.766413Z","end":"2026-04-20T14:24:29.226765Z","steps":["trace[1391477670] 'agreement among raft nodes before linearized reading' (duration: 460.068139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.22687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.045158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.226909Z","caller":"traceutil/trace.go:171","msg":"trace[456002707] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:589; }","duration":"236.10632ms","start":"2026-04-20T14:24:28.990793Z","end":"2026-04-20T14:24:29.2269Z","steps":["trace[456002707] 'agreement among raft nodes before linearized reading' (duration: 236.039547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.226934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.766342Z","time spent":"460.536551ms","remote":"127.0.0.1:39416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:24:29.22696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.217849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.227043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.229193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.227057Z","caller":"traceutil/trace.go:171","msg":"trace[217170120] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:589; }","duration":"136.342521ms","start":"2026-04-20T14:24:29.090696Z","end":"2026-04-20T14:24:29.227038Z","steps":["trace[217170120] 'agreement among raft nodes before linearized reading' (duration: 136.172236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.227143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.871565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.22714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.003143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.227282Z","caller":"traceutil/trace.go:171","msg":"trace[513375044] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:589; }","duration":"157.164428ms","start":"2026-04-20T14:24:29.070108Z","end":"2026-04-20T14:24:29.227272Z","steps":["trace[513375044] 'agreement among raft nodes before linearized reading' (duration: 157.008824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.227308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.6953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.227325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.241782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.227359Z","caller":"traceutil/trace.go:171","msg":"trace[238029434] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:589; }","duration":"293.298124ms","start":"2026-04-20T14:24:28.934054Z","end":"2026-04-20T14:24:29.227352Z","steps":["trace[238029434] 'agreement among raft nodes before linearized reading' (duration: 293.249222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.227366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.28338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.227387Z","caller":"traceutil/trace.go:171","msg":"trace[2062757739] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:589; }","duration":"157.344311ms","start":"2026-04-20T14:24:29.070037Z","end":"2026-04-20T14:24:29.227381Z","steps":["trace[2062757739] 'agreement among raft nodes before linearized reading' (duration: 157.313941ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.227333Z","caller":"traceutil/trace.go:171","msg":"trace[1368799111] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:589; }","duration":"183.758662ms","start":"2026-04-20T14:24:29.043567Z","end":"2026-04-20T14:24:29.227326Z","steps":["trace[1368799111] 'agreement among raft nodes before linearized reading' (duration: 183.720791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.22748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.509152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.227169Z","caller":"traceutil/trace.go:171","msg":"trace[1791658774] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:589; }","duration":"235.912535ms","start":"2026-04-20T14:24:28.991251Z","end":"2026-04-20T14:24:29.227164Z","steps":["trace[1791658774] 'agreement among raft nodes before linearized reading' (duration: 235.875874ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.22764Z","caller":"traceutil/trace.go:171","msg":"trace[1521527770] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:589; }","duration":"333.750367ms","start":"2026-04-20T14:24:28.893869Z","end":"2026-04-20T14:24:29.227619Z","steps":["trace[1521527770] 'agreement among raft nodes before linearized reading' (duration: 333.502111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.227133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.348006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.227743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.893863Z","time spent":"333.859019ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-20T14:24:29.2278Z","caller":"traceutil/trace.go:171","msg":"trace[1686267739] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:589; }","duration":"237.050002ms","start":"2026-04-20T14:24:28.990742Z","end":"2026-04-20T14:24:29.227792Z","steps":["trace[1686267739] 'agreement among raft nodes before linearized reading' (duration: 236.320455ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.226713Z","caller":"traceutil/trace.go:171","msg":"trace[1171095930] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:589; }","duration":"183.123736ms","start":"2026-04-20T14:24:29.043569Z","end":"2026-04-20T14:24:29.226693Z","steps":["trace[1171095930] 'agreement among raft nodes before linearized reading' (duration: 182.938722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.227902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.641098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.228005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.591613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.228033Z","caller":"traceutil/trace.go:171","msg":"trace[169720532] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:589; }","duration":"429.656784ms","start":"2026-04-20T14:24:28.798368Z","end":"2026-04-20T14:24:29.228025Z","steps":["trace[169720532] 'agreement among raft nodes before linearized reading' (duration: 429.605123ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.227994Z","caller":"traceutil/trace.go:171","msg":"trace[849314156] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:589; }","duration":"136.73587ms","start":"2026-04-20T14:24:29.091242Z","end":"2026-04-20T14:24:29.227978Z","steps":["trace[849314156] 'agreement among raft nodes before linearized reading' (duration: 136.613977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.228059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.798348Z","time spent":"429.703805ms","remote":"127.0.0.1:39424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:24:29.228141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.415504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.226793Z","caller":"traceutil/trace.go:171","msg":"trace[1562775721] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"659.291019ms","start":"2026-04-20T14:24:28.56748Z","end":"2026-04-20T14:24:29.226771Z","steps":["trace[1562775721] 'agreement among raft nodes before linearized reading' (duration: 658.986352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.228181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.05714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.228202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.348971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.228205Z","caller":"traceutil/trace.go:171","msg":"trace[1308996075] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:589; }","duration":"429.08398ms","start":"2026-04-20T14:24:28.799114Z","end":"2026-04-20T14:24:29.228198Z","steps":["trace[1308996075] 'agreement among raft nodes before linearized reading' (duration: 429.042709ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.228227Z","caller":"traceutil/trace.go:171","msg":"trace[536065705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:589; }","duration":"334.417663ms","start":"2026-04-20T14:24:28.893803Z","end":"2026-04-20T14:24:29.228221Z","steps":["trace[536065705] 'agreement among raft nodes before linearized reading' (duration: 334.380472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.228231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.799082Z","time spent":"429.143432ms","remote":"127.0.0.1:39424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-20T14:24:29.22827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.893779Z","time spent":"334.463063ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:24:29.228289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.567464Z","time spent":"660.813785ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T14:24:29.228321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.770866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.228408Z","caller":"traceutil/trace.go:171","msg":"trace[161067708] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:589; }","duration":"429.870629ms","start":"2026-04-20T14:24:28.798523Z","end":"2026-04-20T14:24:29.228394Z","steps":["trace[161067708] 'agreement among raft nodes before linearized reading' (duration: 429.773067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.228429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.982155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.228439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.798517Z","time spent":"429.91472ms","remote":"127.0.0.1:39424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:24:29.228454Z","caller":"traceutil/trace.go:171","msg":"trace[189704783] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:589; }","duration":"462.043966ms","start":"2026-04-20T14:24:28.766401Z","end":"2026-04-20T14:24:29.228445Z","steps":["trace[189704783] 'agreement among raft nodes before linearized reading' (duration: 462.000165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.228443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.585207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.228483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.76638Z","time spent":"462.097428ms","remote":"127.0.0.1:39416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:24:29.227286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.16447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.228516Z","caller":"traceutil/trace.go:171","msg":"trace[2077056593] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:589; }","duration":"381.734951ms","start":"2026-04-20T14:24:28.846773Z","end":"2026-04-20T14:24:29.228508Z","steps":["trace[2077056593] 'agreement among raft nodes before linearized reading' (duration: 381.622598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.227114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.475599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.228546Z","caller":"traceutil/trace.go:171","msg":"trace[2033119932] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:589; }","duration":"219.919103ms","start":"2026-04-20T14:24:29.008618Z","end":"2026-04-20T14:24:29.228537Z","steps":["trace[2033119932] 'agreement among raft nodes before linearized reading' (duration: 218.470409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.228556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.846739Z","time spent":"381.792372ms","remote":"127.0.0.1:39432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T14:24:29.226706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.675681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.228583Z","caller":"traceutil/trace.go:171","msg":"trace[1533853630] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:589; }","duration":"334.574376ms","start":"2026-04-20T14:24:28.894002Z","end":"2026-04-20T14:24:29.228576Z","steps":["trace[1533853630] 'agreement among raft nodes before linearized reading' (duration: 332.65938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.227097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.804279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.228616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.893996Z","time spent":"334.608727ms","remote":"127.0.0.1:39432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"info","ts":"2026-04-20T14:24:29.227071Z","caller":"traceutil/trace.go:171","msg":"trace[209535060] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:589; }","duration":"218.270674ms","start":"2026-04-20T14:24:29.008794Z","end":"2026-04-20T14:24:29.227065Z","steps":["trace[209535060] 'agreement among raft nodes before linearized reading' (duration: 218.226703ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.228641Z","caller":"traceutil/trace.go:171","msg":"trace[1454222841] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:589; }","duration":"158.390846ms","start":"2026-04-20T14:24:29.070232Z","end":"2026-04-20T14:24:29.228623Z","steps":["trace[1454222841] 'agreement among raft nodes before linearized reading' (duration: 156.804279ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.22817Z","caller":"traceutil/trace.go:171","msg":"trace[2061949337] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:589; }","duration":"381.487666ms","start":"2026-04-20T14:24:28.846672Z","end":"2026-04-20T14:24:29.22816Z","steps":["trace[2061949337] 'agreement among raft nodes before linearized reading' (duration: 381.442934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.228184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.226727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.227245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.338291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:24:29.228738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.846652Z","time spent":"382.078399ms","remote":"127.0.0.1:39432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:24:29.228759Z","caller":"traceutil/trace.go:171","msg":"trace[423451790] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:589; }","duration":"293.880336ms","start":"2026-04-20T14:24:28.934871Z","end":"2026-04-20T14:24:29.228751Z","steps":["trace[423451790] 'agreement among raft nodes before linearized reading' (duration: 292.287639ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.228777Z","caller":"traceutil/trace.go:171","msg":"trace[727780795] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:589; }","duration":"294.415229ms","start":"2026-04-20T14:24:28.934112Z","end":"2026-04-20T14:24:29.228527Z","steps":["trace[727780795] 'agreement among raft nodes before linearized reading' (duration: 293.15395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.228362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.54869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:29.229283Z","caller":"traceutil/trace.go:171","msg":"trace[1339172875] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:589; }","duration":"138.514043ms","start":"2026-04-20T14:24:29.090761Z","end":"2026-04-20T14:24:29.229275Z","steps":["trace[1339172875] 'agreement among raft nodes before linearized reading' (duration: 137.519279ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:24:29.228823Z","caller":"traceutil/trace.go:171","msg":"trace[1675350641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:589; }","duration":"461.855142ms","start":"2026-04-20T14:24:28.766885Z","end":"2026-04-20T14:24:29.22874Z","steps":["trace[1675350641] 'agreement among raft nodes before linearized reading' (duration: 461.215757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:29.229394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:24:28.766877Z","time spent":"462.504187ms","remote":"127.0.0.1:39416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"info","ts":"2026-04-20T14:24:30.701901Z","caller":"traceutil/trace.go:171","msg":"trace[808747018] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"162.31776ms","start":"2026-04-20T14:24:30.539567Z","end":"2026-04-20T14:24:30.701885Z","steps":["trace[808747018] 'process raft request' (duration: 161.768027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:24:30.702164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.599953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:24:30.70178Z","caller":"traceutil/trace.go:171","msg":"trace[2088783969] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"135.196253ms","start":"2026-04-20T14:24:30.566555Z","end":"2026-04-20T14:24:30.701751Z","steps":["trace[2088783969] 'read index received' (duration: 134.63339ms)","trace[2088783969] 'applied index is now lower than readState.Index' (duration: 561.623µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:24:30.702229Z","caller":"traceutil/trace.go:171","msg":"trace[15017596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"135.717065ms","start":"2026-04-20T14:24:30.566498Z","end":"2026-04-20T14:24:30.702215Z","steps":["trace[15017596] 'agreement among raft nodes before linearized reading' (duration: 135.49754ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:25:18.878706Z","caller":"traceutil/trace.go:171","msg":"trace[1144160826] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"119.822237ms","start":"2026-04-20T14:25:18.758864Z","end":"2026-04-20T14:25:18.878686Z","steps":["trace[1144160826] 'process raft request' (duration: 119.694154ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:25:19.519525Z","caller":"traceutil/trace.go:171","msg":"trace[1980716676] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:998; }","duration":"278.989341ms","start":"2026-04-20T14:25:19.240513Z","end":"2026-04-20T14:25:19.519502Z","steps":["trace[1980716676] 'read index received' (duration: 278.876148ms)","trace[1980716676] 'applied index is now lower than readState.Index' (duration: 112.193µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:25:19.519555Z","caller":"traceutil/trace.go:171","msg":"trace[2142057301] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"598.388597ms","start":"2026-04-20T14:25:18.92114Z","end":"2026-04-20T14:25:19.519529Z","steps":["trace[2142057301] 'process raft request' (duration: 598.214662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:19.519676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:25:18.921115Z","time spent":"598.501119ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:25:19.519694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.294736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T14:25:19.519711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.168875ms","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-20T14:25:19.519783Z","caller":"traceutil/trace.go:171","msg":"trace[332115082] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:964; }","duration":"279.303718ms","start":"2026-04-20T14:25:19.240462Z","end":"2026-04-20T14:25:19.519765Z","steps":["trace[332115082] 'agreement among raft nodes before linearized reading' (duration: 279.164875ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:25:19.519728Z","caller":"traceutil/trace.go:171","msg":"trace[1183129133] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:964; }","duration":"109.411019ms","start":"2026-04-20T14:25:19.410308Z","end":"2026-04-20T14:25:19.519719Z","steps":["trace[1183129133] 'agreement among raft nodes before linearized reading' (duration: 109.330887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:43.994106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.120463ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:25:43.994266Z","caller":"traceutil/trace.go:171","msg":"trace[250889519] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"326.752316ms","start":"2026-04-20T14:25:43.667488Z","end":"2026-04-20T14:25:43.994241Z","steps":["trace[250889519] 'read index received' (duration: 203.341496ms)","trace[250889519] 'applied index is now lower than readState.Index' (duration: 123.409029ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:25:43.994511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.010351ms","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-20T14:25:43.994335Z","caller":"traceutil/trace.go:171","msg":"trace[778484985] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"348.19656ms","start":"2026-04-20T14:25:43.646107Z","end":"2026-04-20T14:25:43.994304Z","steps":["trace[778484985] 'process raft request' (duration: 224.797781ms)","trace[778484985] 'compare' (duration: 122.97939ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:25:43.994568Z","caller":"traceutil/trace.go:171","msg":"trace[890280662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1045; }","duration":"327.126764ms","start":"2026-04-20T14:25:43.667425Z","end":"2026-04-20T14:25:43.994551Z","steps":["trace[890280662] 'agreement among raft nodes before linearized reading' (duration: 326.950911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:43.994622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:25:43.667401Z","time spent":"327.208766ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T14:25:43.994935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.424292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T14:25:43.994985Z","caller":"traceutil/trace.go:171","msg":"trace[465219629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1045; }","duration":"274.517205ms","start":"2026-04-20T14:25:43.720456Z","end":"2026-04-20T14:25:43.994973Z","steps":["trace[465219629] 'agreement among raft nodes before linearized reading' (duration: 274.29795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:43.995243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:25:43.646087Z","time spent":"349.053138ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:25:43.995078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.852482ms","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-20T14:25:43.99569Z","caller":"traceutil/trace.go:171","msg":"trace[285317616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1045; }","duration":"302.516957ms","start":"2026-04-20T14:25:43.69316Z","end":"2026-04-20T14:25:43.995677Z","steps":["trace[285317616] 'agreement among raft nodes before linearized reading' (duration: 301.597857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:43.995842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:25:43.69314Z","time spent":"302.686551ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T14:25:44.202528Z","caller":"traceutil/trace.go:171","msg":"trace[1685061822] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"204.617074ms","start":"2026-04-20T14:25:43.997883Z","end":"2026-04-20T14:25:44.2025Z","steps":["trace[1685061822] 'process raft request' (duration: 181.967032ms)","trace[1685061822] 'compare' (duration: 22.474868ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:25:44.20302Z","caller":"traceutil/trace.go:171","msg":"trace[1607480949] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"204.167044ms","start":"2026-04-20T14:25:43.998822Z","end":"2026-04-20T14:25:44.202989Z","steps":["trace[1607480949] 'process raft request' (duration: 203.864797ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:25:44.203603Z","caller":"traceutil/trace.go:171","msg":"trace[1663637816] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"203.652913ms","start":"2026-04-20T14:25:43.999304Z","end":"2026-04-20T14:25:44.202957Z","steps":["trace[1663637816] 'process raft request' (duration: 203.583401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:46.321972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.938239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T14:25:46.322158Z","caller":"traceutil/trace.go:171","msg":"trace[1867655750] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1051; }","duration":"104.152254ms","start":"2026-04-20T14:25:46.217975Z","end":"2026-04-20T14:25:46.322128Z","steps":["trace[1867655750] 'count revisions from in-memory index tree' (duration: 103.892778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:46.322427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.600738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T14:25:46.322463Z","caller":"traceutil/trace.go:171","msg":"trace[616953699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1051; }","duration":"113.666299ms","start":"2026-04-20T14:25:46.208788Z","end":"2026-04-20T14:25:46.322454Z","steps":["trace[616953699] 'range keys from in-memory index tree' (duration: 113.494946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:46.322664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.311196ms","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-20T14:25:46.32274Z","caller":"traceutil/trace.go:171","msg":"trace[1308870510] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1051; }","duration":"115.462479ms","start":"2026-04-20T14:25:46.20726Z","end":"2026-04-20T14:25:46.322723Z","steps":["trace[1308870510] 'range keys from in-memory index tree' (duration: 115.099611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:46.322046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.718713ms","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-20T14:25:46.323056Z","caller":"traceutil/trace.go:171","msg":"trace[1590380783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1051; }","duration":"115.773246ms","start":"2026-04-20T14:25:46.20726Z","end":"2026-04-20T14:25:46.323034Z","steps":["trace[1590380783] 'range keys from in-memory index tree' (duration: 114.477467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:46.563781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.539582ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:25:46.564381Z","caller":"traceutil/trace.go:171","msg":"trace[1395001501] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"237.382564ms","start":"2026-04-20T14:25:46.326952Z","end":"2026-04-20T14:25:46.564334Z","steps":["trace[1395001501] 'process raft request' (duration: 237.20251ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:25:46.564589Z","caller":"traceutil/trace.go:171","msg":"trace[901132986] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"237.668591ms","start":"2026-04-20T14:25:46.326899Z","end":"2026-04-20T14:25:46.564568Z","steps":["trace[901132986] 'process raft request' (duration: 117.26565ms)","trace[901132986] 'compare' (duration: 119.293876ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:25:50.330101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.585878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:25:50.330195Z","caller":"traceutil/trace.go:171","msg":"trace[1082576593] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1063; }","duration":"456.729253ms","start":"2026-04-20T14:25:49.873445Z","end":"2026-04-20T14:25:50.330175Z","steps":["trace[1082576593] 'count revisions from in-memory index tree' (duration: 456.447936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:25:50.330254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:25:49.873424Z","time spent":"456.812406ms","remote":"127.0.0.1:46772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:25:50.330126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.663549ms","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-20T14:25:50.330624Z","caller":"traceutil/trace.go:171","msg":"trace[1949141813] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1063; }","duration":"233.186081ms","start":"2026-04-20T14:25:50.097416Z","end":"2026-04-20T14:25:50.330602Z","steps":["trace[1949141813] 'range keys from in-memory index tree' (duration: 232.431462ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:25:56.633137Z","caller":"traceutil/trace.go:171","msg":"trace[1534060627] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"180.885358ms","start":"2026-04-20T14:25:56.452235Z","end":"2026-04-20T14:25:56.63312Z","steps":["trace[1534060627] 'process raft request' (duration: 179.700321ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:00.802225Z","caller":"traceutil/trace.go:171","msg":"trace[1369500019] linearizableReadLoop","detail":"{readStateIndex:1194; appliedIndex:1193; }","duration":"233.866237ms","start":"2026-04-20T14:26:00.568344Z","end":"2026-04-20T14:26:00.80221Z","steps":["trace[1369500019] 'read index received' (duration: 233.741924ms)","trace[1369500019] 'applied index is now lower than readState.Index' (duration: 123.793µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:26:00.802297Z","caller":"traceutil/trace.go:171","msg":"trace[1395321768] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"320.008092ms","start":"2026-04-20T14:26:00.482275Z","end":"2026-04-20T14:26:00.802283Z","steps":["trace[1395321768] 'process raft request' (duration: 319.850659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:00.802338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.977699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:26:00.802357Z","caller":"traceutil/trace.go:171","msg":"trace[1590241675] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1149; }","duration":"234.03679ms","start":"2026-04-20T14:26:00.568314Z","end":"2026-04-20T14:26:00.802351Z","steps":["trace[1590241675] 'agreement among raft nodes before linearized reading' (duration: 233.973938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:00.802384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:00.482256Z","time spent":"320.073144ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:26:00.802486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.967244ms","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-20T14:26:00.802501Z","caller":"traceutil/trace.go:171","msg":"trace[1708681397] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1149; }","duration":"139.983614ms","start":"2026-04-20T14:26:00.662512Z","end":"2026-04-20T14:26:00.802496Z","steps":["trace[1708681397] 'agreement among raft nodes before linearized reading' (duration: 139.906832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:00.802474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.834602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:26:00.802557Z","caller":"traceutil/trace.go:171","msg":"trace[156572268] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1149; }","duration":"182.984285ms","start":"2026-04-20T14:26:00.619556Z","end":"2026-04-20T14:26:00.80254Z","steps":["trace[156572268] 'agreement among raft nodes before linearized reading' (duration: 182.838032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:00.802573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.329939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-20T14:26:00.80256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T14:26:00.802618Z","caller":"traceutil/trace.go:171","msg":"trace[495128787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1149; }","duration":"108.38458ms","start":"2026-04-20T14:26:00.694222Z","end":"2026-04-20T14:26:00.802607Z","steps":["trace[495128787] 'agreement among raft nodes before linearized reading' (duration: 108.246766ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:00.802649Z","caller":"traceutil/trace.go:171","msg":"trace[451063560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1149; }","duration":"109.406253ms","start":"2026-04-20T14:26:00.693225Z","end":"2026-04-20T14:26:00.802632Z","steps":["trace[451063560] 'agreement among raft nodes before linearized reading' (duration: 109.184628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:15.167699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.073239ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:26:15.167959Z","caller":"traceutil/trace.go:171","msg":"trace[232582860] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"260.885746ms","start":"2026-04-20T14:26:14.907017Z","end":"2026-04-20T14:26:15.167903Z","steps":["trace[232582860] 'process raft request' (duration: 119.449229ms)","trace[232582860] 'compare' (duration: 140.624659ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:26:20.891762Z","caller":"traceutil/trace.go:171","msg":"trace[316767743] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"170.689908ms","start":"2026-04-20T14:26:20.721053Z","end":"2026-04-20T14:26:20.891743Z","steps":["trace[316767743] 'process raft request' (duration: 170.579135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:21.315033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.596786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:26:21.315162Z","caller":"traceutil/trace.go:171","msg":"trace[1490167659] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"418.453687ms","start":"2026-04-20T14:26:20.896683Z","end":"2026-04-20T14:26:21.315137Z","steps":["trace[1490167659] 'process raft request' (duration: 220.685717ms)","trace[1490167659] 'compare' (duration: 197.252878ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:26:21.315225Z","caller":"traceutil/trace.go:171","msg":"trace[1616844308] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"346.389378ms","start":"2026-04-20T14:26:20.968817Z","end":"2026-04-20T14:26:21.315206Z","steps":["trace[1616844308] 'read index received' (duration: 148.559488ms)","trace[1616844308] 'applied index is now lower than readState.Index' (duration: 197.82769ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:26:21.315305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:20.896666Z","time spent":"418.585381ms","remote":"127.0.0.1:46590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":823,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T14:26:21.315429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.606503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-04-20T14:26:21.315449Z","caller":"traceutil/trace.go:171","msg":"trace[1077626822] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1220; }","duration":"346.666365ms","start":"2026-04-20T14:26:20.968777Z","end":"2026-04-20T14:26:21.315443Z","steps":["trace[1077626822] 'agreement among raft nodes before linearized reading' (duration: 346.529152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:21.315469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:20.968726Z","time spent":"346.739326ms","remote":"127.0.0.1:46670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5354,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-20T14:26:21.3156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.572625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T14:26:21.315634Z","caller":"traceutil/trace.go:171","msg":"trace[240141261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1221; }","duration":"289.642436ms","start":"2026-04-20T14:26:21.025979Z","end":"2026-04-20T14:26:21.315621Z","steps":["trace[240141261] 'agreement among raft nodes before linearized reading' (duration: 289.507543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:21.315677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.645894ms","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-20T14:26:21.315713Z","caller":"traceutil/trace.go:171","msg":"trace[987692752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1221; }","duration":"265.711465ms","start":"2026-04-20T14:26:21.049991Z","end":"2026-04-20T14:26:21.315703Z","steps":["trace[987692752] 'agreement among raft nodes before linearized reading' (duration: 265.586382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:21.315766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.278979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T14:26:21.315786Z","caller":"traceutil/trace.go:171","msg":"trace[575986137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1221; }","duration":"266.34068ms","start":"2026-04-20T14:26:21.04944Z","end":"2026-04-20T14:26:21.315781Z","steps":["trace[575986137] 'agreement among raft nodes before linearized reading' (duration: 266.277239ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:21.315808Z","caller":"traceutil/trace.go:171","msg":"trace[1101221914] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"300.510562ms","start":"2026-04-20T14:26:21.015281Z","end":"2026-04-20T14:26:21.315791Z","steps":["trace[1101221914] 'process raft request' (duration: 299.851317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:21.315857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.999075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T14:26:21.315871Z","caller":"traceutil/trace.go:171","msg":"trace[698420139] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1221; }","duration":"267.046515ms","start":"2026-04-20T14:26:21.04882Z","end":"2026-04-20T14:26:21.315867Z","steps":["trace[698420139] 'agreement among raft nodes before linearized reading' (duration: 267.008674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:21.315886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:21.015239Z","time spent":"300.605674ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:26:21.316055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.512904ms","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-20T14:26:21.316179Z","caller":"traceutil/trace.go:171","msg":"trace[1308003364] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1221; }","duration":"266.71037ms","start":"2026-04-20T14:26:21.049441Z","end":"2026-04-20T14:26:21.316151Z","steps":["trace[1308003364] 'agreement among raft nodes before linearized reading' (duration: 266.34468ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:21.466917Z","caller":"traceutil/trace.go:171","msg":"trace[384918025] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"146.176664ms","start":"2026-04-20T14:26:21.320717Z","end":"2026-04-20T14:26:21.466894Z","steps":["trace[384918025] 'process raft request' (duration: 106.705992ms)","trace[384918025] 'compare' (duration: 39.238287ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:26:21.466942Z","caller":"traceutil/trace.go:171","msg":"trace[1232396400] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"145.132809ms","start":"2026-04-20T14:26:21.321784Z","end":"2026-04-20T14:26:21.466917Z","steps":["trace[1232396400] 'process raft request' (duration: 145.037197ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:21.467126Z","caller":"traceutil/trace.go:171","msg":"trace[1811613736] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"144.25732ms","start":"2026-04-20T14:26:21.322864Z","end":"2026-04-20T14:26:21.467121Z","steps":["trace[1811613736] 'process raft request' (duration: 144.015074ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:21.467268Z","caller":"traceutil/trace.go:171","msg":"trace[1026880924] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"143.399961ms","start":"2026-04-20T14:26:21.323858Z","end":"2026-04-20T14:26:21.467258Z","steps":["trace[1026880924] 'process raft request' (duration: 143.35148ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:21.467419Z","caller":"traceutil/trace.go:171","msg":"trace[627041063] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"144.012615ms","start":"2026-04-20T14:26:21.323287Z","end":"2026-04-20T14:26:21.467299Z","steps":["trace[627041063] 'process raft request' (duration: 143.78209ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:35.820554Z","caller":"traceutil/trace.go:171","msg":"trace[1101333451] linearizableReadLoop","detail":"{readStateIndex:1380; appliedIndex:1379; }","duration":"278.121602ms","start":"2026-04-20T14:26:35.542414Z","end":"2026-04-20T14:26:35.820536Z","steps":["trace[1101333451] 'read index received' (duration: 278.01385ms)","trace[1101333451] 'applied index is now lower than readState.Index' (duration: 107.282µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:26:35.820618Z","caller":"traceutil/trace.go:171","msg":"trace[1942183685] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"278.713195ms","start":"2026-04-20T14:26:35.541887Z","end":"2026-04-20T14:26:35.8206Z","steps":["trace[1942183685] 'process raft request' (duration: 278.502621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:35.820707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.286995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T14:26:35.820733Z","caller":"traceutil/trace.go:171","msg":"trace[1343962154] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1328; }","duration":"278.355437ms","start":"2026-04-20T14:26:35.542371Z","end":"2026-04-20T14:26:35.820726Z","steps":["trace[1343962154] 'agreement among raft nodes before linearized reading' (duration: 278.246595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:35.841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.743091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-20T14:26:35.841007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.054765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:26:35.841057Z","caller":"traceutil/trace.go:171","msg":"trace[803087406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1329; }","duration":"296.838794ms","start":"2026-04-20T14:26:35.544206Z","end":"2026-04-20T14:26:35.841045Z","steps":["trace[803087406] 'agreement among raft nodes before linearized reading' (duration: 296.690371ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:35.841065Z","caller":"traceutil/trace.go:171","msg":"trace[546511590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1329; }","duration":"272.143556ms","start":"2026-04-20T14:26:35.568908Z","end":"2026-04-20T14:26:35.841052Z","steps":["trace[546511590] 'agreement among raft nodes before linearized reading' (duration: 272.055474ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:35.841066Z","caller":"traceutil/trace.go:171","msg":"trace[356796821] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"297.629942ms","start":"2026-04-20T14:26:35.543421Z","end":"2026-04-20T14:26:35.841051Z","steps":["trace[356796821] 'process raft request' (duration: 297.377277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:35.841001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.559681ms","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-20T14:26:35.841152Z","caller":"traceutil/trace.go:171","msg":"trace[1520754996] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1329; }","duration":"113.762294ms","start":"2026-04-20T14:26:35.727385Z","end":"2026-04-20T14:26:35.841148Z","steps":["trace[1520754996] 'agreement among raft nodes before linearized reading' (duration: 113.524339ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:36.326686Z","caller":"traceutil/trace.go:171","msg":"trace[142803868] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"481.778355ms","start":"2026-04-20T14:26:35.844881Z","end":"2026-04-20T14:26:36.32666Z","steps":["trace[142803868] 'process raft request' (duration: 481.736074ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:26:36.326969Z","caller":"traceutil/trace.go:171","msg":"trace[2013598192] linearizableReadLoop","detail":"{readStateIndex:1382; appliedIndex:1381; }","duration":"484.480636ms","start":"2026-04-20T14:26:35.842459Z","end":"2026-04-20T14:26:36.32694Z","steps":["trace[2013598192] 'read index received' (duration: 463.724308ms)","trace[2013598192] 'applied index is now lower than readState.Index' (duration: 20.754268ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:26:36.32706Z","caller":"traceutil/trace.go:171","msg":"trace[697297937] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"502.596333ms","start":"2026-04-20T14:26:35.824445Z","end":"2026-04-20T14:26:36.327042Z","steps":["trace[697297937] 'process raft request' (duration: 481.724032ms)","trace[697297937] 'compare' (duration: 19.855659ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:26:36.327118Z","caller":"traceutil/trace.go:171","msg":"trace[1425837019] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"482.236344ms","start":"2026-04-20T14:26:35.844859Z","end":"2026-04-20T14:26:36.327095Z","steps":["trace[1425837019] 'process raft request' (duration: 481.670732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:36.327157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.701651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:26:36.327165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:35.824426Z","time spent":"502.675645ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:26:36.32729Z","caller":"traceutil/trace.go:171","msg":"trace[2145307717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1332; }","duration":"484.860484ms","start":"2026-04-20T14:26:35.842392Z","end":"2026-04-20T14:26:36.327252Z","steps":["trace[2145307717] 'agreement among raft nodes before linearized reading' (duration: 484.727651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:26:36.327347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:35.842365Z","time spent":"484.972127ms","remote":"127.0.0.1:46524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T14:26:36.327445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:35.844864Z","time spent":"481.895747ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:26:36.327284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:26:35.844825Z","time spent":"482.350117ms","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T14:26:36.32824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.15176ms","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:533"} {"level":"info","ts":"2026-04-20T14:26:36.328295Z","caller":"traceutil/trace.go:171","msg":"trace[964171952] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1332; }","duration":"210.273342ms","start":"2026-04-20T14:26:36.118011Z","end":"2026-04-20T14:26:36.328284Z","steps":["trace[964171952] 'agreement among raft nodes before linearized reading' (duration: 209.331131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:27:02.182244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.540519ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:27:02.182376Z","caller":"traceutil/trace.go:171","msg":"trace[1280980642] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"183.696912ms","start":"2026-04-20T14:27:01.998658Z","end":"2026-04-20T14:27:02.182355Z","steps":["trace[1280980642] 'process raft request' (duration: 42.934588ms)","trace[1280980642] 'compare' (duration: 140.322564ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:02.497386Z","caller":"traceutil/trace.go:171","msg":"trace[745503539] transaction","detail":"{read_only:false; response_revision:1724; number_of_response:1; }","duration":"169.111367ms","start":"2026-04-20T14:28:02.328242Z","end":"2026-04-20T14:28:02.497354Z","steps":["trace[745503539] 'process raft request' (duration: 138.707217ms)","trace[745503539] 'compare' (duration: 30.188135ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:02.52188Z","caller":"traceutil/trace.go:171","msg":"trace[1718236769] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"142.312459ms","start":"2026-04-20T14:28:02.379533Z","end":"2026-04-20T14:28:02.521845Z","steps":["trace[1718236769] 'process raft request' (duration: 142.055073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:04.517547Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:05.017683Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:05.518504Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:06.019409Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:06.519967Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:06.568063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000574388s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-20T14:28:06.56821Z","caller":"traceutil/trace.go:171","msg":"trace[807347367] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000779972s","start":"2026-04-20T14:28:04.567393Z","end":"2026-04-20T14:28:06.568173Z","steps":["trace[807347367] 'agreement among raft nodes before linearized reading' (duration: 2.000568818s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:06.568289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:04.567371Z","time spent":"2.000903025s","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/20 14:28:06 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:07.020315Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:07.520759Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:08.021443Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:08.522687Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:08.568578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000105126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-20T14:28:08.568666Z","caller":"traceutil/trace.go:171","msg":"trace[204089550] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000210998s","start":"2026-04-20T14:28:06.568437Z","end":"2026-04-20T14:28:08.568648Z","steps":["trace[204089550] 'agreement among raft nodes before linearized reading' (duration: 2.000101326s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:08.568732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:06.568364Z","time spent":"2.000358791s","remote":"127.0.0.1:46524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/20 14:28:08 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:08.914073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.914335Z","time spent":"4.999712463s","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/04/20 14:28:08 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:09.016235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999715473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-20T14:28:09.01641Z","caller":"traceutil/trace.go:171","msg":"trace[804672166] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999933728s","start":"2026-04-20T14:28:04.016452Z","end":"2026-04-20T14:28:09.016386Z","steps":["trace[804672166] 'agreement among raft nodes before linearized reading' (duration: 4.999735214s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.016548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:04.016438Z","time spent":"5.00003655s","remote":"127.0.0.1:46740","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/20 14:28:09 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:09.023499Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10496656715467536928,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T14:28:09.143752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.445254126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T14:28:09.143864Z","caller":"traceutil/trace.go:171","msg":"trace[1778757339] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1726; }","duration":"6.445408339s","start":"2026-04-20T14:28:02.698407Z","end":"2026-04-20T14:28:09.143816Z","steps":["trace[1778757339] 'count revisions from in-memory index tree' (duration: 6.445085831s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.143912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:02.698389Z","time spent":"6.445511401s","remote":"127.0.0.1:47020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:09.144347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.751913989s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.144463Z","caller":"traceutil/trace.go:171","msg":"trace[1959434509] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1726; }","duration":"3.752026802s","start":"2026-04-20T14:28:05.392415Z","end":"2026-04-20T14:28:09.144442Z","steps":["trace[1959434509] 'range keys from in-memory index tree' (duration: 3.751900248s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.144714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.323317898s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.144841Z","caller":"traceutil/trace.go:171","msg":"trace[754397827] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1726; }","duration":"6.323709987s","start":"2026-04-20T14:28:02.821101Z","end":"2026-04-20T14:28:09.144811Z","steps":["trace[754397827] 'count revisions from in-memory index tree' (duration: 6.323168235s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.144913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:02.821075Z","time spent":"6.323812258s","remote":"127.0.0.1:46798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:09.146157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.31548581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T14:28:09.14626Z","caller":"traceutil/trace.go:171","msg":"trace[143470269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1726; }","duration":"6.315639943s","start":"2026-04-20T14:28:02.830593Z","end":"2026-04-20T14:28:09.146233Z","steps":["trace[143470269] 'range keys from in-memory index tree' (duration: 6.315241835s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.146321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:02.830563Z","time spent":"6.315741476s","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T14:28:09.146296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.804538406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.146402Z","caller":"traceutil/trace.go:171","msg":"trace[1745830394] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1726; }","duration":"5.80472933s","start":"2026-04-20T14:28:03.341652Z","end":"2026-04-20T14:28:09.146382Z","steps":["trace[1745830394] 'count revisions from in-memory index tree' (duration: 5.804415063s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.146448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.341623Z","time spent":"5.804813112s","remote":"127.0.0.1:46706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:09.146824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.292580271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"rangeKeys: context cancelled: context deadline exceeded"} {"level":"info","ts":"2026-04-20T14:28:09.146866Z","caller":"traceutil/trace.go:171","msg":"trace[205822857] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"6.292675703s","start":"2026-04-20T14:28:02.854181Z","end":"2026-04-20T14:28:09.146856Z","steps":["trace[205822857] 'range keys from in-memory index tree' (duration: 6.292407647s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.146899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:02.854149Z","time spent":"6.292743615s","remote":"127.0.0.1:46740","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/20 14:28:09 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T14:28:09.147067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.292490649s","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-20T14:28:09.14709Z","caller":"traceutil/trace.go:171","msg":"trace[2000345742] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1726; }","duration":"6.29253407s","start":"2026-04-20T14:28:02.854549Z","end":"2026-04-20T14:28:09.147084Z","steps":["trace[2000345742] 'range keys from in-memory index tree' (duration: 6.292362675s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.147109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:02.854541Z","time spent":"6.292564111s","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-20T14:28:09.147293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.277086809s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-20T14:28:09.147315Z","caller":"traceutil/trace.go:171","msg":"trace[571597632] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1726; }","duration":"6.27715826s","start":"2026-04-20T14:28:02.87015Z","end":"2026-04-20T14:28:09.147308Z","steps":["trace[571597632] 'range keys from in-memory index tree' (duration: 6.276966456s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.147333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:02.870123Z","time spent":"6.277205742s","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T14:28:09.147811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.557769996s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-20T14:28:09.147859Z","caller":"traceutil/trace.go:171","msg":"trace[1811532138] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1726; }","duration":"5.557866818s","start":"2026-04-20T14:28:03.589978Z","end":"2026-04-20T14:28:09.147845Z","steps":["trace[1811532138] 'range keys from in-memory index tree' (duration: 5.557560122s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.147943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:03.589941Z","time spent":"5.557989271s","remote":"127.0.0.1:46740","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-20T14:28:09.156001Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.24152754s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T14:28:09.164168Z","caller":"traceutil/trace.go:171","msg":"trace[1002456765] transaction","detail":"{read_only:false; response_revision:1728; number_of_response:1; }","duration":"4.151766021s","start":"2026-04-20T14:28:05.012366Z","end":"2026-04-20T14:28:09.164132Z","steps":["trace[1002456765] 'process raft request' (duration: 4.151537386s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.16435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:05.012328Z","time spent":"4.151935545s","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T14:28:09.171476Z","caller":"traceutil/trace.go:171","msg":"trace[309655092] linearizableReadLoop","detail":"{readStateIndex:1800; appliedIndex:1796; }","duration":"5.154972066s","start":"2026-04-20T14:28:04.016482Z","end":"2026-04-20T14:28:09.171454Z","steps":["trace[309655092] 'read index received' (duration: 5.139972466s)","trace[309655092] 'applied index is now lower than readState.Index' (duration: 14.99867ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:28:09.171927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:08.73545Z","time spent":"436.474285ms","remote":"127.0.0.1:46590","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-20T14:28:09.1721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.670905873s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T14:28:09.17219Z","caller":"traceutil/trace.go:171","msg":"trace[630927265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1732; }","duration":"4.671040945s","start":"2026-04-20T14:28:04.501128Z","end":"2026-04-20T14:28:09.172169Z","steps":["trace[630927265] 'agreement among raft nodes before linearized reading' (duration: 4.67082304s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.172219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.395255433s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T14:28:09.17224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:04.501107Z","time spent":"4.671122907s","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-20T14:28:09.172255Z","caller":"traceutil/trace.go:171","msg":"trace[119023883] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1732; }","duration":"2.395372106s","start":"2026-04-20T14:28:06.776874Z","end":"2026-04-20T14:28:09.172246Z","steps":["trace[119023883] 'agreement among raft nodes before linearized reading' (duration: 2.395302864s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.1723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:06.776839Z","time spent":"2.395448147s","remote":"127.0.0.1:39416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:09.172462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.587084416s","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":"info","ts":"2026-04-20T14:28:09.172509Z","caller":"traceutil/trace.go:171","msg":"trace[1596191539] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1732; }","duration":"2.587155268s","start":"2026-04-20T14:28:06.585338Z","end":"2026-04-20T14:28:09.172494Z","steps":["trace[1596191539] 'agreement among raft nodes before linearized reading' (duration: 2.587050186s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.172522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.559105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:550"} {"level":"warn","ts":"2026-04-20T14:28:09.172546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:06.585323Z","time spent":"2.587214649s","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-20T14:28:09.172579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.344194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.172604Z","caller":"traceutil/trace.go:171","msg":"trace[1655324343] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1732; }","duration":"355.415776ms","start":"2026-04-20T14:28:08.817183Z","end":"2026-04-20T14:28:09.172599Z","steps":["trace[1655324343] 'agreement among raft nodes before linearized reading' (duration: 355.381025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.172628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:08.817159Z","time spent":"355.463406ms","remote":"127.0.0.1:39592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:09.17265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.765484814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.172685Z","caller":"traceutil/trace.go:171","msg":"trace[1507818528] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1732; }","duration":"2.765560755s","start":"2026-04-20T14:28:06.407114Z","end":"2026-04-20T14:28:09.172675Z","steps":["trace[1507818528] 'agreement among raft nodes before linearized reading' (duration: 2.765504354s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.172719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:06.40709Z","time spent":"2.765621507s","remote":"127.0.0.1:39462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:09.172758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.686572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.172791Z","caller":"traceutil/trace.go:171","msg":"trace[230692273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1732; }","duration":"437.761304ms","start":"2026-04-20T14:28:08.735022Z","end":"2026-04-20T14:28:09.172783Z","steps":["trace[230692273] 'agreement among raft nodes before linearized reading' (duration: 437.710453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.172813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:08.734996Z","time spent":"437.812754ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T14:28:09.172868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.264462686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.172905Z","caller":"traceutil/trace.go:171","msg":"trace[310401990] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1732; }","duration":"3.264537718s","start":"2026-04-20T14:28:05.908358Z","end":"2026-04-20T14:28:09.172896Z","steps":["trace[310401990] 'agreement among raft nodes before linearized reading' (duration: 3.264482117s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.172938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:05.90834Z","time spent":"3.264590379s","remote":"127.0.0.1:46958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:09.172974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.492408946s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:09.172999Z","caller":"traceutil/trace.go:171","msg":"trace[1231791501] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1732; }","duration":"1.492459546s","start":"2026-04-20T14:28:07.680532Z","end":"2026-04-20T14:28:09.172991Z","steps":["trace[1231791501] 'agreement among raft nodes before linearized reading' (duration: 1.492425766s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.173026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:07.680518Z","time spent":"1.492498888s","remote":"127.0.0.1:39452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:28:09.172549Z","caller":"traceutil/trace.go:171","msg":"trace[1545162666] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:1732; }","duration":"257.623226ms","start":"2026-04-20T14:28:08.914919Z","end":"2026-04-20T14:28:09.172542Z","steps":["trace[1545162666] 'agreement among raft nodes before linearized reading' (duration: 257.515954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.172942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.72256ms","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":"info","ts":"2026-04-20T14:28:09.17312Z","caller":"traceutil/trace.go:171","msg":"trace[2002252189] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1732; }","duration":"919.899624ms","start":"2026-04-20T14:28:08.253212Z","end":"2026-04-20T14:28:09.173112Z","steps":["trace[2002252189] 'agreement among raft nodes before linearized reading' (duration: 919.70781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.173114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.017366142s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T14:28:09.173149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:08.253148Z","time spent":"919.993097ms","remote":"127.0.0.1:51010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-20T14:28:09.173164Z","caller":"traceutil/trace.go:171","msg":"trace[1967059747] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1732; }","duration":"4.017468234s","start":"2026-04-20T14:28:05.155684Z","end":"2026-04-20T14:28:09.173152Z","steps":["trace[1967059747] 'agreement among raft nodes before linearized reading' (duration: 4.017379762s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.173209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:05.155665Z","time spent":"4.017534925s","remote":"127.0.0.1:34474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-20T14:28:09.1734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.610699665s","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-20T14:28:09.173427Z","caller":"traceutil/trace.go:171","msg":"trace[886409143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1732; }","duration":"4.610762297s","start":"2026-04-20T14:28:04.562658Z","end":"2026-04-20T14:28:09.173421Z","steps":["trace[886409143] 'agreement among raft nodes before linearized reading' (duration: 4.610690295s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.173445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:04.562639Z","time spent":"4.610800928s","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T14:28:09.173514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.16273454s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-20T14:28:09.173546Z","caller":"traceutil/trace.go:171","msg":"trace[1466722858] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1732; }","duration":"4.162793242s","start":"2026-04-20T14:28:05.010745Z","end":"2026-04-20T14:28:09.173538Z","steps":["trace[1466722858] 'agreement among raft nodes before linearized reading' (duration: 4.16271662s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:09.173569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:28:05.010729Z","time spent":"4.162835802s","remote":"127.0.0.1:46740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-20T14:28:35.548763Z","caller":"traceutil/trace.go:171","msg":"trace[2035842093] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"219.631053ms","start":"2026-04-20T14:28:35.329109Z","end":"2026-04-20T14:28:35.54874Z","steps":["trace[2035842093] 'read index received' (duration: 219.49826ms)","trace[2035842093] 'applied index is now lower than readState.Index' (duration: 131.723µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:28:35.549274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.158746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T14:28:35.549325Z","caller":"traceutil/trace.go:171","msg":"trace[95582399] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1852; }","duration":"220.265608ms","start":"2026-04-20T14:28:35.329048Z","end":"2026-04-20T14:28:35.549314Z","steps":["trace[95582399] 'agreement among raft nodes before linearized reading' (duration: 220.108474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:35.549367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.569846ms","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-20T14:28:35.549431Z","caller":"traceutil/trace.go:171","msg":"trace[577367088] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1852; }","duration":"217.639238ms","start":"2026-04-20T14:28:35.33177Z","end":"2026-04-20T14:28:35.54941Z","steps":["trace[577367088] 'agreement among raft nodes before linearized reading' (duration: 217.533546ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:35.549501Z","caller":"traceutil/trace.go:171","msg":"trace[1179078536] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"250.659329ms","start":"2026-04-20T14:28:35.29883Z","end":"2026-04-20T14:28:35.54949Z","steps":["trace[1179078536] 'process raft request' (duration: 249.786998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:35.549248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.222015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T14:28:35.549601Z","caller":"traceutil/trace.go:171","msg":"trace[877463820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1852; }","duration":"219.641085ms","start":"2026-04-20T14:28:35.32995Z","end":"2026-04-20T14:28:35.549592Z","steps":["trace[877463820] 'agreement among raft nodes before linearized reading' (duration: 219.087412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:35.549748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.995566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-20T14:28:35.54978Z","caller":"traceutil/trace.go:171","msg":"trace[1673627496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1852; }","duration":"218.051128ms","start":"2026-04-20T14:28:35.331721Z","end":"2026-04-20T14:28:35.549772Z","steps":["trace[1673627496] 'agreement among raft nodes before linearized reading' (duration: 217.951426ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:35.688615Z","caller":"traceutil/trace.go:171","msg":"trace[1060146891] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"133.469628ms","start":"2026-04-20T14:28:35.55512Z","end":"2026-04-20T14:28:35.688589Z","steps":["trace[1060146891] 'process raft request' (duration: 133.265563ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:35.688626Z","caller":"traceutil/trace.go:171","msg":"trace[1095843367] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"133.739665ms","start":"2026-04-20T14:28:35.554825Z","end":"2026-04-20T14:28:35.688565Z","steps":["trace[1095843367] 'process raft request' (duration: 39.498387ms)","trace[1095843367] 'compare' (duration: 93.708796ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:35.688713Z","caller":"traceutil/trace.go:171","msg":"trace[1792673026] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"133.437757ms","start":"2026-04-20T14:28:35.555256Z","end":"2026-04-20T14:28:35.688693Z","steps":["trace[1792673026] 'process raft request' (duration: 133.280543ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:35.688877Z","caller":"traceutil/trace.go:171","msg":"trace[1030845805] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1929; }","duration":"123.229166ms","start":"2026-04-20T14:28:35.565637Z","end":"2026-04-20T14:28:35.688866Z","steps":["trace[1030845805] 'read index received' (duration: 28.774323ms)","trace[1030845805] 'applied index is now lower than readState.Index' (duration: 94.453803ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:35.688918Z","caller":"traceutil/trace.go:171","msg":"trace[1126118821] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"133.437898ms","start":"2026-04-20T14:28:35.55547Z","end":"2026-04-20T14:28:35.688908Z","steps":["trace[1126118821] 'process raft request' (duration: 133.173952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:35.688967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.320068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T14:28:35.689004Z","caller":"traceutil/trace.go:171","msg":"trace[2106890716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1856; }","duration":"123.402841ms","start":"2026-04-20T14:28:35.565592Z","end":"2026-04-20T14:28:35.688995Z","steps":["trace[2106890716] 'agreement among raft nodes before linearized reading' (duration: 123.320209ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:37.260418Z","caller":"traceutil/trace.go:171","msg":"trace[1314549146] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"104.868575ms","start":"2026-04-20T14:28:37.155532Z","end":"2026-04-20T14:28:37.260401Z","steps":["trace[1314549146] 'process raft request' (duration: 104.755212ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:38.149257Z","caller":"traceutil/trace.go:171","msg":"trace[1848397644] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"105.586812ms","start":"2026-04-20T14:28:38.043646Z","end":"2026-04-20T14:28:38.149232Z","steps":["trace[1848397644] 'process raft request' (duration: 105.449398ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:40.201013Z","caller":"traceutil/trace.go:171","msg":"trace[714841781] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"208.261757ms","start":"2026-04-20T14:28:39.992719Z","end":"2026-04-20T14:28:40.200981Z","steps":["trace[714841781] 'process raft request' (duration: 207.834558ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:44.009487Z","caller":"traceutil/trace.go:171","msg":"trace[1493855396] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"103.925944ms","start":"2026-04-20T14:28:43.905523Z","end":"2026-04-20T14:28:44.009449Z","steps":["trace[1493855396] 'process raft request' (duration: 103.869153ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:44.009779Z","caller":"traceutil/trace.go:171","msg":"trace[1820616543] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"113.34474ms","start":"2026-04-20T14:28:43.896382Z","end":"2026-04-20T14:28:44.009726Z","steps":["trace[1820616543] 'process raft request' (duration: 39.68688ms)","trace[1820616543] 'compare' (duration: 73.086056ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:44.010001Z","caller":"traceutil/trace.go:171","msg":"trace[1252833843] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"105.592772ms","start":"2026-04-20T14:28:43.904335Z","end":"2026-04-20T14:28:44.009928Z","steps":["trace[1252833843] 'process raft request' (duration: 105.008348ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:44.381892Z","caller":"traceutil/trace.go:171","msg":"trace[431260251] linearizableReadLoop","detail":"{readStateIndex:1971; appliedIndex:1970; }","duration":"118.437236ms","start":"2026-04-20T14:28:44.263427Z","end":"2026-04-20T14:28:44.381864Z","steps":["trace[431260251] 'read index received' (duration: 118.128239ms)","trace[431260251] 'applied index is now lower than readState.Index' (duration: 307.927µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:44.381979Z","caller":"traceutil/trace.go:171","msg":"trace[3174035] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"125.679552ms","start":"2026-04-20T14:28:44.256251Z","end":"2026-04-20T14:28:44.381931Z","steps":["trace[3174035] 'process raft request' (duration: 125.447456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:44.38212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.678812ms","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-20T14:28:44.382191Z","caller":"traceutil/trace.go:171","msg":"trace[1761751087] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1892; }","duration":"118.793986ms","start":"2026-04-20T14:28:44.263379Z","end":"2026-04-20T14:28:44.382173Z","steps":["trace[1761751087] 'agreement among raft nodes before linearized reading' (duration: 118.610521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:44.382258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.922161ms","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:533"} {"level":"info","ts":"2026-04-20T14:28:44.382336Z","caller":"traceutil/trace.go:171","msg":"trace[1097678854] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1892; }","duration":"103.054444ms","start":"2026-04-20T14:28:44.279263Z","end":"2026-04-20T14:28:44.382318Z","steps":["trace[1097678854] 'agreement among raft nodes before linearized reading' (duration: 102.761617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:28:44.551518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.781325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T14:28:44.551765Z","caller":"traceutil/trace.go:171","msg":"trace[2131151807] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"163.600412ms","start":"2026-04-20T14:28:44.388127Z","end":"2026-04-20T14:28:44.551727Z","steps":["trace[2131151807] 'process raft request' (duration: 10.52229ms)","trace[2131151807] 'compare' (duration: 152.634542ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T14:28:44.552185Z","caller":"traceutil/trace.go:171","msg":"trace[1176647367] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"160.381149ms","start":"2026-04-20T14:28:44.391782Z","end":"2026-04-20T14:28:44.552163Z","steps":["trace[1176647367] 'process raft request' (duration: 160.321158ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:44.552258Z","caller":"traceutil/trace.go:171","msg":"trace[367939829] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"164.072453ms","start":"2026-04-20T14:28:44.388171Z","end":"2026-04-20T14:28:44.552243Z","steps":["trace[367939829] 'process raft request' (duration: 163.460809ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:28:44.552403Z","caller":"traceutil/trace.go:171","msg":"trace[2059598122] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"164.089494ms","start":"2026-04-20T14:28:44.388241Z","end":"2026-04-20T14:28:44.552331Z","steps":["trace[2059598122] 'process raft request' (duration: 163.761526ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:29:30.79967Z","caller":"traceutil/trace.go:171","msg":"trace[998073206] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"171.262329ms","start":"2026-04-20T14:29:30.628379Z","end":"2026-04-20T14:29:30.799642Z","steps":["trace[998073206] 'process raft request' (duration: 171.104495ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:30:04.682992Z","caller":"traceutil/trace.go:171","msg":"trace[1570355888] transaction","detail":"{read_only:false; response_revision:2288; number_of_response:1; }","duration":"174.856892ms","start":"2026-04-20T14:30:04.508106Z","end":"2026-04-20T14:30:04.682963Z","steps":["trace[1570355888] 'process raft request' (duration: 174.631757ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:30:04.712971Z","caller":"traceutil/trace.go:171","msg":"trace[521501843] linearizableReadLoop","detail":"{readStateIndex:2385; appliedIndex:2384; }","duration":"170.080634ms","start":"2026-04-20T14:30:04.542861Z","end":"2026-04-20T14:30:04.712941Z","steps":["trace[521501843] 'read index received' (duration: 141.36182ms)","trace[521501843] 'applied index is now lower than readState.Index' (duration: 28.717674ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T14:30:04.713333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.468063ms","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-20T14:30:04.713371Z","caller":"traceutil/trace.go:171","msg":"trace[536495421] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2289; }","duration":"170.572756ms","start":"2026-04-20T14:30:04.54279Z","end":"2026-04-20T14:30:04.713363Z","steps":["trace[536495421] 'agreement among raft nodes before linearized reading' (duration: 170.454923ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:30:04.713519Z","caller":"traceutil/trace.go:171","msg":"trace[992391756] transaction","detail":"{read_only:false; response_revision:2289; number_of_response:1; }","duration":"205.04939ms","start":"2026-04-20T14:30:04.508333Z","end":"2026-04-20T14:30:04.713383Z","steps":["trace[992391756] 'process raft request' (duration: 204.475047ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T14:30:34.269034Z","caller":"traceutil/trace.go:171","msg":"trace[1922348622] transaction","detail":"{read_only:false; response_revision:2429; number_of_response:1; }","duration":"351.347764ms","start":"2026-04-20T14:30:33.917661Z","end":"2026-04-20T14:30:34.269009Z","steps":["trace[1922348622] 'process raft request' (duration: 351.145259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T14:30:34.269159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T14:30:33.917636Z","time spent":"351.466876ms","remote":"127.0.0.1:46670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6937,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}