{"level":"warn","ts":"2026-04-16T16:30:52.753949Z","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-16T16:30:52.754096Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.185: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.185:2380","--initial-cluster=instance=https://199.19.213.185:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.185:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.185: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-16T16:30:52.754248Z","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-16T16:30:52.754273Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.185:2380"]} {"level":"info","ts":"2026-04-16T16:30:52.754315Z","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-16T16:30:52.755446Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.185:2379"]} {"level":"info","ts":"2026-04-16T16:30:52.755596Z","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.185:2380"],"listen-peer-urls":["https://199.19.213.185:2380"],"advertise-client-urls":["https://199.19.213.185:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.185:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.185: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-16T16:30:52.76098Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.021387ms"} {"level":"info","ts":"2026-04-16T16:30:52.767946Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dcbda34f8b503a3","cluster-id":"2e806bc52dde46af"} {"level":"info","ts":"2026-04-16T16:30:52.768081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T16:30:52.768131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became follower at term 0"} {"level":"info","ts":"2026-04-16T16:30:52.768152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dcbda34f8b503a3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T16:30:52.768166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became follower at term 1"} {"level":"info","ts":"2026-04-16T16:30:52.768221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 switched to configuration voters=(994128063811093411)"} {"level":"warn","ts":"2026-04-16T16:30:52.787882Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T16:30:52.790831Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T16:30:52.792153Z","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-16T16:30:52.797132Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dcbda34f8b503a3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T16:30:52.797394Z","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-16T16:30:52.797486Z","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-16T16:30:52.797497Z","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-16T16:30:52.797831Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dcbda34f8b503a3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T16:30:52.798851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 switched to configuration voters=(994128063811093411)"} {"level":"info","ts":"2026-04-16T16:30:52.798967Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2e806bc52dde46af","local-member-id":"dcbda34f8b503a3","added-peer-id":"dcbda34f8b503a3","added-peer-peer-urls":["https://199.19.213.185:2380"]} {"level":"info","ts":"2026-04-16T16:30:52.814227Z","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-16T16:30:52.814333Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.185:2380"} {"level":"info","ts":"2026-04-16T16:30:52.81442Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.185:2380"} {"level":"info","ts":"2026-04-16T16:30:52.815555Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dcbda34f8b503a3","initial-advertise-peer-urls":["https://199.19.213.185:2380"],"listen-peer-urls":["https://199.19.213.185:2380"],"advertise-client-urls":["https://199.19.213.185:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.185:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T16:30:52.815591Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T16:30:52.868877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T16:30:52.868953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T16:30:52.868976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 received MsgPreVoteResp from dcbda34f8b503a3 at term 1"} {"level":"info","ts":"2026-04-16T16:30:52.86899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became candidate at term 2"} {"level":"info","ts":"2026-04-16T16:30:52.868998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 received MsgVoteResp from dcbda34f8b503a3 at term 2"} {"level":"info","ts":"2026-04-16T16:30:52.86901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcbda34f8b503a3 became leader at term 2"} {"level":"info","ts":"2026-04-16T16:30:52.869021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dcbda34f8b503a3 elected leader dcbda34f8b503a3 at term 2"} {"level":"info","ts":"2026-04-16T16:30:52.869869Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dcbda34f8b503a3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.185:2379]}","request-path":"/0/members/dcbda34f8b503a3/attributes","cluster-id":"2e806bc52dde46af","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T16:30:52.871761Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T16:30:52.872089Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T16:30:52.872692Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2e806bc52dde46af","local-member-id":"dcbda34f8b503a3","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T16:30:52.872808Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T16:30:52.872902Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T16:30:52.872944Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T16:30:52.874932Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T16:30:52.875292Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.185:2379"} {"level":"info","ts":"2026-04-16T16:30:52.876344Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T16:30:52.876432Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T16:31:11.406588Z","caller":"traceutil/trace.go:171","msg":"trace[364939947] linearizableReadLoop","detail":"{readStateIndex:411; appliedIndex:409; }","duration":"147.945113ms","start":"2026-04-16T16:31:11.258618Z","end":"2026-04-16T16:31:11.406563Z","steps":["trace[364939947] 'read index received' (duration: 5.802055ms)","trace[364939947] 'applied index is now lower than readState.Index' (duration: 142.141698ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:31:11.406738Z","caller":"traceutil/trace.go:171","msg":"trace[29613747] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"147.526413ms","start":"2026-04-16T16:31:11.2592Z","end":"2026-04-16T16:31:11.406726Z","steps":["trace[29613747] 'process raft request' (duration: 147.284368ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:11.40674Z","caller":"traceutil/trace.go:171","msg":"trace[1314534390] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"148.805613ms","start":"2026-04-16T16:31:11.2579Z","end":"2026-04-16T16:31:11.406705Z","steps":["trace[1314534390] 'process raft request' (duration: 110.166724ms)","trace[1314534390] 'compare' (duration: 38.25231ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:31:11.40694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.304741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"info","ts":"2026-04-16T16:31:11.407015Z","caller":"traceutil/trace.go:171","msg":"trace[830818954] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:400; }","duration":"148.417764ms","start":"2026-04-16T16:31:11.258586Z","end":"2026-04-16T16:31:11.407004Z","steps":["trace[830818954] 'agreement among raft nodes before linearized reading' (duration: 148.290061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:11.407047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.82782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-16T16:31:11.407095Z","caller":"traceutil/trace.go:171","msg":"trace[1325204337] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:400; }","duration":"141.912672ms","start":"2026-04-16T16:31:11.265168Z","end":"2026-04-16T16:31:11.407081Z","steps":["trace[1325204337] 'agreement among raft nodes before linearized reading' (duration: 141.772588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:11.407352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.098468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:31:11.407441Z","caller":"traceutil/trace.go:171","msg":"trace[149997078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:400; }","duration":"109.198401ms","start":"2026-04-16T16:31:11.298222Z","end":"2026-04-16T16:31:11.40742Z","steps":["trace[149997078] 'agreement among raft nodes before linearized reading' (duration: 109.056667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:18.148633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.433318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T16:31:18.148772Z","caller":"traceutil/trace.go:171","msg":"trace[1907056058] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:438; }","duration":"607.885846ms","start":"2026-04-16T16:31:17.540864Z","end":"2026-04-16T16:31:18.14875Z","steps":["trace[1907056058] 'read index received' (duration: 353.336383ms)","trace[1907056058] 'applied index is now lower than readState.Index' (duration: 254.547423ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:31:18.148829Z","caller":"traceutil/trace.go:171","msg":"trace[1279481703] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"612.971694ms","start":"2026-04-16T16:31:17.535814Z","end":"2026-04-16T16:31:18.148786Z","steps":["trace[1279481703] 'process raft request' (duration: 358.493172ms)","trace[1279481703] 'compare' (duration: 253.308785ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:31:18.149041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:17.535796Z","time spent":"613.141898ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:31:18.148866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.005529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:18.149173Z","caller":"traceutil/trace.go:171","msg":"trace[1050244199] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:425; }","duration":"608.331406ms","start":"2026-04-16T16:31:17.540816Z","end":"2026-04-16T16:31:18.149147Z","steps":["trace[1050244199] 'agreement among raft nodes before linearized reading' (duration: 607.999969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:18.149245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:17.540802Z","time spent":"608.424488ms","remote":"127.0.0.1:33492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T16:31:24.706746Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":262226475746419741,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T16:31:25.005481Z","caller":"traceutil/trace.go:171","msg":"trace[699647930] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"981.789726ms","start":"2026-04-16T16:31:24.02366Z","end":"2026-04-16T16:31:25.00545Z","steps":["trace[699647930] 'process raft request' (duration: 981.620132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.005636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.023639Z","time spent":"981.910929ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T16:31:25.019217Z","caller":"traceutil/trace.go:171","msg":"trace[1899723865] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"981.176212ms","start":"2026-04-16T16:31:24.03802Z","end":"2026-04-16T16:31:25.019196Z","steps":["trace[1899723865] 'process raft request' (duration: 981.026288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.019518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.038005Z","time spent":"981.441797ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T16:31:25.019321Z","caller":"traceutil/trace.go:171","msg":"trace[2122203183] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"981.10723ms","start":"2026-04-16T16:31:24.038137Z","end":"2026-04-16T16:31:25.019244Z","steps":["trace[2122203183] 'process raft request' (duration: 980.992897ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:25.019499Z","caller":"traceutil/trace.go:171","msg":"trace[1846133375] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"977.081107ms","start":"2026-04-16T16:31:24.042328Z","end":"2026-04-16T16:31:25.019409Z","steps":["trace[1846133375] 'process raft request' (duration: 976.835481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.019715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.038065Z","time spent":"981.564331ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T16:31:25.019881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.042302Z","time spent":"977.450576ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T16:31:25.019992Z","caller":"traceutil/trace.go:171","msg":"trace[1612317573] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"977.526407ms","start":"2026-04-16T16:31:24.042457Z","end":"2026-04-16T16:31:25.019983Z","steps":["trace[1612317573] 'process raft request' (duration: 977.397234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.020065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.042451Z","time spent":"977.598288ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T16:31:25.020217Z","caller":"traceutil/trace.go:171","msg":"trace[1018637275] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"977.691491ms","start":"2026-04-16T16:31:24.042512Z","end":"2026-04-16T16:31:25.020204Z","steps":["trace[1018637275] 'process raft request' (duration: 977.474536ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:25.020256Z","caller":"traceutil/trace.go:171","msg":"trace[1415307575] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"974.507157ms","start":"2026-04-16T16:31:24.045719Z","end":"2026-04-16T16:31:25.020227Z","steps":["trace[1415307575] 'process raft request' (duration: 974.440385ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:25.020347Z","caller":"traceutil/trace.go:171","msg":"trace[1799086463] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"974.564388ms","start":"2026-04-16T16:31:24.045736Z","end":"2026-04-16T16:31:25.020301Z","steps":["trace[1799086463] 'process raft request' (duration: 974.456016ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:25.020376Z","caller":"traceutil/trace.go:171","msg":"trace[1978536733] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"962.581249ms","start":"2026-04-16T16:31:24.057784Z","end":"2026-04-16T16:31:25.020365Z","steps":["trace[1978536733] 'process raft request' (duration: 962.438825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.020402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.045708Z","time spent":"974.618779ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T16:31:25.020426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.057767Z","time spent":"962.640721ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T16:31:25.020283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.042485Z","time spent":"977.768852ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T16:31:25.02054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.045717Z","time spent":"974.679341ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T16:31:25.020609Z","caller":"traceutil/trace.go:171","msg":"trace[911992610] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"955.430323ms","start":"2026-04-16T16:31:24.065167Z","end":"2026-04-16T16:31:25.020597Z","steps":["trace[911992610] 'process raft request' (duration: 955.090435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.020664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.065159Z","time spent":"955.478294ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T16:31:25.021816Z","caller":"traceutil/trace.go:171","msg":"trace[1127202180] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"948.87431ms","start":"2026-04-16T16:31:24.072924Z","end":"2026-04-16T16:31:25.021799Z","steps":["trace[1127202180] 'process raft request' (duration: 947.432827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.021884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.072897Z","time spent":"948.958262ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T16:31:25.022093Z","caller":"traceutil/trace.go:171","msg":"trace[1444457115] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:487; }","duration":"815.455916ms","start":"2026-04-16T16:31:24.206625Z","end":"2026-04-16T16:31:25.022081Z","steps":["trace[1444457115] 'read index received' (duration: 798.689866ms)","trace[1444457115] 'applied index is now lower than readState.Index' (duration: 16.76522ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:31:25.022162Z","caller":"traceutil/trace.go:171","msg":"trace[260900927] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"818.839424ms","start":"2026-04-16T16:31:24.203315Z","end":"2026-04-16T16:31:25.022154Z","steps":["trace[260900927] 'process raft request' (duration: 818.440865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.022211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.203286Z","time spent":"818.899836ms","remote":"127.0.0.1:33538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T16:31:25.022368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.752742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-16T16:31:25.022403Z","caller":"traceutil/trace.go:171","msg":"trace[758659322] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:484; }","duration":"815.791244ms","start":"2026-04-16T16:31:24.206603Z","end":"2026-04-16T16:31:25.022394Z","steps":["trace[758659322] 'agreement among raft nodes before linearized reading' (duration: 815.703822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.022434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.206536Z","time spent":"815.890186ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T16:31:25.030704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.32705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:25.030898Z","caller":"traceutil/trace.go:171","msg":"trace[1244087062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"487.407652ms","start":"2026-04-16T16:31:24.54333Z","end":"2026-04-16T16:31:25.030737Z","steps":["trace[1244087062] 'agreement among raft nodes before linearized reading' (duration: 486.047171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:25.030924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:24.543276Z","time spent":"487.641558ms","remote":"127.0.0.1:33492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T16:31:25.031538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.3996ms","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-16T16:31:25.031559Z","caller":"traceutil/trace.go:171","msg":"trace[60794205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:486; }","duration":"153.456691ms","start":"2026-04-16T16:31:24.878097Z","end":"2026-04-16T16:31:25.031554Z","steps":["trace[60794205] 'agreement among raft nodes before linearized reading' (duration: 152.991851ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:27.659898Z","caller":"traceutil/trace.go:171","msg":"trace[628796736] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:576; }","duration":"115.892567ms","start":"2026-04-16T16:31:27.54398Z","end":"2026-04-16T16:31:27.659873Z","steps":["trace[628796736] 'read index received' (duration: 115.674762ms)","trace[628796736] 'applied index is now lower than readState.Index' (duration: 216.675µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:31:27.659964Z","caller":"traceutil/trace.go:171","msg":"trace[425465961] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"179.479366ms","start":"2026-04-16T16:31:27.480452Z","end":"2026-04-16T16:31:27.659932Z","steps":["trace[425465961] 'process raft request' (duration: 179.278132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:27.660082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.083221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:27.660159Z","caller":"traceutil/trace.go:171","msg":"trace[355309334] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:557; }","duration":"116.208384ms","start":"2026-04-16T16:31:27.543935Z","end":"2026-04-16T16:31:27.660144Z","steps":["trace[355309334] 'agreement among raft nodes before linearized reading' (duration: 116.032ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:28.721322Z","caller":"traceutil/trace.go:171","msg":"trace[672998371] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"680.069685ms","start":"2026-04-16T16:31:28.041229Z","end":"2026-04-16T16:31:28.721299Z","steps":["trace[672998371] 'process raft request' (duration: 679.767958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:28.721428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:28.041204Z","time spent":"680.176677ms","remote":"127.0.0.1:33586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T16:31:28.914161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.430935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:28.914254Z","caller":"traceutil/trace.go:171","msg":"trace[535177264] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:561; }","duration":"127.571739ms","start":"2026-04-16T16:31:28.786661Z","end":"2026-04-16T16:31:28.914232Z","steps":["trace[535177264] 'range keys from in-memory index tree' (duration: 127.304973ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:29.288082Z","caller":"traceutil/trace.go:171","msg":"trace[1029751368] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"232.464649ms","start":"2026-04-16T16:31:29.055578Z","end":"2026-04-16T16:31:29.288043Z","steps":["trace[1029751368] 'process raft request' (duration: 232.241034ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:29.344116Z","caller":"traceutil/trace.go:171","msg":"trace[193199377] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"287.52482ms","start":"2026-04-16T16:31:29.056561Z","end":"2026-04-16T16:31:29.344086Z","steps":["trace[193199377] 'process raft request' (duration: 273.537845ms)","trace[193199377] 'compare' (duration: 13.660458ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:31:29.344629Z","caller":"traceutil/trace.go:171","msg":"trace[652415469] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:581; }","duration":"259.114909ms","start":"2026-04-16T16:31:29.085485Z","end":"2026-04-16T16:31:29.3446Z","steps":["trace[652415469] 'read index received' (duration: 202.246396ms)","trace[652415469] 'applied index is now lower than readState.Index' (duration: 56.866093ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:31:29.344985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.414166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T16:31:29.345031Z","caller":"traceutil/trace.go:171","msg":"trace[865195869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:563; }","duration":"259.56108ms","start":"2026-04-16T16:31:29.085457Z","end":"2026-04-16T16:31:29.345018Z","steps":["trace[865195869] 'agreement among raft nodes before linearized reading' (duration: 259.249243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:33.820764Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":262226475746419949,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T16:31:34.323892Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":262226475746419949,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T16:31:34.341249Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.033850777s","expected-duration":"1s"} {"level":"info","ts":"2026-04-16T16:31:34.34165Z","caller":"traceutil/trace.go:171","msg":"trace[786049246] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"1.021909079s","start":"2026-04-16T16:31:33.319718Z","end":"2026-04-16T16:31:34.341627Z","steps":["trace[786049246] 'read index received' (duration: 1.021669493s)","trace[786049246] 'applied index is now lower than readState.Index' (duration: 238.086µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:31:34.341765Z","caller":"traceutil/trace.go:171","msg":"trace[1896420624] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.034462681s","start":"2026-04-16T16:31:33.307279Z","end":"2026-04-16T16:31:34.341742Z","steps":["trace[1896420624] 'process raft request' (duration: 1.034177764s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.341885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.307256Z","time spent":"1.034549823s","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:31:34.341956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.262355ms","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":"info","ts":"2026-04-16T16:31:34.342019Z","caller":"traceutil/trace.go:171","msg":"trace[967357465] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:594; }","duration":"795.332097ms","start":"2026-04-16T16:31:33.546668Z","end":"2026-04-16T16:31:34.342Z","steps":["trace[967357465] 'agreement among raft nodes before linearized reading' (duration: 795.254455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.341962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.865973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:31:34.342071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.546662Z","time spent":"795.395198ms","remote":"127.0.0.1:55408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"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-16T16:31:34.341885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021974621s","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-16T16:31:34.342117Z","caller":"traceutil/trace.go:171","msg":"trace[539169021] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:594; }","duration":"338.048867ms","start":"2026-04-16T16:31:34.004043Z","end":"2026-04-16T16:31:34.342092Z","steps":["trace[539169021] 'agreement among raft nodes before linearized reading' (duration: 337.828872ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:34.34216Z","caller":"traceutil/trace.go:171","msg":"trace[1316376151] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:594; }","duration":"1.022287048s","start":"2026-04-16T16:31:33.319845Z","end":"2026-04-16T16:31:34.342132Z","steps":["trace[1316376151] 'agreement among raft nodes before linearized reading' (duration: 1.02196053s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.342181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:34.004037Z","time spent":"338.129358ms","remote":"127.0.0.1:55466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:31:34.342226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.319827Z","time spent":"1.022380189s","remote":"127.0.0.1:55374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"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-16T16:31:34.342259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.07328ms","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-16T16:31:34.342413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.066367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.342468Z","caller":"traceutil/trace.go:171","msg":"trace[1828842581] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"797.138299ms","start":"2026-04-16T16:31:33.545314Z","end":"2026-04-16T16:31:34.342453Z","steps":["trace[1828842581] 'agreement among raft nodes before linearized reading' (duration: 797.074818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.342517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.545298Z","time spent":"797.20789ms","remote":"127.0.0.1:33492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T16:31:34.34259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.604411ms","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":"info","ts":"2026-04-16T16:31:34.34264Z","caller":"traceutil/trace.go:171","msg":"trace[1403995916] 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:594; }","duration":"213.657992ms","start":"2026-04-16T16:31:34.128971Z","end":"2026-04-16T16:31:34.342629Z","steps":["trace[1403995916] 'agreement among raft nodes before linearized reading' (duration: 213.58087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.342684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.41262ms","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-16T16:31:34.342722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.163691ms","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-16T16:31:34.342747Z","caller":"traceutil/trace.go:171","msg":"trace[135829947] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:594; }","duration":"306.506503ms","start":"2026-04-16T16:31:34.036225Z","end":"2026-04-16T16:31:34.342732Z","steps":["trace[135829947] 'agreement among raft nodes before linearized reading' (duration: 306.40788ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:34.342766Z","caller":"traceutil/trace.go:171","msg":"trace[1275889821] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:594; }","duration":"813.240843ms","start":"2026-04-16T16:31:33.529513Z","end":"2026-04-16T16:31:34.342753Z","steps":["trace[1275889821] 'agreement among raft nodes before linearized reading' (duration: 813.170171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.342795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:34.036203Z","time spent":"306.577474ms","remote":"127.0.0.1:55480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-16T16:31:34.342802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.919472ms","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-16T16:31:34.342565Z","caller":"traceutil/trace.go:171","msg":"trace[2044594791] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:594; }","duration":"795.447449ms","start":"2026-04-16T16:31:33.546959Z","end":"2026-04-16T16:31:34.342407Z","steps":["trace[2044594791] 'agreement among raft nodes before linearized reading' (duration: 794.943537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.342819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.529492Z","time spent":"813.314044ms","remote":"127.0.0.1:55398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-16T16:31:34.342836Z","caller":"traceutil/trace.go:171","msg":"trace[880660368] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:594; }","duration":"306.992394ms","start":"2026-04-16T16:31:34.035833Z","end":"2026-04-16T16:31:34.342826Z","steps":["trace[880660368] 'agreement among raft nodes before linearized reading' (duration: 306.940493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.342869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:34.035805Z","time spent":"307.055216ms","remote":"127.0.0.1:55480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:31:34.342957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.546944Z","time spent":"795.90386ms","remote":"127.0.0.1:55408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-16T16:31:34.34291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.818446ms","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":"warn","ts":"2026-04-16T16:31:34.343044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.365572ms","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":"warn","ts":"2026-04-16T16:31:34.343059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.39193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.343116Z","caller":"traceutil/trace.go:171","msg":"trace[1677082225] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:594; }","duration":"815.500066ms","start":"2026-04-16T16:31:33.527602Z","end":"2026-04-16T16:31:34.343102Z","steps":["trace[1677082225] 'agreement among raft nodes before linearized reading' (duration: 815.385194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.343183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.110037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.343224Z","caller":"traceutil/trace.go:171","msg":"trace[1815867890] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:594; }","duration":"255.190239ms","start":"2026-04-16T16:31:34.088022Z","end":"2026-04-16T16:31:34.343212Z","steps":["trace[1815867890] 'agreement among raft nodes before linearized reading' (duration: 255.129677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.343251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.70684ms","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-16T16:31:34.34329Z","caller":"traceutil/trace.go:171","msg":"trace[1993869140] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:594; }","duration":"815.746341ms","start":"2026-04-16T16:31:33.527531Z","end":"2026-04-16T16:31:34.343277Z","steps":["trace[1993869140] 'agreement among raft nodes before linearized reading' (duration: 815.6801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.343341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.527499Z","time spent":"815.828493ms","remote":"127.0.0.1:55398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:31:34.343348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.313413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.343398Z","caller":"traceutil/trace.go:171","msg":"trace[1235160021] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:594; }","duration":"427.390025ms","start":"2026-04-16T16:31:33.915998Z","end":"2026-04-16T16:31:34.343388Z","steps":["trace[1235160021] 'agreement among raft nodes before linearized reading' (duration: 427.321363ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:34.343331Z","caller":"traceutil/trace.go:171","msg":"trace[1139880193] 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:594; }","duration":"214.282766ms","start":"2026-04-16T16:31:34.128951Z","end":"2026-04-16T16:31:34.343233Z","steps":["trace[1139880193] 'agreement among raft nodes before linearized reading' (duration: 213.049608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.34344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.915981Z","time spent":"427.450336ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T16:31:34.343453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.389573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.343506Z","caller":"traceutil/trace.go:171","msg":"trace[1837575909] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:594; }","duration":"255.474045ms","start":"2026-04-16T16:31:34.088019Z","end":"2026-04-16T16:31:34.343493Z","steps":["trace[1837575909] 'agreement among raft nodes before linearized reading' (duration: 255.394403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.343563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.065423ms","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-16T16:31:34.343604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.629784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.343631Z","caller":"traceutil/trace.go:171","msg":"trace[1646629632] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"860.148015ms","start":"2026-04-16T16:31:33.483458Z","end":"2026-04-16T16:31:34.343606Z","steps":["trace[1646629632] 'agreement among raft nodes before linearized reading' (duration: 860.065643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.343682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.512882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.343727Z","caller":"traceutil/trace.go:171","msg":"trace[1070089334] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:594; }","duration":"361.563833ms","start":"2026-04-16T16:31:33.982155Z","end":"2026-04-16T16:31:34.343719Z","steps":["trace[1070089334] 'agreement among raft nodes before linearized reading' (duration: 361.506871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.343762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.982151Z","time spent":"361.602073ms","remote":"127.0.0.1:55450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-16T16:31:34.343763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.36606ms","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-16T16:31:34.343807Z","caller":"traceutil/trace.go:171","msg":"trace[1973095040] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"860.452972ms","start":"2026-04-16T16:31:33.483342Z","end":"2026-04-16T16:31:34.343795Z","steps":["trace[1973095040] 'agreement among raft nodes before linearized reading' (duration: 860.376571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.343867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.483319Z","time spent":"860.526404ms","remote":"127.0.0.1:55392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T16:31:34.343729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.459371ms","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-16T16:31:34.343916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.474624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.343947Z","caller":"traceutil/trace.go:171","msg":"trace[727876158] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:594; }","duration":"362.511235ms","start":"2026-04-16T16:31:33.981427Z","end":"2026-04-16T16:31:34.343938Z","steps":["trace[727876158] 'agreement among raft nodes before linearized reading' (duration: 362.464384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.343956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.455589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:31:34.343992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.981424Z","time spent":"362.552536ms","remote":"127.0.0.1:55450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-16T16:31:34.344005Z","caller":"traceutil/trace.go:171","msg":"trace[2013564340] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:594; }","duration":"146.576921ms","start":"2026-04-16T16:31:34.197413Z","end":"2026-04-16T16:31:34.34399Z","steps":["trace[2013564340] 'agreement among raft nodes before linearized reading' (duration: 146.428037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.343882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.539035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:31:34.343557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.545968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:31:34.344107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.949058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:31:34.344129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.642861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.34414Z","caller":"traceutil/trace.go:171","msg":"trace[1986784037] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:594; }","duration":"428.135222ms","start":"2026-04-16T16:31:33.915994Z","end":"2026-04-16T16:31:34.34413Z","steps":["trace[1986784037] 'agreement among raft nodes before linearized reading' (duration: 427.440786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024431787s","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-16T16:31:34.344173Z","caller":"traceutil/trace.go:171","msg":"trace[848337509] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:594; }","duration":"1.024479319s","start":"2026-04-16T16:31:33.319687Z","end":"2026-04-16T16:31:34.344167Z","steps":["trace[848337509] 'agreement among raft nodes before linearized reading' (duration: 1.024444778s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.915942Z","time spent":"428.225824ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:31:34.344207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.319669Z","time spent":"1.02453289s","remote":"127.0.0.1:55374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T16:31:34.34415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.353909ms","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":"warn","ts":"2026-04-16T16:31:34.344232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.823988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:31:34.343088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.665711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.344276Z","caller":"traceutil/trace.go:171","msg":"trace[1860998113] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:594; }","duration":"896.89048ms","start":"2026-04-16T16:31:33.447373Z","end":"2026-04-16T16:31:34.344264Z","steps":["trace[1860998113] 'agreement among raft nodes before linearized reading' (duration: 896.816989ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:34.344298Z","caller":"traceutil/trace.go:171","msg":"trace[21204610] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:594; }","duration":"339.89099ms","start":"2026-04-16T16:31:34.004397Z","end":"2026-04-16T16:31:34.344288Z","steps":["trace[21204610] 'agreement among raft nodes before linearized reading' (duration: 338.60818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.447362Z","time spent":"896.945141ms","remote":"127.0.0.1:55384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T16:31:34.344335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:34.00439Z","time spent":"339.935631ms","remote":"127.0.0.1:55466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-16T16:31:34.344357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.297343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.344253Z","caller":"traceutil/trace.go:171","msg":"trace[1916111653] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:594; }","duration":"199.486423ms","start":"2026-04-16T16:31:34.144752Z","end":"2026-04-16T16:31:34.344239Z","steps":["trace[1916111653] 'agreement among raft nodes before linearized reading' (duration: 198.548791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.058306ms","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":"warn","ts":"2026-04-16T16:31:34.344467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.474247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:31:34.343689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.483452Z","time spent":"860.221427ms","remote":"127.0.0.1:55392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-16T16:31:34.344508Z","caller":"traceutil/trace.go:171","msg":"trace[1953630183] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:594; }","duration":"406.5402ms","start":"2026-04-16T16:31:33.937956Z","end":"2026-04-16T16:31:34.344496Z","steps":["trace[1953630183] 'agreement among raft nodes before linearized reading' (duration: 406.464488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.937946Z","time spent":"406.591911ms","remote":"127.0.0.1:55438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-16T16:31:34.343638Z","caller":"traceutil/trace.go:171","msg":"trace[1354460264] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:594; }","duration":"339.682824ms","start":"2026-04-16T16:31:34.003946Z","end":"2026-04-16T16:31:34.343629Z","steps":["trace[1354460264] 'agreement among raft nodes before linearized reading' (duration: 339.633583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.151146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:31:34.344622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:34.003915Z","time spent":"340.693898ms","remote":"127.0.0.1:55466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T16:31:34.344572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.436166ms","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-16T16:31:34.344176Z","caller":"traceutil/trace.go:171","msg":"trace[1051916973] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:594; }","duration":"427.710172ms","start":"2026-04-16T16:31:33.916453Z","end":"2026-04-16T16:31:34.344163Z","steps":["trace[1051916973] 'agreement among raft nodes before linearized reading' (duration: 427.6374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.916445Z","time spent":"428.312976ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-16T16:31:34.344822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.660529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-16T16:31:34.343183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.527578Z","time spent":"815.580198ms","remote":"127.0.0.1:55398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-16T16:31:34.344881Z","caller":"traceutil/trace.go:171","msg":"trace[1793506882] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"983.749741ms","start":"2026-04-16T16:31:33.361117Z","end":"2026-04-16T16:31:34.344867Z","steps":["trace[1793506882] 'agreement among raft nodes before linearized reading' (duration: 983.606288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.361092Z","time spent":"983.828823ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T16:31:34.344298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.810712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.344999Z","caller":"traceutil/trace.go:171","msg":"trace[1349913936] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:594; }","duration":"406.535659ms","start":"2026-04-16T16:31:33.938452Z","end":"2026-04-16T16:31:34.344987Z","steps":["trace[1349913936] 'agreement among raft nodes before linearized reading' (duration: 405.806542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.262622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:31:34.344862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.585508ms","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":"info","ts":"2026-04-16T16:31:34.34514Z","caller":"traceutil/trace.go:171","msg":"trace[1525018992] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:594; }","duration":"522.512088ms","start":"2026-04-16T16:31:33.822584Z","end":"2026-04-16T16:31:34.345096Z","steps":["trace[1525018992] 'agreement among raft nodes before linearized reading' (duration: 522.276292ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:34.343127Z","caller":"traceutil/trace.go:171","msg":"trace[1034911871] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:594; }","duration":"254.473892ms","start":"2026-04-16T16:31:34.088638Z","end":"2026-04-16T16:31:34.343112Z","steps":["trace[1034911871] 'agreement among raft nodes before linearized reading' (duration: 254.37873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.345185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.112922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.345174Z","caller":"traceutil/trace.go:171","msg":"trace[41870144] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:594; }","duration":"200.913706ms","start":"2026-04-16T16:31:34.144244Z","end":"2026-04-16T16:31:34.345157Z","steps":["trace[41870144] 'agreement among raft nodes before linearized reading' (duration: 200.509407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.805021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.346433Z","caller":"traceutil/trace.go:171","msg":"trace[891415850] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:594; }","duration":"365.007683ms","start":"2026-04-16T16:31:33.981405Z","end":"2026-04-16T16:31:34.346412Z","steps":["trace[891415850] 'agreement among raft nodes before linearized reading' (duration: 362.797772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.346495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.981399Z","time spent":"365.075795ms","remote":"127.0.0.1:55450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-16T16:31:34.344164Z","caller":"traceutil/trace.go:171","msg":"trace[225381505] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:594; }","duration":"896.0235ms","start":"2026-04-16T16:31:33.448127Z","end":"2026-04-16T16:31:34.34415Z","steps":["trace[225381505] 'agreement among raft nodes before linearized reading' (duration: 895.930627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.346727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.44812Z","time spent":"898.587979ms","remote":"127.0.0.1:55384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-16T16:31:34.344698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.024975ms","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-16T16:31:34.346939Z","caller":"traceutil/trace.go:171","msg":"trace[1877411468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:594; }","duration":"976.291357ms","start":"2026-04-16T16:31:33.370633Z","end":"2026-04-16T16:31:34.346924Z","steps":["trace[1877411468] 'agreement among raft nodes before linearized reading' (duration: 973.948013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.342985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.169538ms","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-16T16:31:34.347037Z","caller":"traceutil/trace.go:171","msg":"trace[2059007072] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:594; }","duration":"311.248552ms","start":"2026-04-16T16:31:34.035773Z","end":"2026-04-16T16:31:34.347022Z","steps":["trace[2059007072] 'agreement among raft nodes before linearized reading' (duration: 307.190148ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:34.344398Z","caller":"traceutil/trace.go:171","msg":"trace[2129027669] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:594; }","duration":"406.369715ms","start":"2026-04-16T16:31:33.938016Z","end":"2026-04-16T16:31:34.344385Z","steps":["trace[2129027669] 'agreement among raft nodes before linearized reading' (duration: 406.305214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.347075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:34.035735Z","time spent":"311.329164ms","remote":"127.0.0.1:55480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T16:31:34.347093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.937992Z","time spent":"409.081279ms","remote":"127.0.0.1:55438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T16:31:34.34704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.370258Z","time spent":"976.766568ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-16T16:31:34.34463Z","caller":"traceutil/trace.go:171","msg":"trace[687564748] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:594; }","duration":"897.253228ms","start":"2026-04-16T16:31:33.447365Z","end":"2026-04-16T16:31:34.344618Z","steps":["trace[687564748] 'agreement among raft nodes before linearized reading' (duration: 897.152106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.347237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.447348Z","time spent":"899.879719ms","remote":"127.0.0.1:55384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:31:34.345193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.822561Z","time spent":"522.618281ms","remote":"127.0.0.1:55418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"info","ts":"2026-04-16T16:31:34.345237Z","caller":"traceutil/trace.go:171","msg":"trace[1455922665] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:594; }","duration":"523.186254ms","start":"2026-04-16T16:31:33.822036Z","end":"2026-04-16T16:31:34.345222Z","steps":["trace[1455922665] 'agreement among raft nodes before linearized reading' (duration: 523.106072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.347381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.822028Z","time spent":"525.327993ms","remote":"127.0.0.1:55420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T16:31:34.34506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.938446Z","time spent":"406.589ms","remote":"127.0.0.1:55438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-04-16T16:31:34.344847Z","caller":"traceutil/trace.go:171","msg":"trace[1342632429] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:594; }","duration":"179.6419ms","start":"2026-04-16T16:31:34.165103Z","end":"2026-04-16T16:31:34.344745Z","steps":["trace[1342632429] 'agreement among raft nodes before linearized reading' (duration: 179.349514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.344971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.209906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.347605Z","caller":"traceutil/trace.go:171","msg":"trace[208995100] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:594; }","duration":"651.875289ms","start":"2026-04-16T16:31:33.69572Z","end":"2026-04-16T16:31:34.347596Z","steps":["trace[208995100] 'agreement among raft nodes before linearized reading' (duration: 649.209837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.347636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.695703Z","time spent":"651.919309ms","remote":"127.0.0.1:55418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T16:31:34.342355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.456162ms","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":"info","ts":"2026-04-16T16:31:34.347714Z","caller":"traceutil/trace.go:171","msg":"trace[641980886] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:594; }","duration":"801.855488ms","start":"2026-04-16T16:31:33.54585Z","end":"2026-04-16T16:31:34.347705Z","steps":["trace[641980886] 'agreement among raft nodes before linearized reading' (duration: 796.454543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.347747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.545831Z","time spent":"801.90647ms","remote":"127.0.0.1:55408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-04-16T16:31:34.343995Z","caller":"traceutil/trace.go:171","msg":"trace[329175166] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"832.770948ms","start":"2026-04-16T16:31:33.51121Z","end":"2026-04-16T16:31:34.343981Z","steps":["trace[329175166] 'agreement among raft nodes before linearized reading' (duration: 832.277696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.347803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.511205Z","time spent":"836.582686ms","remote":"127.0.0.1:55394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-16T16:31:34.345297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.844946ms","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-16T16:31:34.347896Z","caller":"traceutil/trace.go:171","msg":"trace[282762664] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"837.454556ms","start":"2026-04-16T16:31:33.510433Z","end":"2026-04-16T16:31:34.347888Z","steps":["trace[282762664] 'agreement among raft nodes before linearized reading' (duration: 833.069735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.347928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.51043Z","time spent":"837.484807ms","remote":"127.0.0.1:55394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"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-16T16:31:34.345296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.486071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.34802Z","caller":"traceutil/trace.go:171","msg":"trace[105998637] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:594; }","duration":"526.236314ms","start":"2026-04-16T16:31:33.821776Z","end":"2026-04-16T16:31:34.348012Z","steps":["trace[105998637] 'agreement among raft nodes before linearized reading' (duration: 523.48657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.348044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.82176Z","time spent":"526.275895ms","remote":"127.0.0.1:55420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-16T16:31:34.344113Z","caller":"traceutil/trace.go:171","msg":"trace[433338228] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:594; }","duration":"178.931684ms","start":"2026-04-16T16:31:34.165161Z","end":"2026-04-16T16:31:34.344092Z","steps":["trace[433338228] 'agreement among raft nodes before linearized reading' (duration: 178.366581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.345333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.906688ms","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-16T16:31:34.349832Z","caller":"traceutil/trace.go:171","msg":"trace[1054001190] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:594; }","duration":"839.354021ms","start":"2026-04-16T16:31:33.510406Z","end":"2026-04-16T16:31:34.34976Z","steps":["trace[1054001190] 'agreement among raft nodes before linearized reading' (duration: 833.106856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.350181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.510398Z","time spent":"839.525415ms","remote":"127.0.0.1:55394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-04-16T16:31:34.344571Z","caller":"traceutil/trace.go:171","msg":"trace[475926366] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:594; }","duration":"200.243979ms","start":"2026-04-16T16:31:34.144245Z","end":"2026-04-16T16:31:34.344489Z","steps":["trace[475926366] 'agreement among raft nodes before linearized reading' (duration: 200.042725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.345359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.678422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.351486Z","caller":"traceutil/trace.go:171","msg":"trace[1895864642] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:594; }","duration":"185.804764ms","start":"2026-04-16T16:31:34.165664Z","end":"2026-04-16T16:31:34.351469Z","steps":["trace[1895864642] 'agreement among raft nodes before linearized reading' (duration: 177.846869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.3455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.243486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:31:34.351672Z","caller":"traceutil/trace.go:171","msg":"trace[2081012812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"624.521561ms","start":"2026-04-16T16:31:33.727143Z","end":"2026-04-16T16:31:34.351664Z","steps":["trace[2081012812] 'agreement among raft nodes before linearized reading' (duration: 618.178974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.351722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.72713Z","time spent":"624.582412ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T16:31:34.345524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.496728ms","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":"info","ts":"2026-04-16T16:31:34.351867Z","caller":"traceutil/trace.go:171","msg":"trace[1541933247] 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:594; }","duration":"222.889327ms","start":"2026-04-16T16:31:34.128969Z","end":"2026-04-16T16:31:34.351859Z","steps":["trace[1541933247] 'agreement among raft nodes before linearized reading' (duration: 216.529819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.3456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.597125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.35206Z","caller":"traceutil/trace.go:171","msg":"trace[1659226210] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:594; }","duration":"656.100726ms","start":"2026-04-16T16:31:33.695951Z","end":"2026-04-16T16:31:34.352052Z","steps":["trace[1659226210] 'agreement among raft nodes before linearized reading' (duration: 649.580975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.352118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:33.695944Z","time spent":"656.155437ms","remote":"127.0.0.1:55418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:31:34.345646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.17854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.352255Z","caller":"traceutil/trace.go:171","msg":"trace[1806933448] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:594; }","duration":"130.801334ms","start":"2026-04-16T16:31:34.221446Z","end":"2026-04-16T16:31:34.352247Z","steps":["trace[1806933448] 'agreement among raft nodes before linearized reading' (duration: 124.17494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.345757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.621561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.352469Z","caller":"traceutil/trace.go:171","msg":"trace[1042042554] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:594; }","duration":"131.339556ms","start":"2026-04-16T16:31:34.2211Z","end":"2026-04-16T16:31:34.35244Z","steps":["trace[1042042554] 'agreement among raft nodes before linearized reading' (duration: 124.61906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.345811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.772694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.352699Z","caller":"traceutil/trace.go:171","msg":"trace[338349548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:594; }","duration":"131.678904ms","start":"2026-04-16T16:31:34.221012Z","end":"2026-04-16T16:31:34.352691Z","steps":["trace[338349548] 'agreement among raft nodes before linearized reading' (duration: 124.772724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:34.34586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.362562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:34.352942Z","caller":"traceutil/trace.go:171","msg":"trace[1751743586] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:594; }","duration":"155.470368ms","start":"2026-04-16T16:31:34.197464Z","end":"2026-04-16T16:31:34.352934Z","steps":["trace[1751743586] 'agreement among raft nodes before linearized reading' (duration: 148.368983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:35.995436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.838347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:35.995508Z","caller":"traceutil/trace.go:171","msg":"trace[1693980677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"452.95748ms","start":"2026-04-16T16:31:35.542533Z","end":"2026-04-16T16:31:35.99549Z","steps":["trace[1693980677] 'range keys from in-memory index tree' (duration: 452.764226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:35.995548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:35.542513Z","time spent":"453.024392ms","remote":"127.0.0.1:33492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T16:31:35.995974Z","caller":"traceutil/trace.go:171","msg":"trace[1727238536] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"163.334331ms","start":"2026-04-16T16:31:35.83262Z","end":"2026-04-16T16:31:35.995955Z","steps":["trace[1727238536] 'process raft request' (duration: 97.090319ms)","trace[1727238536] 'compare' (duration: 65.970365ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:31:36.70908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.660863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:31:36.709166Z","caller":"traceutil/trace.go:171","msg":"trace[2068660326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"259.770504ms","start":"2026-04-16T16:31:36.449364Z","end":"2026-04-16T16:31:36.709134Z","steps":["trace[2068660326] 'range keys from in-memory index tree' (duration: 259.527069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:36.709188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.942007ms","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-16T16:31:36.709224Z","caller":"traceutil/trace.go:171","msg":"trace[1494205695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"296.035028ms","start":"2026-04-16T16:31:36.413176Z","end":"2026-04-16T16:31:36.709212Z","steps":["trace[1494205695] 'range keys from in-memory index tree' (duration: 295.717701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:36.70908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.818546ms","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-16T16:31:36.70931Z","caller":"traceutil/trace.go:171","msg":"trace[777629976] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"260.071571ms","start":"2026-04-16T16:31:36.449232Z","end":"2026-04-16T16:31:36.709304Z","steps":["trace[777629976] 'range keys from in-memory index tree' (duration: 259.625601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:36.709368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.733768ms","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-16T16:31:36.70947Z","caller":"traceutil/trace.go:171","msg":"trace[1592595533] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"355.908152ms","start":"2026-04-16T16:31:36.353544Z","end":"2026-04-16T16:31:36.709452Z","steps":["trace[1592595533] 'range keys from in-memory index tree' (duration: 355.470731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:36.709521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:36.353521Z","time spent":"355.990324ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T16:31:46.751402Z","caller":"traceutil/trace.go:171","msg":"trace[290050917] linearizableReadLoop","detail":"{readStateIndex:737; appliedIndex:736; }","duration":"207.204521ms","start":"2026-04-16T16:31:46.544175Z","end":"2026-04-16T16:31:46.751379Z","steps":["trace[290050917] 'read index received' (duration: 207.030717ms)","trace[290050917] 'applied index is now lower than readState.Index' (duration: 172.734µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:31:46.751557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.364814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:31:46.751647Z","caller":"traceutil/trace.go:171","msg":"trace[2027074583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:713; }","duration":"207.504848ms","start":"2026-04-16T16:31:46.544121Z","end":"2026-04-16T16:31:46.751626Z","steps":["trace[2027074583] 'agreement among raft nodes before linearized reading' (duration: 207.354554ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:46.752048Z","caller":"traceutil/trace.go:171","msg":"trace[1547948479] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"269.154712ms","start":"2026-04-16T16:31:46.482876Z","end":"2026-04-16T16:31:46.75203Z","steps":["trace[1547948479] 'process raft request' (duration: 268.336823ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:46.987233Z","caller":"traceutil/trace.go:171","msg":"trace[1374783452] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"104.809499ms","start":"2026-04-16T16:31:46.882398Z","end":"2026-04-16T16:31:46.987208Z","steps":["trace[1374783452] 'process raft request' (duration: 50.112967ms)","trace[1374783452] 'compare' (duration: 54.494988ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:31:52.673755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.465586ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-16T16:31:52.676316Z","caller":"traceutil/trace.go:171","msg":"trace[9540958] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"754.899439ms","start":"2026-04-16T16:31:51.921391Z","end":"2026-04-16T16:31:52.67629Z","steps":["trace[9540958] 'process raft request' (duration: 754.707785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:31:52.676568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:31:51.921366Z","time spent":"755.032763ms","remote":"127.0.0.1:33706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:31:59.179439Z","caller":"traceutil/trace.go:171","msg":"trace[1444815400] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"171.487194ms","start":"2026-04-16T16:31:59.007917Z","end":"2026-04-16T16:31:59.179405Z","steps":["trace[1444815400] 'process raft request' (duration: 83.433918ms)","trace[1444815400] 'compare' (duration: 87.912702ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:31:59.290339Z","caller":"traceutil/trace.go:171","msg":"trace[1221048245] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"279.628189ms","start":"2026-04-16T16:31:59.010687Z","end":"2026-04-16T16:31:59.290315Z","steps":["trace[1221048245] 'process raft request' (duration: 279.519567ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:31:59.290331Z","caller":"traceutil/trace.go:171","msg":"trace[981046493] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"282.210399ms","start":"2026-04-16T16:31:59.008085Z","end":"2026-04-16T16:31:59.290295Z","steps":["trace[981046493] 'process raft request' (duration: 278.071184ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:00.157481Z","caller":"traceutil/trace.go:171","msg":"trace[661089355] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"143.682419ms","start":"2026-04-16T16:32:00.013769Z","end":"2026-04-16T16:32:00.157451Z","steps":["trace[661089355] 'process raft request' (duration: 143.482094ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:00.157879Z","caller":"traceutil/trace.go:171","msg":"trace[1075309156] linearizableReadLoop","detail":"{readStateIndex:866; appliedIndex:866; }","duration":"107.160483ms","start":"2026-04-16T16:32:00.05066Z","end":"2026-04-16T16:32:00.157821Z","steps":["trace[1075309156] 'read index received' (duration: 107.148833ms)","trace[1075309156] 'applied index is now lower than readState.Index' (duration: 9.14µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:00.158014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.326437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T16:32:00.158095Z","caller":"traceutil/trace.go:171","msg":"trace[2134722913] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:838; }","duration":"107.48252ms","start":"2026-04-16T16:32:00.050596Z","end":"2026-04-16T16:32:00.158079Z","steps":["trace[2134722913] 'agreement among raft nodes before linearized reading' (duration: 107.319446ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:05.4692Z","caller":"traceutil/trace.go:171","msg":"trace[2082271363] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"110.908968ms","start":"2026-04-16T16:32:05.358266Z","end":"2026-04-16T16:32:05.469175Z","steps":["trace[2082271363] 'process raft request' (duration: 103.015997ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:15.271029Z","caller":"traceutil/trace.go:171","msg":"trace[1484633103] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"314.659082ms","start":"2026-04-16T16:32:14.956342Z","end":"2026-04-16T16:32:15.271001Z","steps":["trace[1484633103] 'process raft request' (duration: 314.457757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:15.271198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:14.95633Z","time spent":"314.777635ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:32:15.521608Z","caller":"traceutil/trace.go:171","msg":"trace[1170404928] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:956; }","duration":"424.959777ms","start":"2026-04-16T16:32:15.096593Z","end":"2026-04-16T16:32:15.521553Z","steps":["trace[1170404928] 'read index received' (duration: 174.218798ms)","trace[1170404928] 'applied index is now lower than readState.Index' (duration: 250.739759ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:32:15.521912Z","caller":"traceutil/trace.go:171","msg":"trace[120687402] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"447.701427ms","start":"2026-04-16T16:32:15.07417Z","end":"2026-04-16T16:32:15.521871Z","steps":["trace[120687402] 'process raft request' (duration: 403.137737ms)","trace[120687402] 'compare' (duration: 43.781692ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:15.522087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.961323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-16T16:32:15.522115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:15.074141Z","time spent":"447.866061ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:32:15.522163Z","caller":"traceutil/trace.go:171","msg":"trace[1432634735] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:926; }","duration":"247.084745ms","start":"2026-04-16T16:32:15.275061Z","end":"2026-04-16T16:32:15.522146Z","steps":["trace[1432634735] 'agreement among raft nodes before linearized reading' (duration: 246.898811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:15.522165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.639656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T16:32:15.522352Z","caller":"traceutil/trace.go:171","msg":"trace[164724993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:926; }","duration":"416.848781ms","start":"2026-04-16T16:32:15.105486Z","end":"2026-04-16T16:32:15.522334Z","steps":["trace[164724993] 'agreement among raft nodes before linearized reading' (duration: 416.456732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:15.52247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:15.105475Z","time spent":"416.978074ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T16:32:15.523589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.003924ms","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-16T16:32:15.52364Z","caller":"traceutil/trace.go:171","msg":"trace[1875049948] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:926; }","duration":"427.104366ms","start":"2026-04-16T16:32:15.096525Z","end":"2026-04-16T16:32:15.523629Z","steps":["trace[1875049948] 'agreement among raft nodes before linearized reading' (duration: 425.367817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:15.523672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:15.096498Z","time spent":"427.165047ms","remote":"127.0.0.1:33574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:32:15.753822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.127346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T16:32:15.753982Z","caller":"traceutil/trace.go:171","msg":"trace[1332825130] linearizableReadLoop","detail":"{readStateIndex:961; appliedIndex:959; }","duration":"219.930584ms","start":"2026-04-16T16:32:15.534036Z","end":"2026-04-16T16:32:15.753967Z","steps":["trace[1332825130] 'read index received' (duration: 41.659694ms)","trace[1332825130] 'applied index is now lower than readState.Index' (duration: 178.26974ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:32:15.754078Z","caller":"traceutil/trace.go:171","msg":"trace[962127077] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"226.653898ms","start":"2026-04-16T16:32:15.527396Z","end":"2026-04-16T16:32:15.75405Z","steps":["trace[962127077] 'process raft request' (duration: 97.224275ms)","trace[962127077] 'compare' (duration: 129.011403ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:32:15.754147Z","caller":"traceutil/trace.go:171","msg":"trace[1921802695] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"226.649348ms","start":"2026-04-16T16:32:15.527488Z","end":"2026-04-16T16:32:15.754137Z","steps":["trace[1921802695] 'process raft request' (duration: 226.406552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:15.754109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.083558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:32:15.754283Z","caller":"traceutil/trace.go:171","msg":"trace[795169032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:929; }","duration":"220.302633ms","start":"2026-04-16T16:32:15.533972Z","end":"2026-04-16T16:32:15.754275Z","steps":["trace[795169032] 'agreement among raft nodes before linearized reading' (duration: 220.050087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:17.380306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.563354ms","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-16T16:32:17.380398Z","caller":"traceutil/trace.go:171","msg":"trace[71144286] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:932; }","duration":"104.699026ms","start":"2026-04-16T16:32:17.275681Z","end":"2026-04-16T16:32:17.38038Z","steps":["trace[71144286] 'range keys from in-memory index tree' (duration: 104.307377ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:17.583862Z","caller":"traceutil/trace.go:171","msg":"trace[1696940249] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"198.851502ms","start":"2026-04-16T16:32:17.384986Z","end":"2026-04-16T16:32:17.583837Z","steps":["trace[1696940249] 'process raft request' (duration: 198.694938ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:17.671079Z","caller":"traceutil/trace.go:171","msg":"trace[692923817] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:966; }","duration":"127.877587ms","start":"2026-04-16T16:32:17.543173Z","end":"2026-04-16T16:32:17.67105Z","steps":["trace[692923817] 'read index received' (duration: 40.783764ms)","trace[692923817] 'applied index is now lower than readState.Index' (duration: 87.077273ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:17.67128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.071781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:32:17.671327Z","caller":"traceutil/trace.go:171","msg":"trace[21236117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:934; }","duration":"128.151613ms","start":"2026-04-16T16:32:17.543163Z","end":"2026-04-16T16:32:17.671315Z","steps":["trace[21236117] 'agreement among raft nodes before linearized reading' (duration: 128.034581ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:17.671158Z","caller":"traceutil/trace.go:171","msg":"trace[1025383555] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"142.421669ms","start":"2026-04-16T16:32:17.528684Z","end":"2026-04-16T16:32:17.671106Z","steps":["trace[1025383555] 'process raft request' (duration: 142.215115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:30.240246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":262226475746420735,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T16:32:30.721462Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.008080584s","expected-duration":"1s"} {"level":"info","ts":"2026-04-16T16:32:30.781333Z","caller":"traceutil/trace.go:171","msg":"trace[629448347] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1012; }","duration":"1.041343076s","start":"2026-04-16T16:32:29.739954Z","end":"2026-04-16T16:32:30.781297Z","steps":["trace[629448347] 'read index received' (duration: 981.848554ms)","trace[629448347] 'applied index is now lower than readState.Index' (duration: 59.493132ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:32:30.781631Z","caller":"traceutil/trace.go:171","msg":"trace[1959725014] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"1.068237312s","start":"2026-04-16T16:32:29.713326Z","end":"2026-04-16T16:32:30.781563Z","steps":["trace[1959725014] 'process raft request' (duration: 1.008463814s)","trace[1959725014] 'compare' (duration: 58.840016ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:30.781802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:29.713312Z","time spent":"1.068389455s","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:32:30.78191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.041933399s","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-16T16:32:30.781975Z","caller":"traceutil/trace.go:171","msg":"trace[929651846] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:977; }","duration":"1.042030912s","start":"2026-04-16T16:32:29.739919Z","end":"2026-04-16T16:32:30.78195Z","steps":["trace[929651846] 'agreement among raft nodes before linearized reading' (duration: 1.041824367s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:30.782024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:29.739903Z","time spent":"1.042109023s","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T16:32:30.814104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.131121ms","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-16T16:32:30.814132Z","caller":"traceutil/trace.go:171","msg":"trace[41668245] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"411.666953ms","start":"2026-04-16T16:32:30.402437Z","end":"2026-04-16T16:32:30.814104Z","steps":["trace[41668245] 'process raft request' (duration: 411.428097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:30.814168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.238789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:32:30.814181Z","caller":"traceutil/trace.go:171","msg":"trace[1981286940] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:978; }","duration":"996.263344ms","start":"2026-04-16T16:32:29.817899Z","end":"2026-04-16T16:32:30.814162Z","steps":["trace[1981286940] 'agreement among raft nodes before linearized reading' (duration: 996.07506ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:30.814213Z","caller":"traceutil/trace.go:171","msg":"trace[1100667008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:978; }","duration":"271.30284ms","start":"2026-04-16T16:32:30.542895Z","end":"2026-04-16T16:32:30.814198Z","steps":["trace[1100667008] 'agreement among raft nodes before linearized reading' (duration: 271.250369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:30.814221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:29.817882Z","time spent":"996.330605ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T16:32:30.814299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:30.402416Z","time spent":"411.781996ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:32:30.814105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.530771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:32:30.814408Z","caller":"traceutil/trace.go:171","msg":"trace[1007014089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:978; }","duration":"761.867658ms","start":"2026-04-16T16:32:30.052529Z","end":"2026-04-16T16:32:30.814397Z","steps":["trace[1007014089] 'agreement among raft nodes before linearized reading' (duration: 761.51783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:30.814437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:30.052497Z","time spent":"761.9326ms","remote":"127.0.0.1:33492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T16:32:30.814443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.326224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:32:30.814519Z","caller":"traceutil/trace.go:171","msg":"trace[833716242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:978; }","duration":"992.452247ms","start":"2026-04-16T16:32:29.822048Z","end":"2026-04-16T16:32:30.8145Z","steps":["trace[833716242] 'agreement among raft nodes before linearized reading' (duration: 992.244762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:30.81456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:29.822026Z","time spent":"992.525049ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T16:32:30.814635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.018383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:32:30.814701Z","caller":"traceutil/trace.go:171","msg":"trace[1874475944] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:978; }","duration":"911.153096ms","start":"2026-04-16T16:32:29.903532Z","end":"2026-04-16T16:32:30.814685Z","steps":["trace[1874475944] 'agreement among raft nodes before linearized reading' (duration: 910.921021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:30.814707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.504568ms","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-16T16:32:30.814741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:29.903523Z","time spent":"911.208747ms","remote":"127.0.0.1:33686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"info","ts":"2026-04-16T16:32:30.814749Z","caller":"traceutil/trace.go:171","msg":"trace[1046044553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:978; }","duration":"992.570119ms","start":"2026-04-16T16:32:29.822167Z","end":"2026-04-16T16:32:30.814737Z","steps":["trace[1046044553] 'agreement among raft nodes before linearized reading' (duration: 992.419876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:30.814776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:29.822148Z","time spent":"992.622251ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-16T16:32:30.894677Z","caller":"traceutil/trace.go:171","msg":"trace[1557218986] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"109.346283ms","start":"2026-04-16T16:32:30.785292Z","end":"2026-04-16T16:32:30.894639Z","steps":["trace[1557218986] 'process raft request' (duration: 102.913836ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:52.118131Z","caller":"traceutil/trace.go:171","msg":"trace[1545940505] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"292.938492ms","start":"2026-04-16T16:32:51.825112Z","end":"2026-04-16T16:32:52.118051Z","steps":["trace[1545940505] 'process raft request' (duration: 292.787618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:52.902398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.503643ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-16T16:32:52.902501Z","caller":"traceutil/trace.go:171","msg":"trace[1109428113] linearizableReadLoop","detail":"{readStateIndex:1090; appliedIndex:1089; }","duration":"450.410763ms","start":"2026-04-16T16:32:52.452073Z","end":"2026-04-16T16:32:52.902484Z","steps":["trace[1109428113] 'read index received' (duration: 37.766277ms)","trace[1109428113] 'applied index is now lower than readState.Index' (duration: 412.643026ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:52.902701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.604438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T16:32:52.902751Z","caller":"traceutil/trace.go:171","msg":"trace[1102096805] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1049; }","duration":"450.701169ms","start":"2026-04-16T16:32:52.452036Z","end":"2026-04-16T16:32:52.902737Z","steps":["trace[1102096805] 'agreement among raft nodes before linearized reading' (duration: 450.593447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:52.902844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:52.452015Z","time spent":"450.776281ms","remote":"127.0.0.1:59750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":3,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:32:52.94081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.867334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:32:52.941007Z","caller":"traceutil/trace.go:171","msg":"trace[2067777432] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1050; }","duration":"397.019388ms","start":"2026-04-16T16:32:52.543897Z","end":"2026-04-16T16:32:52.940916Z","steps":["trace[2067777432] 'agreement among raft nodes before linearized reading' (duration: 396.850334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:52.94109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:52.543878Z","time spent":"397.203392ms","remote":"127.0.0.1:33492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T16:32:53.092015Z","caller":"traceutil/trace.go:171","msg":"trace[1503281164] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"100.963587ms","start":"2026-04-16T16:32:52.991001Z","end":"2026-04-16T16:32:53.091965Z","steps":["trace[1503281164] 'process raft request' (duration: 46.526058ms)","trace[1503281164] 'compare' (duration: 54.184003ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:32:54.674943Z","caller":"traceutil/trace.go:171","msg":"trace[2022707300] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1095; }","duration":"130.7724ms","start":"2026-04-16T16:32:54.544145Z","end":"2026-04-16T16:32:54.674917Z","steps":["trace[2022707300] 'read index received' (duration: 130.638737ms)","trace[2022707300] 'applied index is now lower than readState.Index' (duration: 132.553µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:32:54.675001Z","caller":"traceutil/trace.go:171","msg":"trace[1581083180] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"547.052042ms","start":"2026-04-16T16:32:54.127921Z","end":"2026-04-16T16:32:54.674974Z","steps":["trace[1581083180] 'process raft request' (duration: 546.832637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:54.675129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.970205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:32:54.675166Z","caller":"traceutil/trace.go:171","msg":"trace[846407469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1055; }","duration":"131.068477ms","start":"2026-04-16T16:32:54.544087Z","end":"2026-04-16T16:32:54.675156Z","steps":["trace[846407469] 'agreement among raft nodes before linearized reading' (duration: 130.985915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:54.675189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:54.12788Z","time spent":"547.224476ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:32:57.465785Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":262226475746420967,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T16:32:57.616508Z","caller":"traceutil/trace.go:171","msg":"trace[481935452] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"918.604795ms","start":"2026-04-16T16:32:56.697876Z","end":"2026-04-16T16:32:57.616481Z","steps":["trace[481935452] 'process raft request' (duration: 888.7289ms)","trace[481935452] 'compare' (duration: 29.769273ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:57.616667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:56.697844Z","time spent":"918.735579ms","remote":"127.0.0.1:33514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:32:57.886202Z","caller":"traceutil/trace.go:171","msg":"trace[1793265666] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"1.185305965s","start":"2026-04-16T16:32:56.700867Z","end":"2026-04-16T16:32:57.886173Z","steps":["trace[1793265666] 'process raft request' (duration: 1.16502066s)","trace[1793265666] 'compare' (duration: 20.06656ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:32:57.886371Z","caller":"traceutil/trace.go:171","msg":"trace[1650464649] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1102; }","duration":"921.349739ms","start":"2026-04-16T16:32:56.96499Z","end":"2026-04-16T16:32:57.88634Z","steps":["trace[1650464649] 'read index received' (duration: 621.642862ms)","trace[1650464649] 'applied index is now lower than readState.Index' (duration: 299.704507ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:32:57.886511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:56.700845Z","time spent":"1.185507729s","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:32:57.886587Z","caller":"traceutil/trace.go:171","msg":"trace[116461351] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"870.285927ms","start":"2026-04-16T16:32:57.016276Z","end":"2026-04-16T16:32:57.886562Z","steps":["trace[116461351] 'process raft request' (duration: 869.848157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.886619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.597984ms","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":"warn","ts":"2026-04-16T16:32:57.886775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:57.016258Z","time spent":"870.426431ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:32:57.886825Z","caller":"traceutil/trace.go:171","msg":"trace[495790192] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1063; }","duration":"921.859101ms","start":"2026-04-16T16:32:56.964948Z","end":"2026-04-16T16:32:57.886807Z","steps":["trace[495790192] 'agreement among raft nodes before linearized reading' (duration: 921.590084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.886884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:56.964921Z","time spent":"921.949842ms","remote":"127.0.0.1:33902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:32:57.897463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.702396ms","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-16T16:32:57.897508Z","caller":"traceutil/trace.go:171","msg":"trace[1634694810] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1064; }","duration":"829.796608ms","start":"2026-04-16T16:32:57.0677Z","end":"2026-04-16T16:32:57.897497Z","steps":["trace[1634694810] 'agreement among raft nodes before linearized reading' (duration: 829.714236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.89751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.343177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:32:57.897534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:57.067672Z","time spent":"829.85515ms","remote":"127.0.0.1:55516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-04-16T16:32:57.897552Z","caller":"traceutil/trace.go:171","msg":"trace[1945004871] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1064; }","duration":"380.49653ms","start":"2026-04-16T16:32:57.517045Z","end":"2026-04-16T16:32:57.897542Z","steps":["trace[1945004871] 'agreement among raft nodes before linearized reading' (duration: 380.397578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.897605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:57.516993Z","time spent":"380.603742ms","remote":"127.0.0.1:55420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-16T16:32:57.897784Z","caller":"traceutil/trace.go:171","msg":"trace[1747047659] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"280.141377ms","start":"2026-04-16T16:32:57.617633Z","end":"2026-04-16T16:32:57.897774Z","steps":["trace[1747047659] 'process raft request' (duration: 279.686407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.897761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.277984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-16T16:32:57.897787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.934021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-16T16:32:57.897857Z","caller":"traceutil/trace.go:171","msg":"trace[1849405346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1064; }","duration":"716.430638ms","start":"2026-04-16T16:32:57.181405Z","end":"2026-04-16T16:32:57.897836Z","steps":["trace[1849405346] 'agreement among raft nodes before linearized reading' (duration: 716.156472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.897926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:57.181394Z","time spent":"716.52444ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-16T16:32:57.898013Z","caller":"traceutil/trace.go:171","msg":"trace[299239611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1064; }","duration":"745.106495ms","start":"2026-04-16T16:32:57.152782Z","end":"2026-04-16T16:32:57.897888Z","steps":["trace[299239611] 'agreement among raft nodes before linearized reading' (duration: 744.686785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.898023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.618812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-16T16:32:57.898058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.028196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:32:57.89808Z","caller":"traceutil/trace.go:171","msg":"trace[1513577436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1064; }","duration":"355.091157ms","start":"2026-04-16T16:32:57.542982Z","end":"2026-04-16T16:32:57.898073Z","steps":["trace[1513577436] 'agreement among raft nodes before linearized reading' (duration: 355.063487ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:32:57.89808Z","caller":"traceutil/trace.go:171","msg":"trace[1859466026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1064; }","duration":"716.676733ms","start":"2026-04-16T16:32:57.181395Z","end":"2026-04-16T16:32:57.898072Z","steps":["trace[1859466026] 'agreement among raft nodes before linearized reading' (duration: 716.53563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.898099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:57.542957Z","time spent":"355.138239ms","remote":"127.0.0.1:33492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T16:32:57.89815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:57.15274Z","time spent":"745.369071ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T16:32:57.898105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:57.181336Z","time spent":"716.762995ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T16:32:57.898027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.758266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-04-16T16:32:57.898338Z","caller":"traceutil/trace.go:171","msg":"trace[1816886209] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1064; }","duration":"279.117144ms","start":"2026-04-16T16:32:57.619215Z","end":"2026-04-16T16:32:57.898332Z","steps":["trace[1816886209] 'agreement among raft nodes before linearized reading' (duration: 278.779046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.898566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.030639ms","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-16T16:32:57.898644Z","caller":"traceutil/trace.go:171","msg":"trace[1174043034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1064; }","duration":"784.171002ms","start":"2026-04-16T16:32:57.114455Z","end":"2026-04-16T16:32:57.898626Z","steps":["trace[1174043034] 'agreement among raft nodes before linearized reading' (duration: 783.324933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.899436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:57.114434Z","time spent":"784.99204ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T16:32:57.898348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.923083ms","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-16T16:32:57.899768Z","caller":"traceutil/trace.go:171","msg":"trace[549920471] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1064; }","duration":"777.449008ms","start":"2026-04-16T16:32:57.122297Z","end":"2026-04-16T16:32:57.899746Z","steps":["trace[549920471] 'agreement among raft nodes before linearized reading' (duration: 775.743289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:32:57.899842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:32:57.12228Z","time spent":"777.536479ms","remote":"127.0.0.1:33922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:33:08.318254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.85919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T16:33:08.318366Z","caller":"traceutil/trace.go:171","msg":"trace[506181418] linearizableReadLoop","detail":"{readStateIndex:1194; appliedIndex:1193; }","duration":"336.875309ms","start":"2026-04-16T16:33:07.981469Z","end":"2026-04-16T16:33:08.318345Z","steps":["trace[506181418] 'read index received' (duration: 199.845075ms)","trace[506181418] 'applied index is now lower than readState.Index' (duration: 137.029214ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:08.318477Z","caller":"traceutil/trace.go:171","msg":"trace[327940930] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"356.252504ms","start":"2026-04-16T16:33:07.962211Z","end":"2026-04-16T16:33:08.318463Z","steps":["trace[327940930] 'process raft request' (duration: 219.105627ms)","trace[327940930] 'compare' (duration: 136.750338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:33:08.318681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:07.962175Z","time spent":"356.334835ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:33:08.318738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.251678ms","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-16T16:33:08.318866Z","caller":"traceutil/trace.go:171","msg":"trace[1527955467] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1148; }","duration":"337.411361ms","start":"2026-04-16T16:33:07.981405Z","end":"2026-04-16T16:33:08.318816Z","steps":["trace[1527955467] 'agreement among raft nodes before linearized reading' (duration: 337.091514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:08.31896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:07.981368Z","time spent":"337.536534ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T16:33:08.369028Z","caller":"traceutil/trace.go:171","msg":"trace[616350241] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"284.902607ms","start":"2026-04-16T16:33:08.084099Z","end":"2026-04-16T16:33:08.369002Z","steps":["trace[616350241] 'process raft request' (duration: 284.742533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:08.369205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.728571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T16:33:08.369288Z","caller":"traceutil/trace.go:171","msg":"trace[1313442413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1149; }","duration":"324.887955ms","start":"2026-04-16T16:33:08.044381Z","end":"2026-04-16T16:33:08.369269Z","steps":["trace[1313442413] 'agreement among raft nodes before linearized reading' (duration: 324.627539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:08.36933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:08.044365Z","time spent":"324.957776ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:08.369287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.370743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-16T16:33:08.369399Z","caller":"traceutil/trace.go:171","msg":"trace[1560676290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1149; }","duration":"324.490656ms","start":"2026-04-16T16:33:08.044898Z","end":"2026-04-16T16:33:08.369389Z","steps":["trace[1560676290] 'agreement among raft nodes before linearized reading' (duration: 324.323512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:08.369426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:08.044893Z","time spent":"324.525776ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:08.369411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.4163ms","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-16T16:33:08.369505Z","caller":"traceutil/trace.go:171","msg":"trace[309758759] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1149; }","duration":"323.532894ms","start":"2026-04-16T16:33:08.045952Z","end":"2026-04-16T16:33:08.369485Z","steps":["trace[309758759] 'agreement among raft nodes before linearized reading' (duration: 323.247207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:08.369554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:08.045948Z","time spent":"323.595315ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-16T16:33:10.438191Z","caller":"traceutil/trace.go:171","msg":"trace[1383745384] linearizableReadLoop","detail":"{readStateIndex:1200; appliedIndex:1199; }","duration":"114.898386ms","start":"2026-04-16T16:33:10.323275Z","end":"2026-04-16T16:33:10.438173Z","steps":["trace[1383745384] 'read index received' (duration: 114.740953ms)","trace[1383745384] 'applied index is now lower than readState.Index' (duration: 156.653µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:10.438381Z","caller":"traceutil/trace.go:171","msg":"trace[391421134] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"476.35223ms","start":"2026-04-16T16:33:09.96202Z","end":"2026-04-16T16:33:10.438372Z","steps":["trace[391421134] 'process raft request' (duration: 476.050123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:10.438462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:09.961994Z","time spent":"476.414121ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:33:10.438654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.378367ms","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-16T16:33:10.438682Z","caller":"traceutil/trace.go:171","msg":"trace[2127413002] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1154; }","duration":"115.444459ms","start":"2026-04-16T16:33:10.323231Z","end":"2026-04-16T16:33:10.438675Z","steps":["trace[2127413002] 'agreement among raft nodes before linearized reading' (duration: 115.353117ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:11.170988Z","caller":"traceutil/trace.go:171","msg":"trace[1042289395] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"728.641567ms","start":"2026-04-16T16:33:10.442304Z","end":"2026-04-16T16:33:11.170946Z","steps":["trace[1042289395] 'process raft request' (duration: 700.817658ms)","trace[1042289395] 'compare' (duration: 27.4336ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:33:11.171187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:10.442276Z","time spent":"728.801091ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:33:11.192235Z","caller":"traceutil/trace.go:171","msg":"trace[1796845465] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"748.209936ms","start":"2026-04-16T16:33:10.444003Z","end":"2026-04-16T16:33:11.192213Z","steps":["trace[1796845465] 'process raft request' (duration: 748.155674ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:11.192249Z","caller":"traceutil/trace.go:171","msg":"trace[730379949] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"749.326842ms","start":"2026-04-16T16:33:10.442892Z","end":"2026-04-16T16:33:11.192219Z","steps":["trace[730379949] 'process raft request' (duration: 749.115417ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:11.19233Z","caller":"traceutil/trace.go:171","msg":"trace[1790343354] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"749.378492ms","start":"2026-04-16T16:33:10.442902Z","end":"2026-04-16T16:33:11.192281Z","steps":["trace[1790343354] 'process raft request' (duration: 749.208818ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:11.192407Z","caller":"traceutil/trace.go:171","msg":"trace[486792327] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"747.794096ms","start":"2026-04-16T16:33:10.4446Z","end":"2026-04-16T16:33:11.192394Z","steps":["trace[486792327] 'process raft request' (duration: 747.583701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:11.19247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:10.444585Z","time spent":"747.850908ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:33:11.1924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:10.443996Z","time spent":"748.311568ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:33:11.192535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:10.442887Z","time spent":"749.561107ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:33:11.19256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:10.44288Z","time spent":"749.436534ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:33:26.306346Z","caller":"traceutil/trace.go:171","msg":"trace[843253848] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"434.948689ms","start":"2026-04-16T16:33:25.871361Z","end":"2026-04-16T16:33:26.30631Z","steps":["trace[843253848] 'process raft request' (duration: 434.792926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:26.306522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:25.87135Z","time spent":"435.078422ms","remote":"127.0.0.1:33654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:33:26.637173Z","caller":"traceutil/trace.go:171","msg":"trace[163405530] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"322.301915ms","start":"2026-04-16T16:33:26.314842Z","end":"2026-04-16T16:33:26.637144Z","steps":["trace[163405530] 'process raft request' (duration: 322.105591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:26.637438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:26.314825Z","time spent":"322.432198ms","remote":"127.0.0.1:33866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":797,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:33:26.643446Z","caller":"traceutil/trace.go:171","msg":"trace[102754317] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"321.831615ms","start":"2026-04-16T16:33:26.321604Z","end":"2026-04-16T16:33:26.643436Z","steps":["trace[102754317] 'process raft request' (duration: 321.734682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:26.643541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:26.321554Z","time spent":"321.956367ms","remote":"127.0.0.1:33658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11375,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:33:26.643617Z","caller":"traceutil/trace.go:171","msg":"trace[1670847502] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1269; }","duration":"100.125667ms","start":"2026-04-16T16:33:26.543467Z","end":"2026-04-16T16:33:26.643592Z","steps":["trace[1670847502] 'read index received' (duration: 93.490775ms)","trace[1670847502] 'applied index is now lower than readState.Index' (duration: 6.632862ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:26.643702Z","caller":"traceutil/trace.go:171","msg":"trace[748850843] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"118.716564ms","start":"2026-04-16T16:33:26.524963Z","end":"2026-04-16T16:33:26.64368Z","steps":["trace[748850843] 'process raft request' (duration: 118.440238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:26.643759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.27886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:33:26.644088Z","caller":"traceutil/trace.go:171","msg":"trace[2147199346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1223; }","duration":"100.572447ms","start":"2026-04-16T16:33:26.543453Z","end":"2026-04-16T16:33:26.644026Z","steps":["trace[2147199346] 'agreement among raft nodes before linearized reading' (duration: 100.237589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:29.367296Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":262226475746421349,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T16:33:29.594662Z","caller":"traceutil/trace.go:171","msg":"trace[1101783385] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"944.405508ms","start":"2026-04-16T16:33:28.650231Z","end":"2026-04-16T16:33:29.594636Z","steps":["trace[1101783385] 'process raft request' (duration: 944.246715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:29.594818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:28.650201Z","time spent":"944.541452ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:33:29.82628Z","caller":"traceutil/trace.go:171","msg":"trace[303856493] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"959.281409ms","start":"2026-04-16T16:33:28.866974Z","end":"2026-04-16T16:33:29.826255Z","steps":["trace[303856493] 'read index received' (duration: 728.394782ms)","trace[303856493] 'applied index is now lower than readState.Index' (duration: 230.885547ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:29.826413Z","caller":"traceutil/trace.go:171","msg":"trace[255893420] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"952.149606ms","start":"2026-04-16T16:33:28.874251Z","end":"2026-04-16T16:33:29.826401Z","steps":["trace[255893420] 'process raft request' (duration: 951.822478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:29.826516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:28.874231Z","time spent":"952.208658ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:33:29.826724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.243833ms","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-16T16:33:29.826812Z","caller":"traceutil/trace.go:171","msg":"trace[727921060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1241; }","duration":"529.338365ms","start":"2026-04-16T16:33:29.297456Z","end":"2026-04-16T16:33:29.826794Z","steps":["trace[727921060] 'agreement among raft nodes before linearized reading' (duration: 529.14289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:29.826856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:29.297383Z","time spent":"529.465608ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T16:33:29.827011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.021716ms","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-16T16:33:29.827068Z","caller":"traceutil/trace.go:171","msg":"trace[2024889896] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1241; }","duration":"960.127489ms","start":"2026-04-16T16:33:28.866928Z","end":"2026-04-16T16:33:29.827056Z","steps":["trace[2024889896] 'agreement among raft nodes before linearized reading' (duration: 960.031807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:29.827106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:28.866906Z","time spent":"960.19138ms","remote":"127.0.0.1:55398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-16T16:33:29.827219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.928595ms","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-16T16:33:29.827272Z","caller":"traceutil/trace.go:171","msg":"trace[1043212738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1241; }","duration":"522.004266ms","start":"2026-04-16T16:33:29.305257Z","end":"2026-04-16T16:33:29.827261Z","steps":["trace[1043212738] 'agreement among raft nodes before linearized reading' (duration: 521.857763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:29.827307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:29.305246Z","time spent":"522.051668ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:29.827448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.95822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-16T16:33:29.827448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.5429ms","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-16T16:33:29.827485Z","caller":"traceutil/trace.go:171","msg":"trace[823198467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1241; }","duration":"520.00572ms","start":"2026-04-16T16:33:29.307467Z","end":"2026-04-16T16:33:29.827473Z","steps":["trace[823198467] 'agreement among raft nodes before linearized reading' (duration: 519.924858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:29.827512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:29.307459Z","time spent":"520.047162ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:29.82751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.288285ms","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-16T16:33:29.82752Z","caller":"traceutil/trace.go:171","msg":"trace[575436889] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1241; }","duration":"529.646992ms","start":"2026-04-16T16:33:29.297855Z","end":"2026-04-16T16:33:29.827502Z","steps":["trace[575436889] 'agreement among raft nodes before linearized reading' (duration: 529.388656ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:29.827553Z","caller":"traceutil/trace.go:171","msg":"trace[955584248] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1241; }","duration":"526.361497ms","start":"2026-04-16T16:33:29.301181Z","end":"2026-04-16T16:33:29.827542Z","steps":["trace[955584248] 'agreement among raft nodes before linearized reading' (duration: 526.250644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:29.827562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:29.297845Z","time spent":"529.708973ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:29.827582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:29.30117Z","time spent":"526.405898ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T16:33:30.071528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.391557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:33:30.071604Z","caller":"traceutil/trace.go:171","msg":"trace[996158750] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1246; }","duration":"142.52181ms","start":"2026-04-16T16:33:29.929067Z","end":"2026-04-16T16:33:30.071588Z","steps":["trace[996158750] 'count revisions from in-memory index tree' (duration: 142.308015ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:32.290917Z","caller":"traceutil/trace.go:171","msg":"trace[358312394] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"430.822103ms","start":"2026-04-16T16:33:31.860066Z","end":"2026-04-16T16:33:32.290888Z","steps":["trace[358312394] 'read index received' (duration: 430.757762ms)","trace[358312394] 'applied index is now lower than readState.Index' (duration: 62.651µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:32.290968Z","caller":"traceutil/trace.go:171","msg":"trace[801915907] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"690.824289ms","start":"2026-04-16T16:33:31.600117Z","end":"2026-04-16T16:33:32.290941Z","steps":["trace[801915907] 'process raft request' (duration: 690.438121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:32.291087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:31.600098Z","time spent":"690.928721ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:33:32.291188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.096409ms","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-16T16:33:32.291225Z","caller":"traceutil/trace.go:171","msg":"trace[297813708] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1247; }","duration":"431.257174ms","start":"2026-04-16T16:33:31.859957Z","end":"2026-04-16T16:33:32.291214Z","steps":["trace[297813708] 'agreement among raft nodes before linearized reading' (duration: 431.057099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:32.291267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:31.859937Z","time spent":"431.321125ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-16T16:33:32.306003Z","caller":"traceutil/trace.go:171","msg":"trace[1101943448] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"370.98591ms","start":"2026-04-16T16:33:31.93499Z","end":"2026-04-16T16:33:32.305976Z","steps":["trace[1101943448] 'process raft request' (duration: 370.791866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:32.306213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:31.934942Z","time spent":"371.134444ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:33:32.398589Z","caller":"traceutil/trace.go:171","msg":"trace[264083597] linearizableReadLoop","detail":"{readStateIndex:1299; appliedIndex:1297; }","duration":"107.574098ms","start":"2026-04-16T16:33:32.29099Z","end":"2026-04-16T16:33:32.398564Z","steps":["trace[264083597] 'read index received' (duration: 14.794479ms)","trace[264083597] 'applied index is now lower than readState.Index' (duration: 92.778489ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:33:32.398974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.347914ms","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-16T16:33:32.399022Z","caller":"traceutil/trace.go:171","msg":"trace[1583162686] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1248; }","duration":"513.06229ms","start":"2026-04-16T16:33:31.885949Z","end":"2026-04-16T16:33:32.399011Z","steps":["trace[1583162686] 'agreement among raft nodes before linearized reading' (duration: 512.752923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:32.399131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:31.885937Z","time spent":"513.182203ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T16:33:32.399405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.204317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:33:32.399443Z","caller":"traceutil/trace.go:171","msg":"trace[1181673485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1248; }","duration":"514.261638ms","start":"2026-04-16T16:33:31.885172Z","end":"2026-04-16T16:33:32.399434Z","steps":["trace[1181673485] 'agreement among raft nodes before linearized reading' (duration: 514.163575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:32.399473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:31.885164Z","time spent":"514.302788ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:32.39973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.680287ms","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-16T16:33:32.399769Z","caller":"traceutil/trace.go:171","msg":"trace[1572554864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1248; }","duration":"514.741599ms","start":"2026-04-16T16:33:31.885019Z","end":"2026-04-16T16:33:32.39976Z","steps":["trace[1572554864] 'agreement among raft nodes before linearized reading' (duration: 514.643557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:32.399799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:31.885009Z","time spent":"514.78437ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:32.400069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.122728ms","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-16T16:33:32.400107Z","caller":"traceutil/trace.go:171","msg":"trace[1383559208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1248; }","duration":"515.200299ms","start":"2026-04-16T16:33:31.884898Z","end":"2026-04-16T16:33:32.400098Z","steps":["trace[1383559208] 'agreement among raft nodes before linearized reading' (duration: 515.109577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:32.400136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:31.884871Z","time spent":"515.258721ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-16T16:33:32.401256Z","caller":"traceutil/trace.go:171","msg":"trace[891075394] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"106.501893ms","start":"2026-04-16T16:33:32.294741Z","end":"2026-04-16T16:33:32.401242Z","steps":["trace[891075394] 'process raft request' (duration: 103.715039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:33.239518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.708331ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T16:33:33.239604Z","caller":"traceutil/trace.go:171","msg":"trace[247374534] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"467.109837ms","start":"2026-04-16T16:33:32.772478Z","end":"2026-04-16T16:33:33.239588Z","steps":["trace[247374534] 'process raft request' (duration: 281.273733ms)","trace[247374534] 'compare' (duration: 185.469335ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:33:33.239644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:32.772471Z","time spent":"467.155729ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:33:36.783115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.30464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.185\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T16:33:36.783194Z","caller":"traceutil/trace.go:171","msg":"trace[516366577] range","detail":"{range_begin:/registry/masterleases/199.19.213.185; range_end:; response_count:1; response_revision:1282; }","duration":"110.442363ms","start":"2026-04-16T16:33:36.672734Z","end":"2026-04-16T16:33:36.783176Z","steps":["trace[516366577] 'range keys from in-memory index tree' (duration: 110.061115ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:37.006598Z","caller":"traceutil/trace.go:171","msg":"trace[1458735376] linearizableReadLoop","detail":"{readStateIndex:1337; appliedIndex:1336; }","duration":"118.463119ms","start":"2026-04-16T16:33:36.888094Z","end":"2026-04-16T16:33:37.006557Z","steps":["trace[1458735376] 'read index received' (duration: 71.377798ms)","trace[1458735376] 'applied index is now lower than readState.Index' (duration: 47.083341ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:37.006604Z","caller":"traceutil/trace.go:171","msg":"trace[870375987] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"132.405338ms","start":"2026-04-16T16:33:36.874167Z","end":"2026-04-16T16:33:37.006572Z","steps":["trace[870375987] 'process raft request' (duration: 85.371128ms)","trace[870375987] 'compare' (duration: 46.754524ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:33:37.006752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.641653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:33:37.006834Z","caller":"traceutil/trace.go:171","msg":"trace[1225706829] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1285; }","duration":"118.759566ms","start":"2026-04-16T16:33:36.888053Z","end":"2026-04-16T16:33:37.006813Z","steps":["trace[1225706829] 'agreement among raft nodes before linearized reading' (duration: 118.604422ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:38.5602Z","caller":"traceutil/trace.go:171","msg":"trace[1352569498] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"100.937966ms","start":"2026-04-16T16:33:38.459224Z","end":"2026-04-16T16:33:38.560162Z","steps":["trace[1352569498] 'process raft request' (duration: 73.717541ms)","trace[1352569498] 'compare' (duration: 26.956549ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:40.203097Z","caller":"traceutil/trace.go:171","msg":"trace[856873554] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"147.224929ms","start":"2026-04-16T16:33:40.055839Z","end":"2026-04-16T16:33:40.203064Z","steps":["trace[856873554] 'read index received' (duration: 146.972133ms)","trace[856873554] 'applied index is now lower than readState.Index' (duration: 251.586µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:40.203931Z","caller":"traceutil/trace.go:171","msg":"trace[1399116554] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"219.825717ms","start":"2026-04-16T16:33:39.984052Z","end":"2026-04-16T16:33:40.203878Z","steps":["trace[1399116554] 'process raft request' (duration: 218.751742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:40.204185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.312045ms","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-16T16:33:40.204275Z","caller":"traceutil/trace.go:171","msg":"trace[1290110861] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1311; }","duration":"148.478738ms","start":"2026-04-16T16:33:40.055777Z","end":"2026-04-16T16:33:40.204256Z","steps":["trace[1290110861] 'agreement among raft nodes before linearized reading' (duration: 147.423164ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:40.661551Z","caller":"traceutil/trace.go:171","msg":"trace[112653654] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"201.545585ms","start":"2026-04-16T16:33:40.45998Z","end":"2026-04-16T16:33:40.661526Z","steps":["trace[112653654] 'read index received' (duration: 148.58416ms)","trace[112653654] 'applied index is now lower than readState.Index' (duration: 52.959875ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:40.661667Z","caller":"traceutil/trace.go:171","msg":"trace[22647082] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"253.921487ms","start":"2026-04-16T16:33:40.407704Z","end":"2026-04-16T16:33:40.661626Z","steps":["trace[22647082] 'process raft request' (duration: 200.787738ms)","trace[22647082] 'compare' (duration: 52.865343ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:33:40.661785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.218012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:33:40.661818Z","caller":"traceutil/trace.go:171","msg":"trace[1081056485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1313; }","duration":"118.304944ms","start":"2026-04-16T16:33:40.543505Z","end":"2026-04-16T16:33:40.66181Z","steps":["trace[1081056485] 'agreement among raft nodes before linearized reading' (duration: 118.209522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:40.661833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.855592ms","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-16T16:33:40.661909Z","caller":"traceutil/trace.go:171","msg":"trace[1544244476] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1313; }","duration":"201.985865ms","start":"2026-04-16T16:33:40.459906Z","end":"2026-04-16T16:33:40.661892Z","steps":["trace[1544244476] 'agreement among raft nodes before linearized reading' (duration: 201.77084ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:40.802619Z","caller":"traceutil/trace.go:171","msg":"trace[1806903727] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"135.283374ms","start":"2026-04-16T16:33:40.667313Z","end":"2026-04-16T16:33:40.802596Z","steps":["trace[1806903727] 'process raft request' (duration: 113.597216ms)","trace[1806903727] 'compare' (duration: 21.540705ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:40.80304Z","caller":"traceutil/trace.go:171","msg":"trace[1393788803] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"135.648812ms","start":"2026-04-16T16:33:40.667383Z","end":"2026-04-16T16:33:40.803032Z","steps":["trace[1393788803] 'process raft request' (duration: 135.183851ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:40.803075Z","caller":"traceutil/trace.go:171","msg":"trace[1764714914] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"135.615831ms","start":"2026-04-16T16:33:40.667451Z","end":"2026-04-16T16:33:40.803067Z","steps":["trace[1764714914] 'process raft request' (duration: 135.354055ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:40.803017Z","caller":"traceutil/trace.go:171","msg":"trace[1333756821] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"135.505469ms","start":"2026-04-16T16:33:40.667487Z","end":"2026-04-16T16:33:40.802993Z","steps":["trace[1333756821] 'process raft request' (duration: 135.421227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.278247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.967852228s","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:530"} {"level":"warn","ts":"2026-04-16T16:33:43.278275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.812609434s","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-16T16:33:43.278343Z","caller":"traceutil/trace.go:171","msg":"trace[539347954] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1318; }","duration":"1.968000232s","start":"2026-04-16T16:33:41.310321Z","end":"2026-04-16T16:33:43.278322Z","steps":["trace[539347954] 'range keys from in-memory index tree' (duration: 1.967640783s)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:43.278386Z","caller":"traceutil/trace.go:171","msg":"trace[228437619] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1318; }","duration":"1.812735027s","start":"2026-04-16T16:33:41.465633Z","end":"2026-04-16T16:33:43.278368Z","steps":["trace[228437619] 'range keys from in-memory index tree' (duration: 1.812593744s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.278386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:41.310291Z","time spent":"1.968085523s","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-16T16:33:43.463794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.193793028s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-16T16:33:43.463965Z","caller":"traceutil/trace.go:171","msg":"trace[1541307695] linearizableReadLoop","detail":"{readStateIndex:1371; appliedIndex:1370; }","duration":"1.370769078s","start":"2026-04-16T16:33:42.093182Z","end":"2026-04-16T16:33:43.463952Z","steps":["trace[1541307695] 'read index received' (duration: 176.873938ms)","trace[1541307695] 'applied index is now lower than readState.Index' (duration: 1.19389432s)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:43.464635Z","caller":"traceutil/trace.go:171","msg":"trace[1804963092] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"854.035564ms","start":"2026-04-16T16:33:42.610589Z","end":"2026-04-16T16:33:43.464625Z","steps":["trace[1804963092] 'process raft request' (duration: 853.289287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.464739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.610565Z","time spent":"854.102255ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:33:43.483962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.390720416s","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:525"} {"level":"info","ts":"2026-04-16T16:33:43.484062Z","caller":"traceutil/trace.go:171","msg":"trace[1336478478] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1319; }","duration":"1.390892119s","start":"2026-04-16T16:33:42.093141Z","end":"2026-04-16T16:33:43.484033Z","steps":["trace[1336478478] 'agreement among raft nodes before linearized reading' (duration: 1.371177847s)","trace[1336478478] 'range keys from in-memory index tree' (duration: 19.449316ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:33:43.48426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.093121Z","time spent":"1.391120565s","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":547,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-16T16:33:43.484391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.235087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-16T16:33:43.484429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.545056ms","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:508"} {"level":"warn","ts":"2026-04-16T16:33:43.484433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.848221ms","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-16T16:33:43.48445Z","caller":"traceutil/trace.go:171","msg":"trace[1341123950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1321; }","duration":"789.347559ms","start":"2026-04-16T16:33:42.695089Z","end":"2026-04-16T16:33:43.484437Z","steps":["trace[1341123950] 'agreement among raft nodes before linearized reading' (duration: 789.136625ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:43.484101Z","caller":"traceutil/trace.go:171","msg":"trace[1178365554] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"815.682774ms","start":"2026-04-16T16:33:42.668376Z","end":"2026-04-16T16:33:43.484059Z","steps":["trace[1178365554] 'process raft request' (duration: 796.240988ms)","trace[1178365554] 'compare' (duration: 19.19318ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:43.484463Z","caller":"traceutil/trace.go:171","msg":"trace[1975298130] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1321; }","duration":"191.611307ms","start":"2026-04-16T16:33:43.292841Z","end":"2026-04-16T16:33:43.484452Z","steps":["trace[1975298130] 'agreement among raft nodes before linearized reading' (duration: 191.489914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.484488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.694991Z","time spent":"789.484552ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T16:33:43.484517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.243744ms","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-16T16:33:43.484582Z","caller":"traceutil/trace.go:171","msg":"trace[30552981] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1321; }","duration":"312.326085ms","start":"2026-04-16T16:33:43.172242Z","end":"2026-04-16T16:33:43.484568Z","steps":["trace[30552981] 'agreement among raft nodes before linearized reading' (duration: 312.246744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.484627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.432855ms","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-16T16:33:43.484557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.668359Z","time spent":"816.137224ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:33:43.484661Z","caller":"traceutil/trace.go:171","msg":"trace[1032494472] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"201.974245ms","start":"2026-04-16T16:33:43.282675Z","end":"2026-04-16T16:33:43.48465Z","steps":["trace[1032494472] 'process raft request' (duration: 201.29947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.484727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.708251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:33:43.48476Z","caller":"traceutil/trace.go:171","msg":"trace[1992829956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"678.763732ms","start":"2026-04-16T16:33:42.805989Z","end":"2026-04-16T16:33:43.484753Z","steps":["trace[1992829956] 'agreement among raft nodes before linearized reading' (duration: 678.68763ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:43.484662Z","caller":"traceutil/trace.go:171","msg":"trace[869762902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1321; }","duration":"678.474375ms","start":"2026-04-16T16:33:42.806179Z","end":"2026-04-16T16:33:43.484653Z","steps":["trace[869762902] 'agreement among raft nodes before linearized reading' (duration: 678.391853ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:43.484472Z","caller":"traceutil/trace.go:171","msg":"trace[1503814079] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1321; }","duration":"677.894212ms","start":"2026-04-16T16:33:42.806569Z","end":"2026-04-16T16:33:43.484463Z","steps":["trace[1503814079] 'agreement among raft nodes before linearized reading' (duration: 677.705838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.484785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.805973Z","time spent":"678.806033ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:43.4848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.806175Z","time spent":"678.613859ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:43.484839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.234049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-16T16:33:43.484665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:43.172216Z","time spent":"312.436038ms","remote":"127.0.0.1:55374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"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-16T16:33:43.484862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.282377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:33:43.484859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.806565Z","time spent":"678.280271ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T16:33:43.484887Z","caller":"traceutil/trace.go:171","msg":"trace[1512167595] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"942.326729ms","start":"2026-04-16T16:33:42.542552Z","end":"2026-04-16T16:33:43.484879Z","steps":["trace[1512167595] 'agreement among raft nodes before linearized reading' (duration: 942.288918ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:43.484876Z","caller":"traceutil/trace.go:171","msg":"trace[59857023] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1321; }","duration":"678.282581ms","start":"2026-04-16T16:33:42.806584Z","end":"2026-04-16T16:33:43.484867Z","steps":["trace[59857023] 'agreement among raft nodes before linearized reading' (duration: 678.107547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.484917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.542538Z","time spent":"942.373189ms","remote":"127.0.0.1:33490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T16:33:43.484933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.806582Z","time spent":"678.341993ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T16:33:43.485028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.889459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:33:43.485066Z","caller":"traceutil/trace.go:171","msg":"trace[280940735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"948.956941ms","start":"2026-04-16T16:33:42.536098Z","end":"2026-04-16T16:33:43.485055Z","steps":["trace[280940735] 'agreement among raft nodes before linearized reading' (duration: 948.899809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.485128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.536074Z","time spent":"949.045403ms","remote":"127.0.0.1:33492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T16:33:43.485381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.238618ms","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-16T16:33:43.487472Z","caller":"traceutil/trace.go:171","msg":"trace[235836206] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1321; }","duration":"992.340705ms","start":"2026-04-16T16:33:42.495093Z","end":"2026-04-16T16:33:43.487434Z","steps":["trace[235836206] 'agreement among raft nodes before linearized reading' (duration: 989.121801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:43.487602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:33:42.49507Z","time spent":"992.490439ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-16T16:33:47.645749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.048206ms","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-16T16:33:47.645832Z","caller":"traceutil/trace.go:171","msg":"trace[1761293648] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1339; }","duration":"131.64393ms","start":"2026-04-16T16:33:47.514166Z","end":"2026-04-16T16:33:47.64581Z","steps":["trace[1761293648] 'range keys from in-memory index tree' (duration: 130.875023ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:47.645881Z","caller":"traceutil/trace.go:171","msg":"trace[1520459030] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"131.671371ms","start":"2026-04-16T16:33:47.514185Z","end":"2026-04-16T16:33:47.645857Z","steps":["trace[1520459030] 'process raft request' (duration: 131.525727ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:47.647784Z","caller":"traceutil/trace.go:171","msg":"trace[136259974] linearizableReadLoop","detail":"{readStateIndex:1395; appliedIndex:1393; }","duration":"133.503823ms","start":"2026-04-16T16:33:47.514266Z","end":"2026-04-16T16:33:47.647769Z","steps":["trace[136259974] 'read index received' (duration: 131.472666ms)","trace[136259974] 'applied index is now lower than readState.Index' (duration: 2.030066ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:47.647992Z","caller":"traceutil/trace.go:171","msg":"trace[158425782] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"133.750008ms","start":"2026-04-16T16:33:47.51423Z","end":"2026-04-16T16:33:47.64798Z","steps":["trace[158425782] 'process raft request' (duration: 133.439921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:47.648635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.337832ms","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-16T16:33:47.648669Z","caller":"traceutil/trace.go:171","msg":"trace[422063492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1341; }","duration":"134.381863ms","start":"2026-04-16T16:33:47.514279Z","end":"2026-04-16T16:33:47.648661Z","steps":["trace[422063492] 'agreement among raft nodes before linearized reading' (duration: 134.290131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:47.648762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.293979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T16:33:47.648803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.405454ms","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-16T16:33:47.648822Z","caller":"traceutil/trace.go:171","msg":"trace[311552621] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1341; }","duration":"134.441175ms","start":"2026-04-16T16:33:47.514375Z","end":"2026-04-16T16:33:47.648816Z","steps":["trace[311552621] 'agreement among raft nodes before linearized reading' (duration: 134.388263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:33:47.648877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.610679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T16:33:47.648799Z","caller":"traceutil/trace.go:171","msg":"trace[668958097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1341; }","duration":"106.366961ms","start":"2026-04-16T16:33:47.542422Z","end":"2026-04-16T16:33:47.648789Z","steps":["trace[668958097] 'agreement among raft nodes before linearized reading' (duration: 106.30711ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:47.648906Z","caller":"traceutil/trace.go:171","msg":"trace[1300144673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1341; }","duration":"134.670099ms","start":"2026-04-16T16:33:47.514229Z","end":"2026-04-16T16:33:47.648899Z","steps":["trace[1300144673] 'agreement among raft nodes before linearized reading' (duration: 134.587738ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:55.829023Z","caller":"traceutil/trace.go:171","msg":"trace[684633111] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"118.825457ms","start":"2026-04-16T16:33:55.710157Z","end":"2026-04-16T16:33:55.828982Z","steps":["trace[684633111] 'process raft request' (duration: 48.697778ms)","trace[684633111] 'compare' (duration: 70.006086ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:33:55.846424Z","caller":"traceutil/trace.go:171","msg":"trace[484366636] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"135.824786ms","start":"2026-04-16T16:33:55.710559Z","end":"2026-04-16T16:33:55.846384Z","steps":["trace[484366636] 'process raft request' (duration: 135.503879ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:55.846355Z","caller":"traceutil/trace.go:171","msg":"trace[589146813] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"135.738085ms","start":"2026-04-16T16:33:55.710587Z","end":"2026-04-16T16:33:55.846326Z","steps":["trace[589146813] 'process raft request' (duration: 135.631312ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:55.84663Z","caller":"traceutil/trace.go:171","msg":"trace[1617301978] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"134.998377ms","start":"2026-04-16T16:33:55.711616Z","end":"2026-04-16T16:33:55.846614Z","steps":["trace[1617301978] 'process raft request' (duration: 134.929456ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:33:55.846773Z","caller":"traceutil/trace.go:171","msg":"trace[1618327926] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"135.298745ms","start":"2026-04-16T16:33:55.711371Z","end":"2026-04-16T16:33:55.84667Z","steps":["trace[1618327926] 'process raft request' (duration: 134.908756ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:34:50.915578Z","caller":"traceutil/trace.go:171","msg":"trace[239046443] transaction","detail":"{read_only:false; response_revision:1633; number_of_response:1; }","duration":"375.170659ms","start":"2026-04-16T16:34:50.540381Z","end":"2026-04-16T16:34:50.915551Z","steps":["trace[239046443] 'process raft request' (duration: 374.986445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:34:50.915735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:34:50.540356Z","time spent":"375.305723ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T16:34:56.427347Z","caller":"traceutil/trace.go:171","msg":"trace[351363221] linearizableReadLoop","detail":"{readStateIndex:1722; appliedIndex:1721; }","duration":"152.893251ms","start":"2026-04-16T16:34:56.274423Z","end":"2026-04-16T16:34:56.427316Z","steps":["trace[351363221] 'read index received' (duration: 152.718737ms)","trace[351363221] 'applied index is now lower than readState.Index' (duration: 173.464µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:34:56.427395Z","caller":"traceutil/trace.go:171","msg":"trace[1521115202] transaction","detail":"{read_only:false; response_revision:1655; number_of_response:1; }","duration":"305.613118ms","start":"2026-04-16T16:34:56.121737Z","end":"2026-04-16T16:34:56.42735Z","steps":["trace[1521115202] 'process raft request' (duration: 305.444944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:34:56.427572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.321823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-16T16:34:56.427582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T16:34:56.121712Z","time spent":"305.780222ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T16:34:56.427579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.154197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-16T16:34:56.427612Z","caller":"traceutil/trace.go:171","msg":"trace[1634001099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1655; }","duration":"137.458756ms","start":"2026-04-16T16:34:56.290143Z","end":"2026-04-16T16:34:56.427602Z","steps":["trace[1634001099] 'agreement among raft nodes before linearized reading' (duration: 137.302082ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:34:56.427633Z","caller":"traceutil/trace.go:171","msg":"trace[486775470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1655; }","duration":"153.26234ms","start":"2026-04-16T16:34:56.274356Z","end":"2026-04-16T16:34:56.427618Z","steps":["trace[486775470] 'agreement among raft nodes before linearized reading' (duration: 153.069336ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:35:42.170744Z","caller":"traceutil/trace.go:171","msg":"trace[761414558] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"128.927547ms","start":"2026-04-16T16:35:42.041796Z","end":"2026-04-16T16:35:42.170724Z","steps":["trace[761414558] 'process raft request' (duration: 128.697442ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:35:46.2785Z","caller":"traceutil/trace.go:171","msg":"trace[1000438427] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"107.171823ms","start":"2026-04-16T16:35:46.171307Z","end":"2026-04-16T16:35:46.278479Z","steps":["trace[1000438427] 'process raft request' (duration: 107.058161ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:36:21.058228Z","caller":"traceutil/trace.go:171","msg":"trace[1335231163] linearizableReadLoop","detail":"{readStateIndex:2128; appliedIndex:2126; }","duration":"146.542754ms","start":"2026-04-16T16:36:20.911644Z","end":"2026-04-16T16:36:21.058187Z","steps":["trace[1335231163] 'read index received' (duration: 20.491856ms)","trace[1335231163] 'applied index is now lower than readState.Index' (duration: 126.049207ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:36:21.05837Z","caller":"traceutil/trace.go:171","msg":"trace[757942094] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"152.256439ms","start":"2026-04-16T16:36:20.906081Z","end":"2026-04-16T16:36:21.058338Z","steps":["trace[757942094] 'process raft request' (duration: 75.655883ms)","trace[757942094] 'compare' (duration: 76.247598ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:36:21.058512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.240781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:36:21.058558Z","caller":"traceutil/trace.go:171","msg":"trace[1745574819] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:2044; }","duration":"123.353554ms","start":"2026-04-16T16:36:20.935193Z","end":"2026-04-16T16:36:21.058546Z","steps":["trace[1745574819] 'agreement among raft nodes before linearized reading' (duration: 123.224231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:36:21.058606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.929713ms","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-16T16:36:21.058708Z","caller":"traceutil/trace.go:171","msg":"trace[1035980665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2044; }","duration":"147.070926ms","start":"2026-04-16T16:36:20.911614Z","end":"2026-04-16T16:36:21.058685Z","steps":["trace[1035980665] 'agreement among raft nodes before linearized reading' (duration: 146.79363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:36:49.656275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.859425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:36:49.656369Z","caller":"traceutil/trace.go:171","msg":"trace[1838426348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2202; }","duration":"112.990718ms","start":"2026-04-16T16:36:49.543357Z","end":"2026-04-16T16:36:49.656348Z","steps":["trace[1838426348] 'range keys from in-memory index tree' (duration: 112.738823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:36:49.656464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.490294ms","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-16T16:36:49.656532Z","caller":"traceutil/trace.go:171","msg":"trace[1404586654] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2202; }","duration":"195.608107ms","start":"2026-04-16T16:36:49.460907Z","end":"2026-04-16T16:36:49.656515Z","steps":["trace[1404586654] 'count revisions from in-memory index tree' (duration: 195.410452ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:36:56.709494Z","caller":"traceutil/trace.go:171","msg":"trace[2013690048] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"240.189483ms","start":"2026-04-16T16:36:56.469278Z","end":"2026-04-16T16:36:56.709467Z","steps":["trace[2013690048] 'process raft request' (duration: 240.023029ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:36:56.716275Z","caller":"traceutil/trace.go:171","msg":"trace[893864559] linearizableReadLoop","detail":"{readStateIndex:2328; appliedIndex:2326; }","duration":"173.619006ms","start":"2026-04-16T16:36:56.542632Z","end":"2026-04-16T16:36:56.716251Z","steps":["trace[893864559] 'read index received' (duration: 166.64429ms)","trace[893864559] 'applied index is now lower than readState.Index' (duration: 6.973766ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T16:36:56.716411Z","caller":"traceutil/trace.go:171","msg":"trace[108001799] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"202.10709ms","start":"2026-04-16T16:36:56.514286Z","end":"2026-04-16T16:36:56.716393Z","steps":["trace[108001799] 'process raft request' (duration: 201.855004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:36:56.716503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.268535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:36:56.716575Z","caller":"traceutil/trace.go:171","msg":"trace[1121696388] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:2236; }","duration":"159.382778ms","start":"2026-04-16T16:36:56.557176Z","end":"2026-04-16T16:36:56.716558Z","steps":["trace[1121696388] 'agreement among raft nodes before linearized reading' (duration: 159.255735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:36:56.716649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.003404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T16:36:56.716731Z","caller":"traceutil/trace.go:171","msg":"trace[225789913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2236; }","duration":"174.129448ms","start":"2026-04-16T16:36:56.542583Z","end":"2026-04-16T16:36:56.716713Z","steps":["trace[225789913] 'agreement among raft nodes before linearized reading' (duration: 173.967794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:37:31.619236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.767351ms","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-16T16:37:31.619331Z","caller":"traceutil/trace.go:171","msg":"trace[536022849] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2402; }","duration":"260.897594ms","start":"2026-04-16T16:37:31.358414Z","end":"2026-04-16T16:37:31.619311Z","steps":["trace[536022849] 'range keys from in-memory index tree' (duration: 260.578927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:37:31.619414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.562943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:5 size:1788"} {"level":"warn","ts":"2026-04-16T16:37:31.619422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.652317ms","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-16T16:37:31.619502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.914617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-16T16:37:31.619514Z","caller":"traceutil/trace.go:171","msg":"trace[1620101810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2402; }","duration":"184.767229ms","start":"2026-04-16T16:37:31.434708Z","end":"2026-04-16T16:37:31.619475Z","steps":["trace[1620101810] 'range keys from in-memory index tree' (duration: 184.482813ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:37:31.619517Z","caller":"traceutil/trace.go:171","msg":"trace[190571352] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:5; response_revision:2402; }","duration":"239.702585ms","start":"2026-04-16T16:37:31.379761Z","end":"2026-04-16T16:37:31.619464Z","steps":["trace[190571352] 'range keys from in-memory index tree' (duration: 239.395838ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:37:31.619545Z","caller":"traceutil/trace.go:171","msg":"trace[1873579018] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2402; }","duration":"182.978338ms","start":"2026-04-16T16:37:31.436554Z","end":"2026-04-16T16:37:31.619532Z","steps":["trace[1873579018] 'range keys from in-memory index tree' (duration: 182.797804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:37:31.619413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.207258ms","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-16T16:37:31.619628Z","caller":"traceutil/trace.go:171","msg":"trace[761234913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2402; }","duration":"181.454293ms","start":"2026-04-16T16:37:31.438166Z","end":"2026-04-16T16:37:31.61962Z","steps":["trace[761234913] 'range keys from in-memory index tree' (duration: 181.025393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:37:31.619706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.545353ms","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-16T16:37:31.619856Z","caller":"traceutil/trace.go:171","msg":"trace[539160332] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2402; }","duration":"154.747288ms","start":"2026-04-16T16:37:31.465082Z","end":"2026-04-16T16:37:31.619829Z","steps":["trace[539160332] 'range keys from in-memory index tree' (duration: 154.512251ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:37:31.789481Z","caller":"traceutil/trace.go:171","msg":"trace[1340279153] transaction","detail":"{read_only:false; response_revision:2405; number_of_response:1; }","duration":"164.633265ms","start":"2026-04-16T16:37:31.624825Z","end":"2026-04-16T16:37:31.789458Z","steps":["trace[1340279153] 'process raft request' (duration: 164.533042ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:37:31.789687Z","caller":"traceutil/trace.go:171","msg":"trace[1565333347] transaction","detail":"{read_only:false; response_revision:2406; number_of_response:1; }","duration":"164.616385ms","start":"2026-04-16T16:37:31.625056Z","end":"2026-04-16T16:37:31.789673Z","steps":["trace[1565333347] 'process raft request' (duration: 164.368759ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T16:37:31.78948Z","caller":"traceutil/trace.go:171","msg":"trace[999529308] transaction","detail":"{read_only:false; response_revision:2404; number_of_response:1; }","duration":"164.86959ms","start":"2026-04-16T16:37:31.624567Z","end":"2026-04-16T16:37:31.789436Z","steps":["trace[999529308] 'process raft request' (duration: 161.623206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T16:37:31.922983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.603914ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-16T16:37:31.923091Z","caller":"traceutil/trace.go:171","msg":"trace[1057296351] linearizableReadLoop","detail":"{readStateIndex:2506; appliedIndex:2505; }","duration":"133.435415ms","start":"2026-04-16T16:37:31.789637Z","end":"2026-04-16T16:37:31.923073Z","steps":["trace[1057296351] 'read index received' (duration: 7.683207ms)","trace[1057296351] 'applied index is now lower than readState.Index' (duration: 125.750818ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T16:37:31.923335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.634641ms","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:535"} {"level":"info","ts":"2026-04-16T16:37:31.923448Z","caller":"traceutil/trace.go:171","msg":"trace[27647566] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2406; }","duration":"153.785074ms","start":"2026-04-16T16:37:31.769643Z","end":"2026-04-16T16:37:31.923428Z","steps":["trace[27647566] 'agreement among raft nodes before linearized reading' (duration: 153.492037ms)"],"step_count":1}