{"level":"warn","ts":"2026-04-13T20:46:30.767977Z","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-13T20:46:30.768094Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-13T20:46:30.768171Z","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-13T20:46:30.768192Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-13T20:46:30.768232Z","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-13T20:46:30.769055Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-04-13T20:46:30.769202Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-13T20:46:30.774449Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.984293ms"} {"level":"info","ts":"2026-04-13T20:46:30.790707Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-04-13T20:46:30.790817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T20:46:30.790843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-04-13T20:46:30.790857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T20:46:30.790869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-04-13T20:46:30.790919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-04-13T20:46:30.806107Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T20:46:30.814717Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T20:46:30.816812Z","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-13T20:46:30.819027Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T20:46:30.819606Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T20:46:30.820859Z","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-13T20:46:30.821671Z","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-13T20:46:30.821697Z","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-13T20:46:30.821993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-04-13T20:46:30.82226Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-04-13T20:46:30.824195Z","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-13T20:46:30.824409Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T20:46:30.824434Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T20:46:30.824506Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-13T20:46:30.824523Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-04-13T20:46:31.792168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T20:46:31.792305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T20:46:31.792408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-04-13T20:46:31.792498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-04-13T20:46:31.792609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-13T20:46:31.792701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-04-13T20:46:31.792793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-04-13T20:46:31.793864Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T20:46:31.793908Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:46:31.794083Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T20:46:31.794162Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T20:46:31.79425Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T20:46:31.794837Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T20:46:31.796156Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:46:31.796667Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:46:31.796711Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:46:31.797387Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-04-13T20:46:31.799664Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T20:46:36.027647Z","caller":"traceutil/trace.go:171","msg":"trace[1211789795] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"182.340159ms","start":"2026-04-13T20:46:35.845277Z","end":"2026-04-13T20:46:36.027617Z","steps":["trace[1211789795] 'process raft request' (duration: 182.079498ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:37.672862Z","caller":"traceutil/trace.go:171","msg":"trace[182160479] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"109.296681ms","start":"2026-04-13T20:46:37.563542Z","end":"2026-04-13T20:46:37.672839Z","steps":["trace[182160479] 'process raft request' (duration: 108.823548ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:37.674736Z","caller":"traceutil/trace.go:171","msg":"trace[2138712556] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"110.44982ms","start":"2026-04-13T20:46:37.564272Z","end":"2026-04-13T20:46:37.674722Z","steps":["trace[2138712556] 'process raft request' (duration: 108.188634ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:37.674883Z","caller":"traceutil/trace.go:171","msg":"trace[123269176] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"110.44247ms","start":"2026-04-13T20:46:37.564433Z","end":"2026-04-13T20:46:37.674875Z","steps":["trace[123269176] 'process raft request' (duration: 108.047493ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:37.690251Z","caller":"traceutil/trace.go:171","msg":"trace[1512356748] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:318; }","duration":"100.470421ms","start":"2026-04-13T20:46:37.589758Z","end":"2026-04-13T20:46:37.690229Z","steps":["trace[1512356748] 'read index received' (duration: 82.628238ms)","trace[1512356748] 'applied index is now lower than readState.Index' (duration: 17.841273ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:37.690495Z","caller":"traceutil/trace.go:171","msg":"trace[1770277367] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"101.449227ms","start":"2026-04-13T20:46:37.589034Z","end":"2026-04-13T20:46:37.690483Z","steps":["trace[1770277367] 'process raft request' (duration: 101.112445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:37.690867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.095715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-04-13T20:46:37.690958Z","caller":"traceutil/trace.go:171","msg":"trace[2117808380] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:310; }","duration":"101.222756ms","start":"2026-04-13T20:46:37.589722Z","end":"2026-04-13T20:46:37.690945Z","steps":["trace[2117808380] 'agreement among raft nodes before linearized reading' (duration: 100.660372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:38.036911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.673673ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T20:46:38.037033Z","caller":"traceutil/trace.go:171","msg":"trace[1143579144] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:325; }","duration":"250.15281ms","start":"2026-04-13T20:46:37.786855Z","end":"2026-04-13T20:46:38.037008Z","steps":["trace[1143579144] 'read index received' (duration: 91.54919ms)","trace[1143579144] 'applied index is now lower than readState.Index' (duration: 158.60229ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:46:38.03709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.230641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:46:38.037123Z","caller":"traceutil/trace.go:171","msg":"trace[1597675437] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:0; response_revision:313; }","duration":"250.284841ms","start":"2026-04-13T20:46:37.786828Z","end":"2026-04-13T20:46:38.037113Z","steps":["trace[1597675437] 'agreement among raft nodes before linearized reading' (duration: 250.231911ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:38.037137Z","caller":"traceutil/trace.go:171","msg":"trace[426561482] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"253.13662ms","start":"2026-04-13T20:46:37.783941Z","end":"2026-04-13T20:46:38.037077Z","steps":["trace[426561482] 'process raft request' (duration: 94.485339ms)","trace[426561482] 'compare' (duration: 157.552742ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:38.19723Z","caller":"traceutil/trace.go:171","msg":"trace[543231209] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"147.540056ms","start":"2026-04-13T20:46:38.04967Z","end":"2026-04-13T20:46:38.19721Z","steps":["trace[543231209] 'process raft request' (duration: 122.403519ms)","trace[543231209] 'compare' (duration: 24.908665ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:46:38.197461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.626916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:46:38.19764Z","caller":"traceutil/trace.go:171","msg":"trace[1278836464] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:0; response_revision:315; }","duration":"124.858618ms","start":"2026-04-13T20:46:38.072731Z","end":"2026-04-13T20:46:38.197589Z","steps":["trace[1278836464] 'agreement among raft nodes before linearized reading' (duration: 124.560406ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:38.197912Z","caller":"traceutil/trace.go:171","msg":"trace[431879843] linearizableReadLoop","detail":"{readStateIndex:328; appliedIndex:327; }","duration":"124.401564ms","start":"2026-04-13T20:46:38.072767Z","end":"2026-04-13T20:46:38.197168Z","steps":["trace[431879843] 'read index received' (duration: 99.320238ms)","trace[431879843] 'applied index is now lower than readState.Index' (duration: 25.080416ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:38.219584Z","caller":"traceutil/trace.go:171","msg":"trace[443731863] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"145.18651ms","start":"2026-04-13T20:46:38.07437Z","end":"2026-04-13T20:46:38.219557Z","steps":["trace[443731863] 'process raft request' (duration: 144.985149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:38.911792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.381862ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T20:46:38.911891Z","caller":"traceutil/trace.go:171","msg":"trace[1472152803] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:335; }","duration":"324.755284ms","start":"2026-04-13T20:46:38.587121Z","end":"2026-04-13T20:46:38.911876Z","steps":["trace[1472152803] 'read index received' (duration: 43.161321ms)","trace[1472152803] 'applied index is now lower than readState.Index' (duration: 281.592873ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:46:38.911957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.837734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-13T20:46:38.911989Z","caller":"traceutil/trace.go:171","msg":"trace[1995477577] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:323; }","duration":"324.896294ms","start":"2026-04-13T20:46:38.587083Z","end":"2026-04-13T20:46:38.911979Z","steps":["trace[1995477577] 'agreement among raft nodes before linearized reading' (duration: 324.836534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:38.912026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:38.587067Z","time spent":"324.951607ms","remote":"127.0.0.1:38220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"info","ts":"2026-04-13T20:46:38.912261Z","caller":"traceutil/trace.go:171","msg":"trace[45460056] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"338.278805ms","start":"2026-04-13T20:46:38.573906Z","end":"2026-04-13T20:46:38.912185Z","steps":["trace[45460056] 'process raft request' (duration: 56.426619ms)","trace[45460056] 'compare' (duration: 281.233491ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:46:38.912651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:38.573887Z","time spent":"338.680127ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:46:39.304761Z","caller":"traceutil/trace.go:171","msg":"trace[715389434] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"300.416669ms","start":"2026-04-13T20:46:39.004321Z","end":"2026-04-13T20:46:39.304738Z","steps":["trace[715389434] 'process raft request' (duration: 300.281738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:39.304904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:39.004289Z","time spent":"300.542949ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:46:39.342974Z","caller":"traceutil/trace.go:171","msg":"trace[37422039] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"304.299238ms","start":"2026-04-13T20:46:39.038652Z","end":"2026-04-13T20:46:39.342951Z","steps":["trace[37422039] 'process raft request' (duration: 304.183667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:39.343108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:39.038622Z","time spent":"304.4246ms","remote":"127.0.0.1:38220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T20:46:39.503744Z","caller":"traceutil/trace.go:171","msg":"trace[2015298656] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"144.890327ms","start":"2026-04-13T20:46:39.358833Z","end":"2026-04-13T20:46:39.503723Z","steps":["trace[2015298656] 'process raft request' (duration: 67.148407ms)","trace[2015298656] 'compare' (duration: 77.615509ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:40.230281Z","caller":"traceutil/trace.go:171","msg":"trace[1339810814] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"192.386669ms","start":"2026-04-13T20:46:40.037864Z","end":"2026-04-13T20:46:40.230251Z","steps":["trace[1339810814] 'process raft request' (duration: 141.939149ms)","trace[1339810814] 'compare' (duration: 50.209888ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:40.415822Z","caller":"traceutil/trace.go:171","msg":"trace[2068288817] linearizableReadLoop","detail":"{readStateIndex:347; appliedIndex:346; }","duration":"179.667752ms","start":"2026-04-13T20:46:40.236134Z","end":"2026-04-13T20:46:40.415802Z","steps":["trace[2068288817] 'read index received' (duration: 179.485959ms)","trace[2068288817] 'applied index is now lower than readState.Index' (duration: 180.893µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:40.41591Z","caller":"traceutil/trace.go:171","msg":"trace[1536330863] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"181.178294ms","start":"2026-04-13T20:46:40.234708Z","end":"2026-04-13T20:46:40.415886Z","steps":["trace[1536330863] 'process raft request' (duration: 180.974312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:40.415962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.805793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-13T20:46:40.41601Z","caller":"traceutil/trace.go:171","msg":"trace[1097739153] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:334; }","duration":"179.890333ms","start":"2026-04-13T20:46:40.236104Z","end":"2026-04-13T20:46:40.415994Z","steps":["trace[1097739153] 'agreement among raft nodes before linearized reading' (duration: 179.792172ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:40.580893Z","caller":"traceutil/trace.go:171","msg":"trace[51999162] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"161.239254ms","start":"2026-04-13T20:46:40.419634Z","end":"2026-04-13T20:46:40.580874Z","steps":["trace[51999162] 'process raft request' (duration: 130.002548ms)","trace[51999162] 'compare' (duration: 31.141605ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:40.724121Z","caller":"traceutil/trace.go:171","msg":"trace[552296616] linearizableReadLoop","detail":"{readStateIndex:351; appliedIndex:348; }","duration":"108.063171ms","start":"2026-04-13T20:46:40.616037Z","end":"2026-04-13T20:46:40.7241Z","steps":["trace[552296616] 'read index received' (duration: 5.096393ms)","trace[552296616] 'applied index is now lower than readState.Index' (duration: 102.965468ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:46:40.724326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.275353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-13T20:46:40.724392Z","caller":"traceutil/trace.go:171","msg":"trace[1748835415] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:338; }","duration":"108.367463ms","start":"2026-04-13T20:46:40.616007Z","end":"2026-04-13T20:46:40.724375Z","steps":["trace[1748835415] 'agreement among raft nodes before linearized reading' (duration: 108.225852ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:40.724478Z","caller":"traceutil/trace.go:171","msg":"trace[1223231706] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"109.189761ms","start":"2026-04-13T20:46:40.615209Z","end":"2026-04-13T20:46:40.724398Z","steps":["trace[1223231706] 'process raft request' (duration: 108.849708ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:40.724724Z","caller":"traceutil/trace.go:171","msg":"trace[1035491283] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"109.05011ms","start":"2026-04-13T20:46:40.615079Z","end":"2026-04-13T20:46:40.724129Z","steps":["trace[1035491283] 'process raft request' (duration: 80.596516ms)","trace[1035491283] 'compare' (duration: 28.273632ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:40.901889Z","caller":"traceutil/trace.go:171","msg":"trace[1604287532] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"168.587227ms","start":"2026-04-13T20:46:40.733277Z","end":"2026-04-13T20:46:40.901865Z","steps":["trace[1604287532] 'process raft request' (duration: 168.306105ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:40.902096Z","caller":"traceutil/trace.go:171","msg":"trace[944860863] linearizableReadLoop","detail":"{readStateIndex:354; appliedIndex:351; }","duration":"164.823945ms","start":"2026-04-13T20:46:40.737242Z","end":"2026-04-13T20:46:40.902066Z","steps":["trace[944860863] 'read index received' (duration: 31.377768ms)","trace[944860863] 'applied index is now lower than readState.Index' (duration: 133.444187ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:40.902203Z","caller":"traceutil/trace.go:171","msg":"trace[803492236] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"167.053204ms","start":"2026-04-13T20:46:40.735117Z","end":"2026-04-13T20:46:40.90217Z","steps":["trace[803492236] 'process raft request' (duration: 166.696761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:40.902286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.071451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-13T20:46:40.902353Z","caller":"traceutil/trace.go:171","msg":"trace[760428966] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:341; }","duration":"114.175262ms","start":"2026-04-13T20:46:40.78816Z","end":"2026-04-13T20:46:40.902335Z","steps":["trace[760428966] 'agreement among raft nodes before linearized reading' (duration: 114.070771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:40.902322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.065067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-13T20:46:40.902598Z","caller":"traceutil/trace.go:171","msg":"trace[929207340] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:341; }","duration":"165.335649ms","start":"2026-04-13T20:46:40.737205Z","end":"2026-04-13T20:46:40.902541Z","steps":["trace[929207340] 'agreement among raft nodes before linearized reading' (duration: 165.016746ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.140149Z","caller":"traceutil/trace.go:171","msg":"trace[1459918641] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"229.990793ms","start":"2026-04-13T20:46:40.910137Z","end":"2026-04-13T20:46:41.140128Z","steps":["trace[1459918641] 'process raft request' (duration: 143.212897ms)","trace[1459918641] 'compare' (duration: 86.620135ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:41.140469Z","caller":"traceutil/trace.go:171","msg":"trace[823598234] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"230.062794ms","start":"2026-04-13T20:46:40.910391Z","end":"2026-04-13T20:46:41.140454Z","steps":["trace[823598234] 'process raft request' (duration: 229.693311ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.140479Z","caller":"traceutil/trace.go:171","msg":"trace[771263928] linearizableReadLoop","detail":"{readStateIndex:357; appliedIndex:354; }","duration":"224.945591ms","start":"2026-04-13T20:46:40.915515Z","end":"2026-04-13T20:46:41.14046Z","steps":["trace[771263928] 'read index received' (duration: 137.846462ms)","trace[771263928] 'applied index is now lower than readState.Index' (duration: 87.098059ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:46:41.140705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.728671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-13T20:46:41.14077Z","caller":"traceutil/trace.go:171","msg":"trace[1615916232] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:344; }","duration":"202.831583ms","start":"2026-04-13T20:46:40.937923Z","end":"2026-04-13T20:46:41.140755Z","steps":["trace[1615916232] 'agreement among raft nodes before linearized reading' (duration: 202.663441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:41.140763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.66841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-04-13T20:46:41.140706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.171263ms","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-13T20:46:41.140882Z","caller":"traceutil/trace.go:171","msg":"trace[82648715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:344; }","duration":"225.384455ms","start":"2026-04-13T20:46:40.91548Z","end":"2026-04-13T20:46:41.140864Z","steps":["trace[82648715] 'agreement among raft nodes before linearized reading' (duration: 225.114322ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.140866Z","caller":"traceutil/trace.go:171","msg":"trace[1325527032] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:344; }","duration":"102.833931ms","start":"2026-04-13T20:46:41.038015Z","end":"2026-04-13T20:46:41.140849Z","steps":["trace[1325527032] 'agreement among raft nodes before linearized reading' (duration: 102.69049ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.140952Z","caller":"traceutil/trace.go:171","msg":"trace[328228000] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"229.764962ms","start":"2026-04-13T20:46:40.911172Z","end":"2026-04-13T20:46:41.140937Z","steps":["trace[328228000] 'process raft request' (duration: 229.139717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:41.140978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.476933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-13T20:46:41.141158Z","caller":"traceutil/trace.go:171","msg":"trace[1710683099] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:344; }","duration":"152.736336ms","start":"2026-04-13T20:46:40.988391Z","end":"2026-04-13T20:46:41.141127Z","steps":["trace[1710683099] 'agreement among raft nodes before linearized reading' (duration: 152.320591ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.425309Z","caller":"traceutil/trace.go:171","msg":"trace[488980049] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"238.554031ms","start":"2026-04-13T20:46:41.186713Z","end":"2026-04-13T20:46:41.425267Z","steps":["trace[488980049] 'process raft request' (duration: 171.766076ms)","trace[488980049] 'compare' (duration: 66.479791ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:41.425371Z","caller":"traceutil/trace.go:171","msg":"trace[1539942564] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"237.34981ms","start":"2026-04-13T20:46:41.187969Z","end":"2026-04-13T20:46:41.425319Z","steps":["trace[1539942564] 'process raft request' (duration: 237.206038ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.425428Z","caller":"traceutil/trace.go:171","msg":"trace[1830349583] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"238.650092ms","start":"2026-04-13T20:46:41.186754Z","end":"2026-04-13T20:46:41.425404Z","steps":["trace[1830349583] 'process raft request' (duration: 238.377929ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.425355Z","caller":"traceutil/trace.go:171","msg":"trace[2013105296] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"229.257256ms","start":"2026-04-13T20:46:41.196076Z","end":"2026-04-13T20:46:41.425333Z","steps":["trace[2013105296] 'process raft request' (duration: 229.204776ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.425886Z","caller":"traceutil/trace.go:171","msg":"trace[389563640] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"237.35732ms","start":"2026-04-13T20:46:41.18851Z","end":"2026-04-13T20:46:41.425867Z","steps":["trace[389563640] 'process raft request' (duration: 236.705804ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.425786Z","caller":"traceutil/trace.go:171","msg":"trace[1207243456] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:365; }","duration":"237.948625ms","start":"2026-04-13T20:46:41.187825Z","end":"2026-04-13T20:46:41.425774Z","steps":["trace[1207243456] 'read index received' (duration: 6.219776ms)","trace[1207243456] 'applied index is now lower than readState.Index' (duration: 231.727289ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:46:41.426145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.297638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-04-13T20:46:41.426201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.006379ms","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-13T20:46:41.426224Z","caller":"traceutil/trace.go:171","msg":"trace[117161710] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:358; }","duration":"238.410559ms","start":"2026-04-13T20:46:41.187793Z","end":"2026-04-13T20:46:41.426203Z","steps":["trace[117161710] 'agreement among raft nodes before linearized reading' (duration: 238.255097ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.426256Z","caller":"traceutil/trace.go:171","msg":"trace[1360337204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:358; }","duration":"117.10174ms","start":"2026-04-13T20:46:41.309135Z","end":"2026-04-13T20:46:41.426237Z","steps":["trace[1360337204] 'agreement among raft nodes before linearized reading' (duration: 116.978829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:41.426549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.380955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-13T20:46:41.42684Z","caller":"traceutil/trace.go:171","msg":"trace[1837616150] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:358; }","duration":"188.702289ms","start":"2026-04-13T20:46:41.238124Z","end":"2026-04-13T20:46:41.426826Z","steps":["trace[1837616150] 'agreement among raft nodes before linearized reading' (duration: 187.958662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:41.431034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.578666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-13T20:46:41.43118Z","caller":"traceutil/trace.go:171","msg":"trace[2017460285] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:358; }","duration":"142.540711ms","start":"2026-04-13T20:46:41.288611Z","end":"2026-04-13T20:46:41.431152Z","steps":["trace[2017460285] 'agreement among raft nodes before linearized reading' (duration: 137.523565ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.641823Z","caller":"traceutil/trace.go:171","msg":"trace[1507308727] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"112.523509ms","start":"2026-04-13T20:46:41.529256Z","end":"2026-04-13T20:46:41.641779Z","steps":["trace[1507308727] 'process raft request' (duration: 112.324107ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.641984Z","caller":"traceutil/trace.go:171","msg":"trace[1360983353] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"112.606549ms","start":"2026-04-13T20:46:41.529368Z","end":"2026-04-13T20:46:41.641974Z","steps":["trace[1360983353] 'process raft request' (duration: 112.325247ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.642155Z","caller":"traceutil/trace.go:171","msg":"trace[2113000189] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"108.435062ms","start":"2026-04-13T20:46:41.533698Z","end":"2026-04-13T20:46:41.642133Z","steps":["trace[2113000189] 'process raft request' (duration: 108.059388ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:41.973182Z","caller":"traceutil/trace.go:171","msg":"trace[1510689088] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"326.110734ms","start":"2026-04-13T20:46:41.647031Z","end":"2026-04-13T20:46:41.973142Z","steps":["trace[1510689088] 'process raft request' (duration: 258.477111ms)","trace[1510689088] 'compare' (duration: 67.415511ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:41.973215Z","caller":"traceutil/trace.go:171","msg":"trace[1001370223] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"325.412447ms","start":"2026-04-13T20:46:41.647776Z","end":"2026-04-13T20:46:41.973189Z","steps":["trace[1001370223] 'process raft request' (duration: 325.316466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:41.973343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.647762Z","time spent":"325.523998ms","remote":"127.0.0.1:38082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T20:46:41.973355Z","caller":"traceutil/trace.go:171","msg":"trace[1614877498] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:385; }","duration":"324.930672ms","start":"2026-04-13T20:46:41.648383Z","end":"2026-04-13T20:46:41.973313Z","steps":["trace[1614877498] 'read index received' (duration: 9.133482ms)","trace[1614877498] 'applied index is now lower than readState.Index' (duration: 315.79564ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:46:41.973365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.647016Z","time spent":"326.269755ms","remote":"127.0.0.1:38082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T20:46:41.973627Z","caller":"traceutil/trace.go:171","msg":"trace[1004335007] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"321.227769ms","start":"2026-04-13T20:46:41.652387Z","end":"2026-04-13T20:46:41.973615Z","steps":["trace[1004335007] 'process raft request' (duration: 320.786525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:41.973715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.65238Z","time spent":"321.276569ms","remote":"127.0.0.1:38200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4115,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:46:41.973707Z","caller":"traceutil/trace.go:171","msg":"trace[548029341] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"324.206425ms","start":"2026-04-13T20:46:41.649474Z","end":"2026-04-13T20:46:41.973681Z","steps":["trace[548029341] 'process raft request' (duration: 323.657481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:41.973761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.304745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"warn","ts":"2026-04-13T20:46:41.973825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.649458Z","time spent":"324.311096ms","remote":"127.0.0.1:38200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T20:46:41.973945Z","caller":"traceutil/trace.go:171","msg":"trace[757919317] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"320.4011ms","start":"2026-04-13T20:46:41.653521Z","end":"2026-04-13T20:46:41.973922Z","steps":["trace[757919317] 'process raft request' (duration: 319.720355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:41.974464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.653501Z","time spent":"320.894156ms","remote":"127.0.0.1:38200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:46:41.973985Z","caller":"traceutil/trace.go:171","msg":"trace[974505707] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:378; }","duration":"325.569688ms","start":"2026-04-13T20:46:41.648343Z","end":"2026-04-13T20:46:41.973912Z","steps":["trace[974505707] 'agreement among raft nodes before linearized reading' (duration: 325.096234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:41.975007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.648326Z","time spent":"326.662268ms","remote":"127.0.0.1:38220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":209,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-04-13T20:46:42.437849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.795474ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T20:46:42.438094Z","caller":"traceutil/trace.go:171","msg":"trace[617213168] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"459.462889ms","start":"2026-04-13T20:46:41.978594Z","end":"2026-04-13T20:46:42.438057Z","steps":["trace[617213168] 'process raft request' (duration: 114.412643ms)","trace[617213168] 'compare' (duration: 344.656203ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:46:42.438134Z","caller":"traceutil/trace.go:171","msg":"trace[1000836902] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"458.621502ms","start":"2026-04-13T20:46:41.979471Z","end":"2026-04-13T20:46:42.438093Z","steps":["trace[1000836902] 'process raft request' (duration: 458.45986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:42.438284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.979452Z","time spent":"458.735454ms","remote":"127.0.0.1:38578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3759,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:46:42.438321Z","caller":"traceutil/trace.go:171","msg":"trace[1560882059] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"458.228378ms","start":"2026-04-13T20:46:41.98005Z","end":"2026-04-13T20:46:42.438278Z","steps":["trace[1560882059] 'process raft request' (duration: 457.924336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:42.438476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.980038Z","time spent":"458.312499ms","remote":"127.0.0.1:38082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T20:46:42.438621Z","caller":"traceutil/trace.go:171","msg":"trace[1812795394] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"454.816727ms","start":"2026-04-13T20:46:41.983786Z","end":"2026-04-13T20:46:42.438603Z","steps":["trace[1812795394] 'process raft request' (duration: 454.209652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:42.438721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.983776Z","time spent":"454.896719ms","remote":"127.0.0.1:38200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T20:46:42.439216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:41.978568Z","time spent":"459.615721ms","remote":"127.0.0.1:38082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T20:46:43.804492Z","caller":"traceutil/trace.go:171","msg":"trace[1890019380] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"218.981922ms","start":"2026-04-13T20:46:43.585491Z","end":"2026-04-13T20:46:43.804473Z","steps":["trace[1890019380] 'process raft request' (duration: 218.86155ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:43.804529Z","caller":"traceutil/trace.go:171","msg":"trace[1658851270] linearizableReadLoop","detail":"{readStateIndex:407; appliedIndex:407; }","duration":"143.480599ms","start":"2026-04-13T20:46:43.661024Z","end":"2026-04-13T20:46:43.804505Z","steps":["trace[1658851270] 'read index received' (duration: 143.473029ms)","trace[1658851270] 'applied index is now lower than readState.Index' (duration: 6.28µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:46:43.804686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.63956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-13T20:46:43.804772Z","caller":"traceutil/trace.go:171","msg":"trace[1563679834] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:393; }","duration":"143.728221ms","start":"2026-04-13T20:46:43.660986Z","end":"2026-04-13T20:46:43.804714Z","steps":["trace[1563679834] 'agreement among raft nodes before linearized reading' (duration: 143.60217ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:43.809212Z","caller":"traceutil/trace.go:171","msg":"trace[1814985747] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"122.461516ms","start":"2026-04-13T20:46:43.686733Z","end":"2026-04-13T20:46:43.809194Z","steps":["trace[1814985747] 'process raft request' (duration: 122.369845ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:46:54.847419Z","caller":"traceutil/trace.go:171","msg":"trace[542154856] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"343.952051ms","start":"2026-04-13T20:46:54.503432Z","end":"2026-04-13T20:46:54.847384Z","steps":["trace[542154856] 'process raft request' (duration: 343.722537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:46:54.847626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:46:54.50341Z","time spent":"344.106523ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:46:57.080866Z","caller":"traceutil/trace.go:171","msg":"trace[1670951474] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"226.572261ms","start":"2026-04-13T20:46:56.854271Z","end":"2026-04-13T20:46:57.080843Z","steps":["trace[1670951474] 'process raft request' (duration: 226.452969ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:00.272768Z","caller":"traceutil/trace.go:171","msg":"trace[1594344146] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"195.616648ms","start":"2026-04-13T20:47:00.077127Z","end":"2026-04-13T20:47:00.272744Z","steps":["trace[1594344146] 'read index received' (duration: 195.387934ms)","trace[1594344146] 'applied index is now lower than readState.Index' (duration: 227.714µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:47:00.272951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.811141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-04-13T20:47:00.273043Z","caller":"traceutil/trace.go:171","msg":"trace[11942614] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"287.902876ms","start":"2026-04-13T20:46:59.985123Z","end":"2026-04-13T20:47:00.273025Z","steps":["trace[11942614] 'process raft request' (duration: 287.471048ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:00.273152Z","caller":"traceutil/trace.go:171","msg":"trace[592890106] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:468; }","duration":"195.986704ms","start":"2026-04-13T20:47:00.077076Z","end":"2026-04-13T20:47:00.273063Z","steps":["trace[592890106] 'agreement among raft nodes before linearized reading' (duration: 195.76238ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:03.255694Z","caller":"traceutil/trace.go:171","msg":"trace[784868676] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"138.705598ms","start":"2026-04-13T20:47:03.11696Z","end":"2026-04-13T20:47:03.255666Z","steps":["trace[784868676] 'process raft request' (duration: 86.420521ms)","trace[784868676] 'compare' (duration: 52.169835ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:47:03.260099Z","caller":"traceutil/trace.go:171","msg":"trace[883980607] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"138.84445ms","start":"2026-04-13T20:47:03.121211Z","end":"2026-04-13T20:47:03.260056Z","steps":["trace[883980607] 'process raft request' (duration: 138.371092ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:03.260935Z","caller":"traceutil/trace.go:171","msg":"trace[1677121879] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"132.454441ms","start":"2026-04-13T20:47:03.12845Z","end":"2026-04-13T20:47:03.260905Z","steps":["trace[1677121879] 'process raft request' (duration: 131.251698ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:03.261772Z","caller":"traceutil/trace.go:171","msg":"trace[1357184094] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"132.239446ms","start":"2026-04-13T20:47:03.129512Z","end":"2026-04-13T20:47:03.261751Z","steps":["trace[1357184094] 'process raft request' (duration: 131.363879ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:03.261812Z","caller":"traceutil/trace.go:171","msg":"trace[1482701963] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"129.81884ms","start":"2026-04-13T20:47:03.131979Z","end":"2026-04-13T20:47:03.261798Z","steps":["trace[1482701963] 'process raft request' (duration: 129.515644ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:03.447337Z","caller":"traceutil/trace.go:171","msg":"trace[2047555277] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"105.025483ms","start":"2026-04-13T20:47:03.342292Z","end":"2026-04-13T20:47:03.447317Z","steps":["trace[2047555277] 'process raft request' (duration: 95.484142ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:03.449948Z","caller":"traceutil/trace.go:171","msg":"trace[106065327] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"103.012535ms","start":"2026-04-13T20:47:03.346918Z","end":"2026-04-13T20:47:03.449931Z","steps":["trace[106065327] 'process raft request' (duration: 102.497026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:04.230388Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095183484029789,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T20:47:04.362339Z","caller":"traceutil/trace.go:171","msg":"trace[477304205] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"655.79977ms","start":"2026-04-13T20:47:03.706508Z","end":"2026-04-13T20:47:04.362308Z","steps":["trace[477304205] 'process raft request' (duration: 644.468101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:04.362672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:03.706491Z","time spent":"655.937153ms","remote":"127.0.0.1:38062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T20:47:04.366876Z","caller":"traceutil/trace.go:171","msg":"trace[705168743] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"658.273888ms","start":"2026-04-13T20:47:03.708584Z","end":"2026-04-13T20:47:04.366858Z","steps":["trace[705168743] 'process raft request' (duration: 657.919321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:04.366985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:03.708558Z","time spent":"658.366059ms","remote":"127.0.0.1:38062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:47:04.367279Z","caller":"traceutil/trace.go:171","msg":"trace[1727908710] linearizableReadLoop","detail":"{readStateIndex:583; appliedIndex:579; }","duration":"636.956425ms","start":"2026-04-13T20:47:03.730306Z","end":"2026-04-13T20:47:04.367262Z","steps":["trace[1727908710] 'read index received' (duration: 620.644672ms)","trace[1727908710] 'applied index is now lower than readState.Index' (duration: 16.310823ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:47:04.367328Z","caller":"traceutil/trace.go:171","msg":"trace[1551515312] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"608.0809ms","start":"2026-04-13T20:47:03.759242Z","end":"2026-04-13T20:47:04.367323Z","steps":["trace[1551515312] 'process raft request' (duration: 607.662803ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:04.367296Z","caller":"traceutil/trace.go:171","msg":"trace[996441108] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"486.533606ms","start":"2026-04-13T20:47:03.880755Z","end":"2026-04-13T20:47:04.367288Z","steps":["trace[996441108] 'process raft request' (duration: 486.457504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:04.367526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:03.880733Z","time spent":"486.74042ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T20:47:04.367366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:03.75921Z","time spent":"608.133372ms","remote":"127.0.0.1:38062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T20:47:04.367411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.37258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:04.367627Z","caller":"traceutil/trace.go:171","msg":"trace[735398979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"208.638395ms","start":"2026-04-13T20:47:04.15898Z","end":"2026-04-13T20:47:04.367619Z","steps":["trace[735398979] 'agreement among raft nodes before linearized reading' (duration: 208.412651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:04.367882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.550457ms","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-13T20:47:04.368114Z","caller":"traceutil/trace.go:171","msg":"trace[875455296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:563; }","duration":"637.67298ms","start":"2026-04-13T20:47:03.730267Z","end":"2026-04-13T20:47:04.36794Z","steps":["trace[875455296] 'agreement among raft nodes before linearized reading' (duration: 637.072298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:04.368379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:03.730245Z","time spent":"637.930794ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T20:47:05.257947Z","caller":"traceutil/trace.go:171","msg":"trace[665165650] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"207.193433ms","start":"2026-04-13T20:47:05.050707Z","end":"2026-04-13T20:47:05.257901Z","steps":["trace[665165650] 'process raft request' (duration: 187.382845ms)","trace[665165650] 'compare' (duration: 18.900551ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:47:05.26871Z","caller":"traceutil/trace.go:171","msg":"trace[499390197] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:602; }","duration":"109.442346ms","start":"2026-04-13T20:47:05.159252Z","end":"2026-04-13T20:47:05.268694Z","steps":["trace[499390197] 'read index received' (duration: 78.753894ms)","trace[499390197] 'applied index is now lower than readState.Index' (duration: 30.687672ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:47:05.269756Z","caller":"traceutil/trace.go:171","msg":"trace[1219383355] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"214.106189ms","start":"2026-04-13T20:47:05.055636Z","end":"2026-04-13T20:47:05.269742Z","steps":["trace[1219383355] 'process raft request' (duration: 212.554818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:05.270097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.832643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:05.270147Z","caller":"traceutil/trace.go:171","msg":"trace[1856743944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"110.943245ms","start":"2026-04-13T20:47:05.159188Z","end":"2026-04-13T20:47:05.270132Z","steps":["trace[1856743944] 'agreement among raft nodes before linearized reading' (duration: 110.815593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.43475Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095183484029942,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T20:47:11.508719Z","caller":"traceutil/trace.go:171","msg":"trace[1782551600] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"574.238906ms","start":"2026-04-13T20:47:10.934464Z","end":"2026-04-13T20:47:11.508703Z","steps":["trace[1782551600] 'read index received' (duration: 573.245994ms)","trace[1782551600] 'applied index is now lower than readState.Index' (duration: 992.382µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:47:11.508843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.330948ms","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-13T20:47:11.508862Z","caller":"traceutil/trace.go:171","msg":"trace[1427712234] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"574.40971ms","start":"2026-04-13T20:47:10.934447Z","end":"2026-04-13T20:47:11.508856Z","steps":["trace[1427712234] 'agreement among raft nodes before linearized reading' (duration: 574.353429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.508883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:10.934425Z","time spent":"574.45319ms","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T20:47:11.50889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.569401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:11.508944Z","caller":"traceutil/trace.go:171","msg":"trace[1842664199] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"255.646083ms","start":"2026-04-13T20:47:11.253281Z","end":"2026-04-13T20:47:11.508927Z","steps":["trace[1842664199] 'agreement among raft nodes before linearized reading' (duration: 255.560082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.820645ms","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-13T20:47:11.509091Z","caller":"traceutil/trace.go:171","msg":"trace[565203556] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:621; }","duration":"326.850456ms","start":"2026-04-13T20:47:11.182236Z","end":"2026-04-13T20:47:11.509087Z","steps":["trace[565203556] 'agreement among raft nodes before linearized reading' (duration: 326.820715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.182232Z","time spent":"326.868726ms","remote":"127.0.0.1:50284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-13T20:47:11.509186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.294537ms","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":"info","ts":"2026-04-13T20:47:11.509207Z","caller":"traceutil/trace.go:171","msg":"trace[1395629617] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:621; }","duration":"327.332767ms","start":"2026-04-13T20:47:11.18187Z","end":"2026-04-13T20:47:11.509202Z","steps":["trace[1395629617] 'agreement among raft nodes before linearized reading' (duration: 327.301747ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:11.509143Z","caller":"traceutil/trace.go:171","msg":"trace[1360084818] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"693.085783ms","start":"2026-04-13T20:47:10.816013Z","end":"2026-04-13T20:47:11.509098Z","steps":["trace[1360084818] 'process raft request' (duration: 692.289315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.642894ms","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-13T20:47:11.509259Z","caller":"traceutil/trace.go:171","msg":"trace[837422012] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:621; }","duration":"327.675194ms","start":"2026-04-13T20:47:11.18158Z","end":"2026-04-13T20:47:11.509255Z","steps":["trace[837422012] 'agreement among raft nodes before linearized reading' (duration: 327.648874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.181572Z","time spent":"327.697975ms","remote":"127.0.0.1:50284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T20:47:11.509313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.734766ms","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-13T20:47:11.509361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.231506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:11.509375Z","caller":"traceutil/trace.go:171","msg":"trace[1157450249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"351.284467ms","start":"2026-04-13T20:47:11.158087Z","end":"2026-04-13T20:47:11.509371Z","steps":["trace[1157450249] 'agreement among raft nodes before linearized reading' (duration: 351.238636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.158067Z","time spent":"351.318807ms","remote":"127.0.0.1:38004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T20:47:11.509382Z","caller":"traceutil/trace.go:171","msg":"trace[1416962371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:621; }","duration":"131.816508ms","start":"2026-04-13T20:47:11.377543Z","end":"2026-04-13T20:47:11.50936Z","steps":["trace[1416962371] 'agreement among raft nodes before linearized reading' (duration: 131.676505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.510029ms","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-13T20:47:11.509481Z","caller":"traceutil/trace.go:171","msg":"trace[577183785] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"445.735474ms","start":"2026-04-13T20:47:11.063742Z","end":"2026-04-13T20:47:11.509478Z","steps":["trace[577183785] 'agreement among raft nodes before linearized reading' (duration: 445.709463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:10.815979Z","time spent":"693.292458ms","remote":"127.0.0.1:38098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T20:47:11.509532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.356877ms","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":"info","ts":"2026-04-13T20:47:11.50955Z","caller":"traceutil/trace.go:171","msg":"trace[16306695] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"446.374297ms","start":"2026-04-13T20:47:11.063172Z","end":"2026-04-13T20:47:11.509546Z","steps":["trace[16306695] 'agreement among raft nodes before linearized reading' (duration: 446.351207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.063137Z","time spent":"446.422108ms","remote":"127.0.0.1:50282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T20:47:11.509554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.864589ms","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-13T20:47:11.509587Z","caller":"traceutil/trace.go:171","msg":"trace[2039598403] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"161.91208ms","start":"2026-04-13T20:47:11.347664Z","end":"2026-04-13T20:47:11.509576Z","steps":["trace[2039598403] 'agreement among raft nodes before linearized reading' (duration: 161.864639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.202576ms","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-13T20:47:11.509697Z","caller":"traceutil/trace.go:171","msg":"trace[1788976944] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:621; }","duration":"471.259467ms","start":"2026-04-13T20:47:11.038432Z","end":"2026-04-13T20:47:11.509691Z","steps":["trace[1788976944] 'agreement among raft nodes before linearized reading' (duration: 471.198555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.03842Z","time spent":"471.288418ms","remote":"127.0.0.1:50266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-13T20:47:11.509683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.870662ms","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-13T20:47:11.509739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.137926ms","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-13T20:47:11.509759Z","caller":"traceutil/trace.go:171","msg":"trace[911885580] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"192.968594ms","start":"2026-04-13T20:47:11.316772Z","end":"2026-04-13T20:47:11.509741Z","steps":["trace[911885580] 'agreement among raft nodes before linearized reading' (duration: 192.81328ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:11.509777Z","caller":"traceutil/trace.go:171","msg":"trace[302178122] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"163.208929ms","start":"2026-04-13T20:47:11.346559Z","end":"2026-04-13T20:47:11.509768Z","steps":["trace[302178122] 'agreement among raft nodes before linearized reading' (duration: 163.157957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.356754ms","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-13T20:47:11.509805Z","caller":"traceutil/trace.go:171","msg":"trace[783548857] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:621; }","duration":"473.400275ms","start":"2026-04-13T20:47:11.036401Z","end":"2026-04-13T20:47:11.509802Z","steps":["trace[783548857] 'agreement among raft nodes before linearized reading' (duration: 473.372494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.036389Z","time spent":"473.431165ms","remote":"127.0.0.1:50266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T20:47:11.509192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.35726ms","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":"warn","ts":"2026-04-13T20:47:11.509886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.482757ms","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-13T20:47:11.509905Z","caller":"traceutil/trace.go:171","msg":"trace[1373616510] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:621; }","duration":"473.516137ms","start":"2026-04-13T20:47:11.036385Z","end":"2026-04-13T20:47:11.509901Z","steps":["trace[1373616510] 'agreement among raft nodes before linearized reading' (duration: 473.484376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.333902ms","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-13T20:47:11.509919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.036375Z","time spent":"473.540108ms","remote":"127.0.0.1:50266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-13T20:47:11.5099Z","caller":"traceutil/trace.go:171","msg":"trace[2044264964] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"193.059026ms","start":"2026-04-13T20:47:11.316795Z","end":"2026-04-13T20:47:11.509854Z","steps":["trace[2044264964] 'agreement among raft nodes before linearized reading' (duration: 192.32916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.59339ms","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-13T20:47:11.509997Z","caller":"traceutil/trace.go:171","msg":"trace[1167589877] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:621; }","duration":"492.636081ms","start":"2026-04-13T20:47:11.017356Z","end":"2026-04-13T20:47:11.509992Z","steps":["trace[1167589877] 'agreement among raft nodes before linearized reading' (duration: 492.61101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.510015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.017338Z","time spent":"492.669532ms","remote":"127.0.0.1:50256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-13T20:47:11.508923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.42134ms","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-13T20:47:11.509495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.063726Z","time spent":"445.765974ms","remote":"127.0.0.1:50282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-13T20:47:11.510119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.363782ms","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-13T20:47:11.510135Z","caller":"traceutil/trace.go:171","msg":"trace[1604119120] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:621; }","duration":"496.381073ms","start":"2026-04-13T20:47:11.013749Z","end":"2026-04-13T20:47:11.51013Z","steps":["trace[1604119120] 'agreement among raft nodes before linearized reading' (duration: 496.355992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.510152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.013694Z","time spent":"496.453714ms","remote":"127.0.0.1:50256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T20:47:11.510223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.471235ms","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":"warn","ts":"2026-04-13T20:47:11.510215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.31627ms","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-13T20:47:11.510269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.542314ms","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-13T20:47:11.510291Z","caller":"traceutil/trace.go:171","msg":"trace[1492345959] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"545.594335ms","start":"2026-04-13T20:47:10.96469Z","end":"2026-04-13T20:47:11.510284Z","steps":["trace[1492345959] 'agreement among raft nodes before linearized reading' (duration: 545.561914ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:11.510242Z","caller":"traceutil/trace.go:171","msg":"trace[354740667] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:621; }","duration":"496.525496ms","start":"2026-04-13T20:47:11.013713Z","end":"2026-04-13T20:47:11.510238Z","steps":["trace[354740667] 'agreement among raft nodes before linearized reading' (duration: 496.495115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.510311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:10.964673Z","time spent":"545.633146ms","remote":"127.0.0.1:50252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T20:47:11.510334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.250326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:11.510385Z","caller":"traceutil/trace.go:171","msg":"trace[1747999028] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"256.311037ms","start":"2026-04-13T20:47:11.254064Z","end":"2026-04-13T20:47:11.510375Z","steps":["trace[1747999028] 'agreement among raft nodes before linearized reading' (duration: 256.241335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.510386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.013693Z","time spent":"496.625218ms","remote":"127.0.0.1:50256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-13T20:47:11.510277Z","caller":"traceutil/trace.go:171","msg":"trace[1683568698] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:621; }","duration":"198.400861ms","start":"2026-04-13T20:47:11.31186Z","end":"2026-04-13T20:47:11.510261Z","steps":["trace[1683568698] 'agreement among raft nodes before linearized reading' (duration: 198.116165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.510431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.735659ms","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-13T20:47:11.510469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.874202ms","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":"info","ts":"2026-04-13T20:47:11.510541Z","caller":"traceutil/trace.go:171","msg":"trace[1743718413] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:621; }","duration":"222.979554ms","start":"2026-04-13T20:47:11.287548Z","end":"2026-04-13T20:47:11.510527Z","steps":["trace[1743718413] 'agreement among raft nodes before linearized reading' (duration: 222.901362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.305996ms","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":"warn","ts":"2026-04-13T20:47:11.510569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.926463ms","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-13T20:47:11.510605Z","caller":"traceutil/trace.go:171","msg":"trace[1225868751] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"545.981234ms","start":"2026-04-13T20:47:10.964616Z","end":"2026-04-13T20:47:11.510597Z","steps":["trace[1225868751] 'agreement among raft nodes before linearized reading' (duration: 545.909672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.510632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:10.964605Z","time spent":"546.019204ms","remote":"127.0.0.1:50252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T20:47:11.510674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.750612ms","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":"warn","ts":"2026-04-13T20:47:11.510681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.240288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:11.510702Z","caller":"traceutil/trace.go:171","msg":"trace[328149854] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:621; }","duration":"223.811703ms","start":"2026-04-13T20:47:11.286882Z","end":"2026-04-13T20:47:11.510694Z","steps":["trace[328149854] 'agreement among raft nodes before linearized reading' (duration: 223.770122ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:11.510734Z","caller":"traceutil/trace.go:171","msg":"trace[1788764341] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"257.3368ms","start":"2026-04-13T20:47:11.253381Z","end":"2026-04-13T20:47:11.510718Z","steps":["trace[1788764341] 'agreement among raft nodes before linearized reading' (duration: 257.254328ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:11.510471Z","caller":"traceutil/trace.go:171","msg":"trace[997404850] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"545.78555ms","start":"2026-04-13T20:47:10.964671Z","end":"2026-04-13T20:47:11.510456Z","steps":["trace[997404850] 'agreement among raft nodes before linearized reading' (duration: 545.717608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.509221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.181866Z","time spent":"327.352058ms","remote":"127.0.0.1:50284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T20:47:11.510811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:10.964668Z","time spent":"546.111906ms","remote":"127.0.0.1:50252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-13T20:47:11.51091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.041158ms","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-13T20:47:11.510576Z","caller":"traceutil/trace.go:171","msg":"trace[1800050748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"447.394039ms","start":"2026-04-13T20:47:11.063176Z","end":"2026-04-13T20:47:11.51057Z","steps":["trace[1800050748] 'agreement among raft nodes before linearized reading' (duration: 446.327996ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:11.51094Z","caller":"traceutil/trace.go:171","msg":"trace[949381310] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:621; }","duration":"224.096629ms","start":"2026-04-13T20:47:11.286835Z","end":"2026-04-13T20:47:11.510931Z","steps":["trace[949381310] 'agreement among raft nodes before linearized reading' (duration: 224.050738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.510954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.06316Z","time spent":"447.784778ms","remote":"127.0.0.1:50282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-04-13T20:47:11.509934Z","caller":"traceutil/trace.go:171","msg":"trace[437600839] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:621; }","duration":"163.386353ms","start":"2026-04-13T20:47:11.34654Z","end":"2026-04-13T20:47:11.509926Z","steps":["trace[437600839] 'agreement among raft nodes before linearized reading' (duration: 163.343773ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:11.510128Z","caller":"traceutil/trace.go:171","msg":"trace[1395511278] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"575.678027ms","start":"2026-04-13T20:47:10.934437Z","end":"2026-04-13T20:47:11.510115Z","steps":["trace[1395511278] 'agreement among raft nodes before linearized reading' (duration: 574.370469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:11.511103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:10.934421Z","time spent":"576.672188ms","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T20:47:12.095465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.437746ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T20:47:12.095567Z","caller":"traceutil/trace.go:171","msg":"trace[1091507425] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"579.412032ms","start":"2026-04-13T20:47:11.516137Z","end":"2026-04-13T20:47:12.095549Z","steps":["trace[1091507425] 'process raft request' (duration: 134.802892ms)","trace[1091507425] 'compare' (duration: 444.313823ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:47:12.095755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.51578Z","time spent":"579.940713ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:47:12.114136Z","caller":"traceutil/trace.go:171","msg":"trace[1619168485] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"596.257283ms","start":"2026-04-13T20:47:11.517831Z","end":"2026-04-13T20:47:12.114088Z","steps":["trace[1619168485] 'process raft request' (duration: 595.964277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.11431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.284111ms","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-13T20:47:12.114448Z","caller":"traceutil/trace.go:171","msg":"trace[1648069450] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"488.477287ms","start":"2026-04-13T20:47:11.625958Z","end":"2026-04-13T20:47:12.114436Z","steps":["trace[1648069450] 'agreement among raft nodes before linearized reading' (duration: 488.239582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.11451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.625949Z","time spent":"488.536428ms","remote":"127.0.0.1:50330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-13T20:47:12.114121Z","caller":"traceutil/trace.go:171","msg":"trace[1498835403] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:643; }","duration":"488.024705ms","start":"2026-04-13T20:47:11.625982Z","end":"2026-04-13T20:47:12.114007Z","steps":["trace[1498835403] 'read index received' (duration: 24.94342ms)","trace[1498835403] 'applied index is now lower than readState.Index' (duration: 463.080405ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:47:12.114563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.517814Z","time spent":"596.512058ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:47:12.114198Z","caller":"traceutil/trace.go:171","msg":"trace[2113292285] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"545.598284ms","start":"2026-04-13T20:47:11.568579Z","end":"2026-04-13T20:47:12.114177Z","steps":["trace[2113292285] 'process raft request' (duration: 545.39001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.114761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.56856Z","time spent":"546.161758ms","remote":"127.0.0.1:38260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T20:47:12.115139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.202923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:12.115173Z","caller":"traceutil/trace.go:171","msg":"trace[1072173304] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"174.266214ms","start":"2026-04-13T20:47:11.940898Z","end":"2026-04-13T20:47:12.115165Z","steps":["trace[1072173304] 'agreement among raft nodes before linearized reading' (duration: 174.194513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.115272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.374537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T20:47:12.11533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.249046ms","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-13T20:47:12.115411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.928342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:12.115408Z","caller":"traceutil/trace.go:171","msg":"trace[1093397556] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"100.38028ms","start":"2026-04-13T20:47:12.015011Z","end":"2026-04-13T20:47:12.115391Z","steps":["trace[1093397556] 'agreement among raft nodes before linearized reading' (duration: 100.219707ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:12.115441Z","caller":"traceutil/trace.go:171","msg":"trace[1976899968] 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:624; }","duration":"118.011064ms","start":"2026-04-13T20:47:11.997423Z","end":"2026-04-13T20:47:12.115434Z","steps":["trace[1976899968] 'agreement among raft nodes before linearized reading' (duration: 117.965193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.115428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.149552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:12.115369Z","caller":"traceutil/trace.go:171","msg":"trace[2138361697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"174.501709ms","start":"2026-04-13T20:47:11.940852Z","end":"2026-04-13T20:47:12.115354Z","steps":["trace[2138361697] 'agreement among raft nodes before linearized reading' (duration: 174.305845ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:12.115481Z","caller":"traceutil/trace.go:171","msg":"trace[1562535259] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"323.246355ms","start":"2026-04-13T20:47:11.792219Z","end":"2026-04-13T20:47:12.115465Z","steps":["trace[1562535259] 'agreement among raft nodes before linearized reading' (duration: 323.131812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.115545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.98083ms","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-13T20:47:12.115583Z","caller":"traceutil/trace.go:171","msg":"trace[1040979423] 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:624; }","duration":"348.022391ms","start":"2026-04-13T20:47:11.767549Z","end":"2026-04-13T20:47:12.115572Z","steps":["trace[1040979423] 'agreement among raft nodes before linearized reading' (duration: 347.951919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.115595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.233769ms","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-13T20:47:12.115618Z","caller":"traceutil/trace.go:171","msg":"trace[320397043] 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:624; }","duration":"118.28235ms","start":"2026-04-13T20:47:11.997329Z","end":"2026-04-13T20:47:12.115611Z","steps":["trace[320397043] 'agreement among raft nodes before linearized reading' (duration: 118.237349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.115618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.767524Z","time spent":"348.083562ms","remote":"127.0.0.1:50350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"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-13T20:47:12.115581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.792213Z","time spent":"323.350027ms","remote":"127.0.0.1:50366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-04-13T20:47:12.115739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.35867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:12.115768Z","caller":"traceutil/trace.go:171","msg":"trace[1613965236] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"147.407722ms","start":"2026-04-13T20:47:11.968354Z","end":"2026-04-13T20:47:12.115762Z","steps":["trace[1613965236] 'agreement among raft nodes before linearized reading' (duration: 147.356411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.115784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.216405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:12.11582Z","caller":"traceutil/trace.go:171","msg":"trace[1090413355] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"324.263566ms","start":"2026-04-13T20:47:11.791547Z","end":"2026-04-13T20:47:12.11581Z","steps":["trace[1090413355] 'agreement among raft nodes before linearized reading' (duration: 324.210075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.115856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.791542Z","time spent":"324.301667ms","remote":"127.0.0.1:50366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-13T20:47:12.115916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.125147ms","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-13T20:47:12.115982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.518391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T20:47:12.115991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.488801ms","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-13T20:47:12.116016Z","caller":"traceutil/trace.go:171","msg":"trace[1713613357] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"324.585952ms","start":"2026-04-13T20:47:11.791421Z","end":"2026-04-13T20:47:12.116007Z","steps":["trace[1713613357] 'agreement among raft nodes before linearized reading' (duration: 324.532841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.115964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.644451ms","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-13T20:47:12.116028Z","caller":"traceutil/trace.go:171","msg":"trace[1447199968] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"100.571452ms","start":"2026-04-13T20:47:12.015446Z","end":"2026-04-13T20:47:12.116018Z","steps":["trace[1447199968] 'agreement among raft nodes before linearized reading' (duration: 100.509081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.116049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.791403Z","time spent":"324.637035ms","remote":"127.0.0.1:50366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"info","ts":"2026-04-13T20:47:12.116109Z","caller":"traceutil/trace.go:171","msg":"trace[169752829] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"221.773695ms","start":"2026-04-13T20:47:11.894271Z","end":"2026-04-13T20:47:12.116045Z","steps":["trace[169752829] 'agreement among raft nodes before linearized reading' (duration: 221.650301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.116189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.316398ms","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-13T20:47:12.116224Z","caller":"traceutil/trace.go:171","msg":"trace[1522944905] 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:624; }","duration":"348.362729ms","start":"2026-04-13T20:47:11.767853Z","end":"2026-04-13T20:47:12.116216Z","steps":["trace[1522944905] 'agreement among raft nodes before linearized reading' (duration: 348.307647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.116253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.767847Z","time spent":"348.39647ms","remote":"127.0.0.1:50350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"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-13T20:47:12.116295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.062817ms","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-13T20:47:12.116358Z","caller":"traceutil/trace.go:171","msg":"trace[1625416536] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"374.172809ms","start":"2026-04-13T20:47:11.742173Z","end":"2026-04-13T20:47:12.116346Z","steps":["trace[1625416536] 'agreement among raft nodes before linearized reading' (duration: 374.062807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.116383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.079401ms","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":"warn","ts":"2026-04-13T20:47:12.116399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.742157Z","time spent":"374.229871ms","remote":"127.0.0.1:50346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T20:47:12.116189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.703186ms","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":"info","ts":"2026-04-13T20:47:12.116435Z","caller":"traceutil/trace.go:171","msg":"trace[532311911] 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:624; }","duration":"349.009953ms","start":"2026-04-13T20:47:11.767415Z","end":"2026-04-13T20:47:12.116424Z","steps":["trace[532311911] 'agreement among raft nodes before linearized reading' (duration: 348.654755ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:12.116425Z","caller":"traceutil/trace.go:171","msg":"trace[1918754466] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"222.179294ms","start":"2026-04-13T20:47:11.894235Z","end":"2026-04-13T20:47:12.116415Z","steps":["trace[1918754466] 'agreement among raft nodes before linearized reading' (duration: 222.065511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.116477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.767404Z","time spent":"349.060174ms","remote":"127.0.0.1:50350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"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-13T20:47:12.116524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.199089ms","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-13T20:47:12.116557Z","caller":"traceutil/trace.go:171","msg":"trace[1483186042] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"374.269681ms","start":"2026-04-13T20:47:11.742281Z","end":"2026-04-13T20:47:12.116551Z","steps":["trace[1483186042] 'agreement among raft nodes before linearized reading' (duration: 374.21938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.116578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.742255Z","time spent":"374.317352ms","remote":"127.0.0.1:50346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T20:47:12.115336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.329939ms","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-13T20:47:12.116707Z","caller":"traceutil/trace.go:171","msg":"trace[1042568840] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"101.722259ms","start":"2026-04-13T20:47:12.014976Z","end":"2026-04-13T20:47:12.116698Z","steps":["trace[1042568840] 'agreement among raft nodes before linearized reading' (duration: 100.328898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.116692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.590205ms","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":"warn","ts":"2026-04-13T20:47:12.116323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.077306ms","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":"info","ts":"2026-04-13T20:47:12.116815Z","caller":"traceutil/trace.go:171","msg":"trace[2117762129] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:624; }","duration":"265.731608ms","start":"2026-04-13T20:47:11.851072Z","end":"2026-04-13T20:47:12.116803Z","steps":["trace[2117762129] 'agreement among raft nodes before linearized reading' (duration: 265.553294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.115374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.515794ms","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-13T20:47:12.117043Z","caller":"traceutil/trace.go:171","msg":"trace[1998969168] 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:624; }","duration":"119.204911ms","start":"2026-04-13T20:47:11.997831Z","end":"2026-04-13T20:47:12.117035Z","steps":["trace[1998969168] 'agreement among raft nodes before linearized reading' (duration: 117.521434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.117099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.137305ms","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":"warn","ts":"2026-04-13T20:47:12.115133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.014168ms","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-13T20:47:12.117142Z","caller":"traceutil/trace.go:171","msg":"trace[818612818] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"491.059612ms","start":"2026-04-13T20:47:11.626073Z","end":"2026-04-13T20:47:12.117133Z","steps":["trace[818612818] 'agreement among raft nodes before linearized reading' (duration: 488.981697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.117182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.626054Z","time spent":"491.109064ms","remote":"127.0.0.1:50330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-13T20:47:12.117248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.881772ms","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-13T20:47:12.117285Z","caller":"traceutil/trace.go:171","msg":"trace[297753699] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:624; }","duration":"266.943313ms","start":"2026-04-13T20:47:11.850332Z","end":"2026-04-13T20:47:12.117275Z","steps":["trace[297753699] 'agreement among raft nodes before linearized reading' (duration: 266.868712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.117323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.536028ms","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-13T20:47:12.117352Z","caller":"traceutil/trace.go:171","msg":"trace[314861470] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"149.567879ms","start":"2026-04-13T20:47:11.967776Z","end":"2026-04-13T20:47:12.117344Z","steps":["trace[314861470] 'agreement among raft nodes before linearized reading' (duration: 149.512977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.11715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.696948ms","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-13T20:47:12.117393Z","caller":"traceutil/trace.go:171","msg":"trace[2093962093] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:624; }","duration":"266.970864ms","start":"2026-04-13T20:47:11.850406Z","end":"2026-04-13T20:47:12.117377Z","steps":["trace[2093962093] 'agreement among raft nodes before linearized reading' (duration: 266.701719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.117436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.212852ms","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-13T20:47:12.117515Z","caller":"traceutil/trace.go:171","msg":"trace[474610419] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"310.329196ms","start":"2026-04-13T20:47:11.807167Z","end":"2026-04-13T20:47:12.117496Z","steps":["trace[474610419] 'agreement among raft nodes before linearized reading' (duration: 310.183732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.117535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.033562ms","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":"info","ts":"2026-04-13T20:47:12.117565Z","caller":"traceutil/trace.go:171","msg":"trace[1471684323] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"311.090032ms","start":"2026-04-13T20:47:11.806466Z","end":"2026-04-13T20:47:12.117556Z","steps":["trace[1471684323] 'agreement among raft nodes before linearized reading' (duration: 311.041461ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:12.116846Z","caller":"traceutil/trace.go:171","msg":"trace[165150027] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"373.636628ms","start":"2026-04-13T20:47:11.743202Z","end":"2026-04-13T20:47:12.116838Z","steps":["trace[165150027] 'agreement among raft nodes before linearized reading' (duration: 373.007954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.117602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.806451Z","time spent":"311.141664ms","remote":"127.0.0.1:50370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-13T20:47:12.117602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.743182Z","time spent":"374.412085ms","remote":"127.0.0.1:50330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"info","ts":"2026-04-13T20:47:12.117577Z","caller":"traceutil/trace.go:171","msg":"trace[1492469797] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"176.474453ms","start":"2026-04-13T20:47:11.940949Z","end":"2026-04-13T20:47:12.117423Z","steps":["trace[1492469797] 'agreement among raft nodes before linearized reading' (duration: 176.119035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.117565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.807156Z","time spent":"310.398577ms","remote":"127.0.0.1:50370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-13T20:47:12.117738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.715144ms","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-13T20:47:12.117775Z","caller":"traceutil/trace.go:171","msg":"trace[1882191095] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"310.802346ms","start":"2026-04-13T20:47:11.806963Z","end":"2026-04-13T20:47:12.117765Z","steps":["trace[1882191095] 'agreement among raft nodes before linearized reading' (duration: 310.730524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:12.117819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:11.806938Z","time spent":"310.870927ms","remote":"127.0.0.1:50370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-04-13T20:47:12.115946Z","caller":"traceutil/trace.go:171","msg":"trace[1329574109] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"148.184188ms","start":"2026-04-13T20:47:11.967755Z","end":"2026-04-13T20:47:12.115939Z","steps":["trace[1329574109] 'agreement among raft nodes before linearized reading' (duration: 148.136767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:13.693356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:12.994592Z","time spent":"698.727099ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-13T20:47:13.693451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.451173425s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T20:47:13.693531Z","caller":"traceutil/trace.go:171","msg":"trace[576272073] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"1.535271675s","start":"2026-04-13T20:47:12.158246Z","end":"2026-04-13T20:47:13.693518Z","steps":["trace[576272073] 'read index received' (duration: 83.944997ms)","trace[576272073] 'applied index is now lower than readState.Index' (duration: 1.451325598s)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:47:13.693659Z","caller":"traceutil/trace.go:171","msg":"trace[667181740] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.556850861s","start":"2026-04-13T20:47:12.136794Z","end":"2026-04-13T20:47:13.693644Z","steps":["trace[667181740] 'process raft request' (duration: 105.42631ms)","trace[667181740] 'compare' (duration: 1.451067453s)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:47:13.6937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:12.136781Z","time spent":"1.556902453s","remote":"127.0.0.1:38200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T20:47:13.694101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.535836009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:13.694171Z","caller":"traceutil/trace.go:171","msg":"trace[526375371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"1.535949682s","start":"2026-04-13T20:47:12.158195Z","end":"2026-04-13T20:47:13.694145Z","steps":["trace[526375371] 'agreement among raft nodes before linearized reading' (duration: 1.535757747s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:13.69421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:12.158171Z","time spent":"1.536033233s","remote":"127.0.0.1:38004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T20:47:13.69477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.25730721s","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-13T20:47:13.694817Z","caller":"traceutil/trace.go:171","msg":"trace[1114772459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"1.257390642s","start":"2026-04-13T20:47:12.437415Z","end":"2026-04-13T20:47:13.694806Z","steps":["trace[1114772459] 'agreement among raft nodes before linearized reading' (duration: 1.256389659s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:13.69485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:12.437395Z","time spent":"1.257448274s","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T20:47:13.695609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.238846384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-13T20:47:13.695666Z","caller":"traceutil/trace.go:171","msg":"trace[1057868967] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"1.238929016s","start":"2026-04-13T20:47:12.456724Z","end":"2026-04-13T20:47:13.695653Z","steps":["trace[1057868967] 'agreement among raft nodes before linearized reading' (duration: 1.237247978s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:13.695704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:12.456714Z","time spent":"1.238982137s","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T20:47:19.149635Z","caller":"traceutil/trace.go:171","msg":"trace[413248723] linearizableReadLoop","detail":"{readStateIndex:728; appliedIndex:727; }","duration":"203.908838ms","start":"2026-04-13T20:47:18.945702Z","end":"2026-04-13T20:47:19.149611Z","steps":["trace[413248723] 'read index received' (duration: 203.59098ms)","trace[413248723] 'applied index is now lower than readState.Index' (duration: 316.968µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:47:19.149809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.104292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-04-13T20:47:19.149926Z","caller":"traceutil/trace.go:171","msg":"trace[1050612125] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:705; }","duration":"204.200674ms","start":"2026-04-13T20:47:18.945682Z","end":"2026-04-13T20:47:19.149883Z","steps":["trace[1050612125] 'agreement among raft nodes before linearized reading' (duration: 204.01763ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:19.150225Z","caller":"traceutil/trace.go:171","msg":"trace[900519650] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"285.840083ms","start":"2026-04-13T20:47:18.86433Z","end":"2026-04-13T20:47:19.15017Z","steps":["trace[900519650] 'process raft request' (duration: 285.057735ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:19.321724Z","caller":"traceutil/trace.go:171","msg":"trace[1921582360] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"144.700284ms","start":"2026-04-13T20:47:19.176997Z","end":"2026-04-13T20:47:19.321698Z","steps":["trace[1921582360] 'process raft request' (duration: 144.50478ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:23.724587Z","caller":"traceutil/trace.go:171","msg":"trace[2024550476] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"104.172543ms","start":"2026-04-13T20:47:23.620385Z","end":"2026-04-13T20:47:23.724557Z","steps":["trace[2024550476] 'process raft request' (duration: 103.978378ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:23.897101Z","caller":"traceutil/trace.go:171","msg":"trace[493214846] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"136.216854ms","start":"2026-04-13T20:47:23.760859Z","end":"2026-04-13T20:47:23.897076Z","steps":["trace[493214846] 'process raft request' (duration: 135.876415ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:29.347797Z","caller":"traceutil/trace.go:171","msg":"trace[144141716] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"155.158924ms","start":"2026-04-13T20:47:29.192614Z","end":"2026-04-13T20:47:29.347773Z","steps":["trace[144141716] 'process raft request' (duration: 155.028401ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:29.54965Z","caller":"traceutil/trace.go:171","msg":"trace[54812657] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"194.46647ms","start":"2026-04-13T20:47:29.355144Z","end":"2026-04-13T20:47:29.54961Z","steps":["trace[54812657] 'process raft request' (duration: 130.303237ms)","trace[54812657] 'compare' (duration: 63.948327ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:47:30.542045Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313095183484030273,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-13T20:47:30.825084Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.021227524s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T20:47:30.825734Z","caller":"traceutil/trace.go:171","msg":"trace[1641677912] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"1.049714598s","start":"2026-04-13T20:47:29.77588Z","end":"2026-04-13T20:47:30.825595Z","steps":["trace[1641677912] 'process raft request' (duration: 1.049453651s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:30.826127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:29.775845Z","time spent":"1.049976864s","remote":"127.0.0.1:38260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:47:30.833967Z","caller":"traceutil/trace.go:171","msg":"trace[1766962318] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:817; }","duration":"792.578179ms","start":"2026-04-13T20:47:30.041319Z","end":"2026-04-13T20:47:30.833898Z","steps":["trace[1766962318] 'read index received' (duration: 784.078279ms)","trace[1766962318] 'applied index is now lower than readState.Index' (duration: 8.49812ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:47:30.834118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.791664ms","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-13T20:47:30.834222Z","caller":"traceutil/trace.go:171","msg":"trace[397754511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"792.943728ms","start":"2026-04-13T20:47:30.041264Z","end":"2026-04-13T20:47:30.834208Z","steps":["trace[397754511] 'agreement among raft nodes before linearized reading' (duration: 792.729252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:30.834262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:30.04124Z","time spent":"793.01241ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T20:47:30.8345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.264237ms","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-13T20:47:30.834557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.142479ms","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-13T20:47:30.834624Z","caller":"traceutil/trace.go:171","msg":"trace[810801465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:792; }","duration":"500.242932ms","start":"2026-04-13T20:47:30.334364Z","end":"2026-04-13T20:47:30.834607Z","steps":["trace[810801465] 'agreement among raft nodes before linearized reading' (duration: 500.065436ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:30.834575Z","caller":"traceutil/trace.go:171","msg":"trace[291058229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"546.374941ms","start":"2026-04-13T20:47:30.288188Z","end":"2026-04-13T20:47:30.834563Z","steps":["trace[291058229] 'agreement among raft nodes before linearized reading' (duration: 546.213775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:30.834714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:30.334342Z","time spent":"500.357564ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T20:47:30.834745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:30.288165Z","time spent":"546.567026ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T20:47:30.834512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.553281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:47:30.834827Z","caller":"traceutil/trace.go:171","msg":"trace[576891374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:792; }","duration":"674.903801ms","start":"2026-04-13T20:47:30.159913Z","end":"2026-04-13T20:47:30.834817Z","steps":["trace[576891374] 'agreement among raft nodes before linearized reading' (duration: 674.564511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:30.834854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:30.159897Z","time spent":"674.950822ms","remote":"127.0.0.1:38004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T20:47:30.835033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.901426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-13T20:47:30.835075Z","caller":"traceutil/trace.go:171","msg":"trace[727043352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"789.959828ms","start":"2026-04-13T20:47:30.045103Z","end":"2026-04-13T20:47:30.835063Z","steps":["trace[727043352] 'agreement among raft nodes before linearized reading' (duration: 789.236728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:47:30.835211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:47:30.045095Z","time spent":"790.07001ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T20:47:35.034Z","caller":"traceutil/trace.go:171","msg":"trace[96022081] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:838; }","duration":"122.024767ms","start":"2026-04-13T20:47:34.911951Z","end":"2026-04-13T20:47:35.033975Z","steps":["trace[96022081] 'read index received' (duration: 18.303043ms)","trace[96022081] 'applied index is now lower than readState.Index' (duration: 103.720804ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:47:35.034062Z","caller":"traceutil/trace.go:171","msg":"trace[33960955] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"133.690834ms","start":"2026-04-13T20:47:34.900318Z","end":"2026-04-13T20:47:35.034008Z","steps":["trace[33960955] 'process raft request' (duration: 98.992695ms)","trace[33960955] 'compare' (duration: 34.558555ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:47:35.034406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.383997ms","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-13T20:47:35.034502Z","caller":"traceutil/trace.go:171","msg":"trace[1268597932] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:811; }","duration":"122.551582ms","start":"2026-04-13T20:47:34.911929Z","end":"2026-04-13T20:47:35.034481Z","steps":["trace[1268597932] 'agreement among raft nodes before linearized reading' (duration: 122.231043ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:45.713923Z","caller":"traceutil/trace.go:171","msg":"trace[748670413] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"148.379443ms","start":"2026-04-13T20:47:45.565506Z","end":"2026-04-13T20:47:45.713885Z","steps":["trace[748670413] 'process raft request' (duration: 52.991077ms)","trace[748670413] 'compare' (duration: 94.936392ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:47:45.877816Z","caller":"traceutil/trace.go:171","msg":"trace[814534355] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"155.2048ms","start":"2026-04-13T20:47:45.722579Z","end":"2026-04-13T20:47:45.877783Z","steps":["trace[814534355] 'process raft request' (duration: 155.022393ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:52.409245Z","caller":"traceutil/trace.go:171","msg":"trace[763971908] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"193.372426ms","start":"2026-04-13T20:47:52.215848Z","end":"2026-04-13T20:47:52.40922Z","steps":["trace[763971908] 'process raft request' (duration: 193.1845ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:47:53.315635Z","caller":"traceutil/trace.go:171","msg":"trace[487348749] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"103.888203ms","start":"2026-04-13T20:47:53.211698Z","end":"2026-04-13T20:47:53.315586Z","steps":["trace[487348749] 'process raft request' (duration: 33.926718ms)","trace[487348749] 'compare' (duration: 69.78435ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:48:01.332252Z","caller":"traceutil/trace.go:171","msg":"trace[978211103] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"120.851267ms","start":"2026-04-13T20:48:01.211365Z","end":"2026-04-13T20:48:01.332217Z","steps":["trace[978211103] 'process raft request' (duration: 120.517326ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:48:26.816427Z","caller":"traceutil/trace.go:171","msg":"trace[94902104] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"123.054221ms","start":"2026-04-13T20:48:26.693346Z","end":"2026-04-13T20:48:26.8164Z","steps":["trace[94902104] 'process raft request' (duration: 122.884815ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:48:33.948215Z","caller":"traceutil/trace.go:171","msg":"trace[2055356358] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"202.807831ms","start":"2026-04-13T20:48:33.74537Z","end":"2026-04-13T20:48:33.948178Z","steps":["trace[2055356358] 'process raft request' (duration: 199.000741ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:48:43.079703Z","caller":"traceutil/trace.go:171","msg":"trace[1781358204] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"170.167514ms","start":"2026-04-13T20:48:42.909518Z","end":"2026-04-13T20:48:43.079685Z","steps":["trace[1781358204] 'process raft request' (duration: 170.049599ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:48:43.885601Z","caller":"traceutil/trace.go:171","msg":"trace[89160433] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"100.775647ms","start":"2026-04-13T20:48:43.784767Z","end":"2026-04-13T20:48:43.885543Z","steps":["trace[89160433] 'process raft request' (duration: 51.73978ms)","trace[89160433] 'compare' (duration: 48.850691ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:48:55.301556Z","caller":"traceutil/trace.go:171","msg":"trace[144134525] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"161.366626ms","start":"2026-04-13T20:48:55.14016Z","end":"2026-04-13T20:48:55.301526Z","steps":["trace[144134525] 'process raft request' (duration: 161.193109ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:48:57.052393Z","caller":"traceutil/trace.go:171","msg":"trace[1720656800] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"224.557418ms","start":"2026-04-13T20:48:56.827798Z","end":"2026-04-13T20:48:57.052356Z","steps":["trace[1720656800] 'process raft request' (duration: 224.314599ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:49:08.099996Z","caller":"traceutil/trace.go:171","msg":"trace[1551835676] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"127.534747ms","start":"2026-04-13T20:49:07.972439Z","end":"2026-04-13T20:49:08.099973Z","steps":["trace[1551835676] 'process raft request' (duration: 127.437243ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:49:08.427764Z","caller":"traceutil/trace.go:171","msg":"trace[1271327610] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"126.432655ms","start":"2026-04-13T20:49:08.3013Z","end":"2026-04-13T20:49:08.427733Z","steps":["trace[1271327610] 'process raft request' (duration: 124.161817ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:49:08.427778Z","caller":"traceutil/trace.go:171","msg":"trace[1773753246] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"123.547202ms","start":"2026-04-13T20:49:08.304195Z","end":"2026-04-13T20:49:08.427742Z","steps":["trace[1773753246] 'process raft request' (duration: 123.446748ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:49:08.550462Z","caller":"traceutil/trace.go:171","msg":"trace[1783389922] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1300; }","duration":"108.077496ms","start":"2026-04-13T20:49:08.44236Z","end":"2026-04-13T20:49:08.550438Z","steps":["trace[1783389922] 'read index received' (duration: 105.933761ms)","trace[1783389922] 'applied index is now lower than readState.Index' (duration: 2.142845ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:49:08.55061Z","caller":"traceutil/trace.go:171","msg":"trace[104161524] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"109.378606ms","start":"2026-04-13T20:49:08.441206Z","end":"2026-04-13T20:49:08.550584Z","steps":["trace[104161524] 'process raft request' (duration: 107.148508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:08.550638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.245072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7d6ff191-785a-48ed-9f62-74ca99103631\" ","response":"range_response_count:1 size:3578"} {"level":"info","ts":"2026-04-13T20:49:08.550694Z","caller":"traceutil/trace.go:171","msg":"trace[1818416997] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7d6ff191-785a-48ed-9f62-74ca99103631; range_end:; response_count:1; response_revision:1253; }","duration":"108.333515ms","start":"2026-04-13T20:49:08.442342Z","end":"2026-04-13T20:49:08.550676Z","steps":["trace[1818416997] 'agreement among raft nodes before linearized reading' (duration: 108.219861ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:49:16.632037Z","caller":"traceutil/trace.go:171","msg":"trace[211840193] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"153.081833ms","start":"2026-04-13T20:49:16.478931Z","end":"2026-04-13T20:49:16.632013Z","steps":["trace[211840193] 'process raft request' (duration: 152.935887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:16.77245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.09357ms","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-13T20:49:16.772555Z","caller":"traceutil/trace.go:171","msg":"trace[844775638] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1302; }","duration":"103.224095ms","start":"2026-04-13T20:49:16.669312Z","end":"2026-04-13T20:49:16.772536Z","steps":["trace[844775638] 'range keys from in-memory index tree' (duration: 102.84119ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:24.337475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.201951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:49:24.337549Z","caller":"traceutil/trace.go:171","msg":"trace[2086650406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1330; }","duration":"179.322805ms","start":"2026-04-13T20:49:24.15821Z","end":"2026-04-13T20:49:24.337532Z","steps":["trace[2086650406] 'range keys from in-memory index tree' (duration: 179.128268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:24.337807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.410118ms","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-13T20:49:24.337855Z","caller":"traceutil/trace.go:171","msg":"trace[1942615659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1330; }","duration":"158.487981ms","start":"2026-04-13T20:49:24.179354Z","end":"2026-04-13T20:49:24.337842Z","steps":["trace[1942615659] 'range keys from in-memory index tree' (duration: 158.280203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:24.337523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.299937ms","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-13T20:49:24.338504Z","caller":"traceutil/trace.go:171","msg":"trace[191162858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1330; }","duration":"356.330097ms","start":"2026-04-13T20:49:23.98215Z","end":"2026-04-13T20:49:24.338481Z","steps":["trace[191162858] 'range keys from in-memory index tree' (duration: 355.099789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:24.33919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:49:23.982128Z","time spent":"356.847988ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-13T20:49:24.580658Z","caller":"traceutil/trace.go:171","msg":"trace[738091267] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"239.109208ms","start":"2026-04-13T20:49:24.341521Z","end":"2026-04-13T20:49:24.58063Z","steps":["trace[738091267] 'process raft request' (duration: 143.536513ms)","trace[738091267] 'compare' (duration: 95.394678ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:49:24.580774Z","caller":"traceutil/trace.go:171","msg":"trace[159241502] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"238.276004ms","start":"2026-04-13T20:49:24.342463Z","end":"2026-04-13T20:49:24.580739Z","steps":["trace[159241502] 'process raft request' (duration: 238.123338ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:49:24.979488Z","caller":"traceutil/trace.go:171","msg":"trace[1195668394] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"306.215433ms","start":"2026-04-13T20:49:24.673242Z","end":"2026-04-13T20:49:24.979458Z","steps":["trace[1195668394] 'process raft request' (duration: 305.91633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:24.979661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:49:24.673224Z","time spent":"306.352908ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:49:24.97965Z","caller":"traceutil/trace.go:171","msg":"trace[1090888268] linearizableReadLoop","detail":"{readStateIndex:1385; appliedIndex:1384; }","duration":"253.873118ms","start":"2026-04-13T20:49:24.725504Z","end":"2026-04-13T20:49:24.979377Z","steps":["trace[1090888268] 'read index received' (duration: 253.648029ms)","trace[1090888268] 'applied index is now lower than readState.Index' (duration: 223.969µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:49:24.979938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.1574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-13T20:49:24.980112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.826265ms","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-13T20:49:24.980152Z","caller":"traceutil/trace.go:171","msg":"trace[852085118] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1334; }","duration":"166.902448ms","start":"2026-04-13T20:49:24.813238Z","end":"2026-04-13T20:49:24.98014Z","steps":["trace[852085118] 'agreement among raft nodes before linearized reading' (duration: 166.798974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:24.979591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.076797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:49:24.980196Z","caller":"traceutil/trace.go:171","msg":"trace[1655859049] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1334; }","duration":"254.728032ms","start":"2026-04-13T20:49:24.725453Z","end":"2026-04-13T20:49:24.980181Z","steps":["trace[1655859049] 'agreement among raft nodes before linearized reading' (duration: 254.083937ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:49:24.980495Z","caller":"traceutil/trace.go:171","msg":"trace[476308137] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:1334; }","duration":"223.313745ms","start":"2026-04-13T20:49:24.756694Z","end":"2026-04-13T20:49:24.980008Z","steps":["trace[476308137] 'agreement among raft nodes before linearized reading' (duration: 223.061435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:25.29511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.505567ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-04-13T20:49:25.295451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:49:24.986187Z","time spent":"309.259836ms","remote":"127.0.0.1:38052","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-13T20:49:25.295651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.625821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:49:25.295732Z","caller":"traceutil/trace.go:171","msg":"trace[1431271350] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1335; }","duration":"308.741035ms","start":"2026-04-13T20:49:24.986975Z","end":"2026-04-13T20:49:25.295716Z","steps":["trace[1431271350] 'agreement among raft nodes before linearized reading' (duration: 308.60904ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:49:25.295255Z","caller":"traceutil/trace.go:171","msg":"trace[780079624] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1386; }","duration":"308.226544ms","start":"2026-04-13T20:49:24.987006Z","end":"2026-04-13T20:49:25.295232Z","steps":["trace[780079624] 'read index received' (duration: 31.315623ms)","trace[780079624] 'applied index is now lower than readState.Index' (duration: 276.908681ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:49:25.295777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:49:24.986959Z","time spent":"308.808017ms","remote":"127.0.0.1:38158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"warn","ts":"2026-04-13T20:49:25.295937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.156154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:49:25.296014Z","caller":"traceutil/trace.go:171","msg":"trace[79654188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1335; }","duration":"135.265698ms","start":"2026-04-13T20:49:25.160733Z","end":"2026-04-13T20:49:25.295998Z","steps":["trace[79654188] 'agreement among raft nodes before linearized reading' (duration: 135.137102ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:49:26.062976Z","caller":"traceutil/trace.go:171","msg":"trace[999173729] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"520.071812ms","start":"2026-04-13T20:49:25.542876Z","end":"2026-04-13T20:49:26.062948Z","steps":["trace[999173729] 'process raft request' (duration: 519.921266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:49:26.06314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:49:25.542852Z","time spent":"520.213988ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:49:37.200093Z","caller":"traceutil/trace.go:171","msg":"trace[844678258] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"112.849698ms","start":"2026-04-13T20:49:37.087224Z","end":"2026-04-13T20:49:37.200074Z","steps":["trace[844678258] 'process raft request' (duration: 54.411613ms)","trace[844678258] 'compare' (duration: 58.257398ms)"],"step_count":2}