{"level":"warn","ts":"2026-03-26T17:55:36.789324Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T17:55:36.78943Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157: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.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-03-26T17:55:36.789516Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T17:55:36.789532Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-03-26T17:55:36.789561Z","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-03-26T17:55:36.79041Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-03-26T17:55:36.7905Z","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.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-03-26T17:55:36.795185Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.409174ms"} {"level":"info","ts":"2026-03-26T17:55:36.801723Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-03-26T17:55:36.801808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-03-26T17:55:36.801845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-03-26T17:55:36.801855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-26T17:55:36.801867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-03-26T17:55:36.801912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-03-26T17:55:36.808764Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-26T17:55:36.809907Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-26T17:55:36.811708Z","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-03-26T17:55:36.814489Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-26T17:55:36.814955Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-26T17:55:36.815185Z","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-03-26T17:55:36.815246Z","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-03-26T17:55:36.815257Z","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-03-26T17:55:36.817009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-03-26T17:55:36.817456Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-03-26T17:55:36.820733Z","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-03-26T17:55:36.820843Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-03-26T17:55:36.821633Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-03-26T17:55:36.821872Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-26T17:55:36.821979Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-26T17:55:37.00244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-03-26T17:55:37.002498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-03-26T17:55:37.002537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-03-26T17:55:37.002557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-03-26T17:55:37.002569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-03-26T17:55:37.002635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-03-26T17:55:37.002649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-03-26T17:55:37.003819Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T17:55:37.00466Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-03-26T17:55:37.00483Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T17:55:37.004886Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T17:55:37.005227Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-26T17:55:37.005276Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-26T17:55:37.00544Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T17:55:37.005652Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T17:55:37.005741Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T17:55:37.008099Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-03-26T17:55:37.008373Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-26T17:55:50.053794Z","caller":"traceutil/trace.go:171","msg":"trace[1906420564] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"155.142305ms","start":"2026-03-26T17:55:49.898627Z","end":"2026-03-26T17:55:50.05377Z","steps":["trace[1906420564] 'process raft request' (duration: 154.945409ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:55:50.186003Z","caller":"traceutil/trace.go:171","msg":"trace[988271561] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"117.325094ms","start":"2026-03-26T17:55:50.068657Z","end":"2026-03-26T17:55:50.185982Z","steps":["trace[988271561] 'process raft request' (duration: 110.77295ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:02.889938Z","caller":"traceutil/trace.go:171","msg":"trace[1564646979] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"154.054264ms","start":"2026-03-26T17:56:02.735857Z","end":"2026-03-26T17:56:02.889911Z","steps":["trace[1564646979] 'process raft request' (duration: 153.90787ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:04.739683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.229219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-26T17:56:04.739813Z","caller":"traceutil/trace.go:171","msg":"trace[549374664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:461; }","duration":"387.406544ms","start":"2026-03-26T17:56:04.352385Z","end":"2026-03-26T17:56:04.739792Z","steps":["trace[549374664] 'range keys from in-memory index tree' (duration: 387.101066ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:04.739808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.804009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"warn","ts":"2026-03-26T17:56:04.739857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:04.352367Z","time spent":"387.480377ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-26T17:56:04.739909Z","caller":"traceutil/trace.go:171","msg":"trace[1826988313] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:461; }","duration":"583.003705ms","start":"2026-03-26T17:56:04.156885Z","end":"2026-03-26T17:56:04.739888Z","steps":["trace[1826988313] 'range keys from in-memory index tree' (duration: 582.656155ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:04.739917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.495296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"warn","ts":"2026-03-26T17:56:04.739953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:04.156858Z","time spent":"583.086268ms","remote":"127.0.0.1:41340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":542,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "} {"level":"warn","ts":"2026-03-26T17:56:04.739944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.247294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329944"} {"level":"info","ts":"2026-03-26T17:56:04.74001Z","caller":"traceutil/trace.go:171","msg":"trace[273146194] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:461; }","duration":"481.62665ms","start":"2026-03-26T17:56:04.258353Z","end":"2026-03-26T17:56:04.73998Z","steps":["trace[273146194] 'range keys from in-memory index tree' (duration: 481.362492ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:04.740052Z","caller":"traceutil/trace.go:171","msg":"trace[1547009062] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:461; }","duration":"556.393088ms","start":"2026-03-26T17:56:04.183633Z","end":"2026-03-26T17:56:04.740026Z","steps":["trace[1547009062] 'range keys from in-memory index tree' (duration: 556.075769ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:04.740099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:04.183616Z","time spent":"556.473821ms","remote":"127.0.0.1:41222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329966,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-03-26T17:56:04.740054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:04.258333Z","time spent":"481.711011ms","remote":"127.0.0.1:41340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":560,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" "} {"level":"info","ts":"2026-03-26T17:56:04.90927Z","caller":"traceutil/trace.go:171","msg":"trace[848315709] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"163.53556ms","start":"2026-03-26T17:56:04.745712Z","end":"2026-03-26T17:56:04.909247Z","steps":["trace[848315709] 'process raft request' (duration: 163.157419ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:05.051948Z","caller":"traceutil/trace.go:171","msg":"trace[1808947033] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"138.307383ms","start":"2026-03-26T17:56:04.913608Z","end":"2026-03-26T17:56:05.051915Z","steps":["trace[1808947033] 'process raft request' (duration: 131.355828ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:07.073512Z","caller":"traceutil/trace.go:171","msg":"trace[401884843] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"662.969178ms","start":"2026-03-26T17:56:06.410511Z","end":"2026-03-26T17:56:07.07348Z","steps":["trace[401884843] 'process raft request' (duration: 662.927527ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:07.073524Z","caller":"traceutil/trace.go:171","msg":"trace[983709712] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"663.257596ms","start":"2026-03-26T17:56:06.41024Z","end":"2026-03-26T17:56:07.073498Z","steps":["trace[983709712] 'process raft request' (duration: 642.540185ms)","trace[983709712] 'compare' (duration: 20.526026ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:56:07.074025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:06.410484Z","time spent":"663.084751ms","remote":"127.0.0.1:41170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:56:07.074097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:06.410226Z","time spent":"663.353019ms","remote":"127.0.0.1:41170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T17:56:07.074264Z","caller":"traceutil/trace.go:171","msg":"trace[1943032561] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"646.569238ms","start":"2026-03-26T17:56:06.427684Z","end":"2026-03-26T17:56:07.074254Z","steps":["trace[1943032561] 'process raft request' (duration: 646.145956ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:07.074325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:06.427665Z","time spent":"646.62261ms","remote":"127.0.0.1:41170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:56:07.074428Z","caller":"traceutil/trace.go:171","msg":"trace[582449094] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"644.063598ms","start":"2026-03-26T17:56:06.430354Z","end":"2026-03-26T17:56:07.074417Z","steps":["trace[582449094] 'process raft request' (duration: 643.928744ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:07.074444Z","caller":"traceutil/trace.go:171","msg":"trace[353557852] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"645.181589ms","start":"2026-03-26T17:56:06.42924Z","end":"2026-03-26T17:56:07.074421Z","steps":["trace[353557852] 'process raft request' (duration: 644.940613ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:07.074512Z","caller":"traceutil/trace.go:171","msg":"trace[1709587489] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:517; }","duration":"160.989678ms","start":"2026-03-26T17:56:06.913505Z","end":"2026-03-26T17:56:07.074495Z","steps":["trace[1709587489] 'read index received' (duration: 139.311ms)","trace[1709587489] 'applied index is now lower than readState.Index' (duration: 21.677898ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:56:07.074551Z","caller":"traceutil/trace.go:171","msg":"trace[125769439] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"564.566067ms","start":"2026-03-26T17:56:06.509976Z","end":"2026-03-26T17:56:07.074542Z","steps":["trace[125769439] 'process raft request' (duration: 564.399542ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:07.074627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:06.509934Z","time spent":"564.67538ms","remote":"127.0.0.1:41170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T17:56:07.074642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:06.429233Z","time spent":"645.309203ms","remote":"127.0.0.1:41170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:56:07.074694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.199035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-26T17:56:07.074508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:06.430346Z","time spent":"644.109669ms","remote":"127.0.0.1:41170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:56:07.07473Z","caller":"traceutil/trace.go:171","msg":"trace[1675228240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:499; }","duration":"161.273737ms","start":"2026-03-26T17:56:06.913445Z","end":"2026-03-26T17:56:07.074719Z","steps":["trace[1675228240] 'agreement among raft nodes before linearized reading' (duration: 161.116162ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:08.232101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.013524ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-26T17:56:08.232212Z","caller":"traceutil/trace.go:171","msg":"trace[237613691] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"261.600573ms","start":"2026-03-26T17:56:07.970592Z","end":"2026-03-26T17:56:08.232193Z","steps":["trace[237613691] 'process raft request' (duration: 87.29172ms)","trace[237613691] 'compare' (duration: 173.802129ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:56:08.274754Z","caller":"traceutil/trace.go:171","msg":"trace[957644290] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"164.410495ms","start":"2026-03-26T17:56:08.110318Z","end":"2026-03-26T17:56:08.274729Z","steps":["trace[957644290] 'process raft request' (duration: 164.075625ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:08.791865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938290404220003962,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-26T17:56:09.062342Z","caller":"traceutil/trace.go:171","msg":"trace[450754697] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"773.503332ms","start":"2026-03-26T17:56:08.288805Z","end":"2026-03-26T17:56:09.062308Z","steps":["trace[450754697] 'process raft request' (duration: 770.624221ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:09.062462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:08.288786Z","time spent":"773.618736ms","remote":"127.0.0.1:41170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:56:09.071438Z","caller":"traceutil/trace.go:171","msg":"trace[1845207232] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:567; }","duration":"780.157299ms","start":"2026-03-26T17:56:08.291243Z","end":"2026-03-26T17:56:09.071401Z","steps":["trace[1845207232] 'read index received' (duration: 768.133552ms)","trace[1845207232] 'applied index is now lower than readState.Index' (duration: 12.023147ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:56:09.071739Z","caller":"traceutil/trace.go:171","msg":"trace[835566403] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"721.423401ms","start":"2026-03-26T17:56:08.350305Z","end":"2026-03-26T17:56:09.071728Z","steps":["trace[835566403] 'process raft request' (duration: 721.012689ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:09.071817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:08.350288Z","time spent":"721.481022ms","remote":"127.0.0.1:41170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:56:09.072004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.757436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-03-26T17:56:09.072033Z","caller":"traceutil/trace.go:171","msg":"trace[1134723421] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:545; }","duration":"780.786447ms","start":"2026-03-26T17:56:08.291239Z","end":"2026-03-26T17:56:09.072025Z","steps":["trace[1134723421] 'agreement among raft nodes before linearized reading' (duration: 780.685394ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:09.072054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:08.291204Z","time spent":"780.844639ms","remote":"127.0.0.1:41170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":59653,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-03-26T17:56:13.718606Z","caller":"traceutil/trace.go:171","msg":"trace[615787250] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"294.166307ms","start":"2026-03-26T17:56:13.424391Z","end":"2026-03-26T17:56:13.718557Z","steps":["trace[615787250] 'process raft request' (duration: 292.594583ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:14.128263Z","caller":"traceutil/trace.go:171","msg":"trace[114278145] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"389.498782ms","start":"2026-03-26T17:56:13.738733Z","end":"2026-03-26T17:56:14.128231Z","steps":["trace[114278145] 'process raft request' (duration: 389.218755ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:14.128449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:13.738716Z","time spent":"389.638396ms","remote":"127.0.0.1:41314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:56:14.131603Z","caller":"traceutil/trace.go:171","msg":"trace[937068227] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"356.397543ms","start":"2026-03-26T17:56:13.77518Z","end":"2026-03-26T17:56:14.131577Z","steps":["trace[937068227] 'process raft request' (duration: 356.2833ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:14.131822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:13.775156Z","time spent":"356.523536ms","remote":"127.0.0.1:41526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T17:56:15.557781Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938290404220004061,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T17:56:15.574013Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.056215659s","expected-duration":"1s"} {"level":"info","ts":"2026-03-26T17:56:15.574965Z","caller":"traceutil/trace.go:171","msg":"trace[1829703952] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.05839777s","start":"2026-03-26T17:56:14.516504Z","end":"2026-03-26T17:56:15.574902Z","steps":["trace[1829703952] 'process raft request' (duration: 1.057902836s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:15.575107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:14.516473Z","time spent":"1.058548724s","remote":"127.0.0.1:41222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:56:15.999512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.053321ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-03-26T17:56:15.999756Z","caller":"traceutil/trace.go:171","msg":"trace[968936250] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:604; }","duration":"943.543386ms","start":"2026-03-26T17:56:15.056188Z","end":"2026-03-26T17:56:15.999732Z","steps":["trace[968936250] 'read index received' (duration: 518.098843ms)","trace[968936250] 'applied index is now lower than readState.Index' (duration: 425.442713ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:56:15.999972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.070797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:56:16.000001Z","caller":"traceutil/trace.go:171","msg":"trace[75673691] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"355.118178ms","start":"2026-03-26T17:56:15.644875Z","end":"2026-03-26T17:56:15.999993Z","steps":["trace[75673691] 'agreement among raft nodes before linearized reading' (duration: 355.029375ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:15.999991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.773152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:56:16.00006Z","caller":"traceutil/trace.go:171","msg":"trace[1412321818] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"361.94628ms","start":"2026-03-26T17:56:15.638107Z","end":"2026-03-26T17:56:16.000053Z","steps":["trace[1412321818] 'process raft request' (duration: 361.518398ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.638094Z","time spent":"361.98141ms","remote":"127.0.0.1:41670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T17:56:16.000102Z","caller":"traceutil/trace.go:171","msg":"trace[1180050190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"943.912236ms","start":"2026-03-26T17:56:15.056149Z","end":"2026-03-26T17:56:16.000061Z","steps":["trace[1180050190] 'agreement among raft nodes before linearized reading' (duration: 943.681149ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.755256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.000172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.05613Z","time spent":"944.026099ms","remote":"127.0.0.1:41124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T17:56:16.000179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.826912ms","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-03-26T17:56:16.000211Z","caller":"traceutil/trace.go:171","msg":"trace[1762859479] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:581; }","duration":"588.855379ms","start":"2026-03-26T17:56:15.411334Z","end":"2026-03-26T17:56:16.000189Z","steps":["trace[1762859479] 'agreement among raft nodes before linearized reading' (duration: 588.707614ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.526338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.000273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.411297Z","time spent":"588.960892ms","remote":"127.0.0.1:52238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-03-26T17:56:16.0003Z","caller":"traceutil/trace.go:171","msg":"trace[484960288] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:581; }","duration":"195.563369ms","start":"2026-03-26T17:56:15.80472Z","end":"2026-03-26T17:56:16.000284Z","steps":["trace[484960288] 'agreement among raft nodes before linearized reading' (duration: 195.520098ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.000257Z","caller":"traceutil/trace.go:171","msg":"trace[1821726744] 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:581; }","duration":"415.949606ms","start":"2026-03-26T17:56:15.584289Z","end":"2026-03-26T17:56:16.000239Z","steps":["trace[1821726744] 'agreement among raft nodes before linearized reading' (duration: 415.811922ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.584275Z","time spent":"416.091449ms","remote":"127.0.0.1:52264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-03-26T17:56:16.000404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.343068ms","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":"warn","ts":"2026-03-26T17:56:16.000421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.227748ms","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-03-26T17:56:16.000443Z","caller":"traceutil/trace.go:171","msg":"trace[391798359] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:581; }","duration":"196.264129ms","start":"2026-03-26T17:56:15.804173Z","end":"2026-03-26T17:56:16.000437Z","steps":["trace[391798359] 'agreement among raft nodes before linearized reading' (duration: 196.228578ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.644871Z","time spent":"355.155409ms","remote":"127.0.0.1:52272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-03-26T17:56:16.000499Z","caller":"traceutil/trace.go:171","msg":"trace[1624537807] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:581; }","duration":"612.40131ms","start":"2026-03-26T17:56:15.388032Z","end":"2026-03-26T17:56:16.000433Z","steps":["trace[1624537807] 'agreement among raft nodes before linearized reading' (duration: 612.318658ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.489735ms","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-03-26T17:56:16.000549Z","caller":"traceutil/trace.go:171","msg":"trace[1419934764] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:581; }","duration":"196.508955ms","start":"2026-03-26T17:56:15.804035Z","end":"2026-03-26T17:56:16.000544Z","steps":["trace[1419934764] 'agreement among raft nodes before linearized reading' (duration: 196.480545ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.47348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.000613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.209733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.00064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.800361ms","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-03-26T17:56:16.000665Z","caller":"traceutil/trace.go:171","msg":"trace[945194275] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"213.843803ms","start":"2026-03-26T17:56:15.786816Z","end":"2026-03-26T17:56:16.000659Z","steps":["trace[945194275] 'agreement among raft nodes before linearized reading' (duration: 213.807242ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.18573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.000631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.138627ms","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-03-26T17:56:16.000709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.885342ms","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":"warn","ts":"2026-03-26T17:56:16.000772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.681056ms","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-03-26T17:56:16.000771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.329444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:56:16.000792Z","caller":"traceutil/trace.go:171","msg":"trace[734866381] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"214.702086ms","start":"2026-03-26T17:56:15.786084Z","end":"2026-03-26T17:56:16.000786Z","steps":["trace[734866381] 'agreement among raft nodes before linearized reading' (duration: 214.669175ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.000807Z","caller":"traceutil/trace.go:171","msg":"trace[2034054826] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"438.397736ms","start":"2026-03-26T17:56:15.562399Z","end":"2026-03-26T17:56:16.000797Z","steps":["trace[2034054826] 'agreement among raft nodes before linearized reading' (duration: 438.339114ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.562381Z","time spent":"438.464098ms","remote":"127.0.0.1:52254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T17:56:16.000858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.928332ms","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-03-26T17:56:16.000903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.814699ms","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-03-26T17:56:16.000925Z","caller":"traceutil/trace.go:171","msg":"trace[1293983942] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"214.854511ms","start":"2026-03-26T17:56:15.786065Z","end":"2026-03-26T17:56:16.000919Z","steps":["trace[1293983942] 'agreement among raft nodes before linearized reading' (duration: 214.80252ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.000936Z","caller":"traceutil/trace.go:171","msg":"trace[1924986911] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:581; }","duration":"666.017935ms","start":"2026-03-26T17:56:15.334909Z","end":"2026-03-26T17:56:16.000926Z","steps":["trace[1924986911] 'agreement among raft nodes before linearized reading' (duration: 665.923853ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.334904Z","time spent":"666.073177ms","remote":"127.0.0.1:52220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"info","ts":"2026-03-26T17:56:16.00082Z","caller":"traceutil/trace.go:171","msg":"trace[1305801655] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"356.391054ms","start":"2026-03-26T17:56:15.644362Z","end":"2026-03-26T17:56:16.000753Z","steps":["trace[1305801655] 'agreement among raft nodes before linearized reading' (duration: 356.087646ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.247033ms","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-03-26T17:56:16.001076Z","caller":"traceutil/trace.go:171","msg":"trace[1383291822] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"246.297653ms","start":"2026-03-26T17:56:15.754769Z","end":"2026-03-26T17:56:16.001067Z","steps":["trace[1383291822] 'agreement among raft nodes before linearized reading' (duration: 246.269282ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.644354Z","time spent":"356.708243ms","remote":"127.0.0.1:52272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-03-26T17:56:16.001084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.072942ms","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-03-26T17:56:16.001138Z","caller":"traceutil/trace.go:171","msg":"trace[628136090] 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:581; }","duration":"570.128634ms","start":"2026-03-26T17:56:15.430995Z","end":"2026-03-26T17:56:16.001123Z","steps":["trace[628136090] 'agreement among raft nodes before linearized reading' (duration: 570.053912ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.775335ms","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":"warn","ts":"2026-03-26T17:56:16.001191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.801927ms","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-03-26T17:56:16.001194Z","caller":"traceutil/trace.go:171","msg":"trace[449845442] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:581; }","duration":"667.815405ms","start":"2026-03-26T17:56:15.333368Z","end":"2026-03-26T17:56:16.001183Z","steps":["trace[449845442] 'agreement among raft nodes before linearized reading' (duration: 667.751274ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.001222Z","caller":"traceutil/trace.go:171","msg":"trace[160049399] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:581; }","duration":"283.837907ms","start":"2026-03-26T17:56:15.717366Z","end":"2026-03-26T17:56:16.001204Z","steps":["trace[160049399] 'agreement among raft nodes before linearized reading' (duration: 283.809606ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.866848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.00131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.888912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.00133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.94003ms","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-03-26T17:56:16.001328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.958739ms","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":"warn","ts":"2026-03-26T17:56:16.001329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.35686ms","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-03-26T17:56:16.001352Z","caller":"traceutil/trace.go:171","msg":"trace[126738083] 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:581; }","duration":"416.996055ms","start":"2026-03-26T17:56:15.584345Z","end":"2026-03-26T17:56:16.001341Z","steps":["trace[126738083] 'agreement among raft nodes before linearized reading' (duration: 416.943333ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.00138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.091308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.001346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.075592ms","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-03-26T17:56:16.001382Z","caller":"traceutil/trace.go:171","msg":"trace[1614728684] 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:581; }","duration":"570.462913ms","start":"2026-03-26T17:56:15.430908Z","end":"2026-03-26T17:56:16.001371Z","steps":["trace[1614728684] 'agreement among raft nodes before linearized reading' (duration: 570.387611ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.001399Z","caller":"traceutil/trace.go:171","msg":"trace[2031640342] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:581; }","duration":"303.125708ms","start":"2026-03-26T17:56:15.698268Z","end":"2026-03-26T17:56:16.001393Z","steps":["trace[2031640342] 'agreement among raft nodes before linearized reading' (duration: 303.095038ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.00142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.698258Z","time spent":"303.1564ms","remote":"127.0.0.1:52284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-26T17:56:16.001424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.485145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.001427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.430882Z","time spent":"570.532825ms","remote":"127.0.0.1:52248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-03-26T17:56:16.001456Z","caller":"traceutil/trace.go:171","msg":"trace[363429591] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:581; }","duration":"735.529096ms","start":"2026-03-26T17:56:15.265918Z","end":"2026-03-26T17:56:16.001447Z","steps":["trace[363429591] 'agreement among raft nodes before linearized reading' (duration: 735.478224ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.26591Z","time spent":"735.569588ms","remote":"127.0.0.1:52202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-03-26T17:56:16.001513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.681675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.001512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.378019ms","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-03-26T17:56:16.001533Z","caller":"traceutil/trace.go:171","msg":"trace[1643253829] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:581; }","duration":"303.733576ms","start":"2026-03-26T17:56:15.697794Z","end":"2026-03-26T17:56:16.001528Z","steps":["trace[1643253829] 'agreement among raft nodes before linearized reading' (duration: 303.704155ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.00155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.697777Z","time spent":"303.768157ms","remote":"127.0.0.1:52284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T17:56:16.000345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.802671ms","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-03-26T17:56:16.001658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.650118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.001657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.71027ms","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-03-26T17:56:16.001672Z","caller":"traceutil/trace.go:171","msg":"trace[764490364] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"386.253712ms","start":"2026-03-26T17:56:15.615405Z","end":"2026-03-26T17:56:16.001658Z","steps":["trace[764490364] 'agreement among raft nodes before linearized reading' (duration: 384.707388ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.8874ms","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-03-26T17:56:16.001696Z","caller":"traceutil/trace.go:171","msg":"trace[108115998] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:581; }","duration":"736.711969ms","start":"2026-03-26T17:56:15.264968Z","end":"2026-03-26T17:56:16.00168Z","steps":["trace[108115998] 'agreement among raft nodes before linearized reading' (duration: 736.664168ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.615402Z","time spent":"386.288963ms","remote":"127.0.0.1:52266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-03-26T17:56:16.001698Z","caller":"traceutil/trace.go:171","msg":"trace[1088573675] 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:581; }","duration":"570.755462ms","start":"2026-03-26T17:56:15.430932Z","end":"2026-03-26T17:56:16.001687Z","steps":["trace[1088573675] 'agreement among raft nodes before linearized reading' (duration: 570.68595ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.693845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-03-26T17:56:16.001744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.430857Z","time spent":"570.874995ms","remote":"127.0.0.1:52248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-03-26T17:56:16.001373Z","caller":"traceutil/trace.go:171","msg":"trace[1952477985] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:581; }","duration":"668.025161ms","start":"2026-03-26T17:56:15.333335Z","end":"2026-03-26T17:56:16.00136Z","steps":["trace[1952477985] 'agreement among raft nodes before linearized reading' (duration: 667.95901ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.001765Z","caller":"traceutil/trace.go:171","msg":"trace[375736803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"883.790328ms","start":"2026-03-26T17:56:15.117959Z","end":"2026-03-26T17:56:16.001749Z","steps":["trace[375736803] 'agreement among raft nodes before linearized reading' (duration: 883.605933ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.333321Z","time spent":"668.483114ms","remote":"127.0.0.1:52220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T17:56:16.000625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.988416ms","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-03-26T17:56:16.001855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.117955Z","time spent":"883.884611ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-26T17:56:16.001868Z","caller":"traceutil/trace.go:171","msg":"trace[319513824] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:581; }","duration":"614.338164ms","start":"2026-03-26T17:56:15.387521Z","end":"2026-03-26T17:56:16.001859Z","steps":["trace[319513824] 'agreement among raft nodes before linearized reading' (duration: 613.078249ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.387497Z","time spent":"614.397116ms","remote":"127.0.0.1:52228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-26T17:56:16.001951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.124595ms","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-03-26T17:56:16.002007Z","caller":"traceutil/trace.go:171","msg":"trace[220500705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:581; }","duration":"590.194707ms","start":"2026-03-26T17:56:15.411797Z","end":"2026-03-26T17:56:16.001992Z","steps":["trace[220500705] 'agreement among raft nodes before linearized reading' (duration: 590.098435ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.002052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.411787Z","time spent":"590.253159ms","remote":"127.0.0.1:52238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-03-26T17:56:16.001161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.976784ms","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-03-26T17:56:16.002166Z","caller":"traceutil/trace.go:171","msg":"trace[746407919] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:581; }","duration":"283.998762ms","start":"2026-03-26T17:56:15.718154Z","end":"2026-03-26T17:56:16.002153Z","steps":["trace[746407919] 'agreement among raft nodes before linearized reading' (duration: 282.992003ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.001929Z","caller":"traceutil/trace.go:171","msg":"trace[34683107] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"357.591477ms","start":"2026-03-26T17:56:15.644194Z","end":"2026-03-26T17:56:16.001785Z","steps":["trace[34683107] 'agreement among raft nodes before linearized reading' (duration: 356.692552ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.001545Z","caller":"traceutil/trace.go:171","msg":"trace[1748257902] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:581; }","duration":"871.449461ms","start":"2026-03-26T17:56:15.130087Z","end":"2026-03-26T17:56:16.001537Z","steps":["trace[1748257902] 'agreement among raft nodes before linearized reading' (duration: 871.347799ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.002957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.130067Z","time spent":"872.877672ms","remote":"127.0.0.1:52202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T17:56:16.001389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.584315Z","time spent":"417.062747ms","remote":"127.0.0.1:52264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T17:56:16.001243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.430968Z","time spent":"570.216707ms","remote":"127.0.0.1:52248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-26T17:56:16.001726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.264955Z","time spent":"736.763001ms","remote":"127.0.0.1:52216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-03-26T17:56:16.001412Z","caller":"traceutil/trace.go:171","msg":"trace[321156660] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:581; }","duration":"871.169204ms","start":"2026-03-26T17:56:15.130231Z","end":"2026-03-26T17:56:16.001401Z","steps":["trace[321156660] 'agreement among raft nodes before linearized reading' (duration: 871.080551ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.000809Z","caller":"traceutil/trace.go:171","msg":"trace[861276325] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:581; }","duration":"614.040496ms","start":"2026-03-26T17:56:15.386731Z","end":"2026-03-26T17:56:16.000771Z","steps":["trace[861276325] 'agreement among raft nodes before linearized reading' (duration: 613.950443ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.003118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.130224Z","time spent":"872.881993ms","remote":"127.0.0.1:52202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-03-26T17:56:16.003166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.386698Z","time spent":"616.435423ms","remote":"127.0.0.1:52228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T17:56:16.003277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.549837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-26T17:56:16.000326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.042214ms","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-03-26T17:56:16.003301Z","caller":"traceutil/trace.go:171","msg":"trace[1990963272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:581; }","duration":"592.025988ms","start":"2026-03-26T17:56:15.411268Z","end":"2026-03-26T17:56:16.003294Z","steps":["trace[1990963272] 'agreement among raft nodes before linearized reading' (duration: 588.962692ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.001013Z","caller":"traceutil/trace.go:171","msg":"trace[143300960] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"385.622594ms","start":"2026-03-26T17:56:15.615375Z","end":"2026-03-26T17:56:16.000998Z","steps":["trace[143300960] 'agreement among raft nodes before linearized reading' (duration: 385.206563ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.003321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.411234Z","time spent":"592.081339ms","remote":"127.0.0.1:52238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"info","ts":"2026-03-26T17:56:16.000713Z","caller":"traceutil/trace.go:171","msg":"trace[2062420935] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"438.241511ms","start":"2026-03-26T17:56:15.562461Z","end":"2026-03-26T17:56:16.000702Z","steps":["trace[2062420935] 'agreement among raft nodes before linearized reading' (duration: 438.185339ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.819901ms","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":"warn","ts":"2026-03-26T17:56:16.004917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.562456Z","time spent":"442.449ms","remote":"127.0.0.1:52254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-03-26T17:56:16.004946Z","caller":"traceutil/trace.go:171","msg":"trace[843050008] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:581; }","duration":"160.964398ms","start":"2026-03-26T17:56:15.843947Z","end":"2026-03-26T17:56:16.004911Z","steps":["trace[843050008] 'agreement among raft nodes before linearized reading' (duration: 156.77487ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.00172Z","caller":"traceutil/trace.go:171","msg":"trace[1191058739] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:581; }","duration":"303.957102ms","start":"2026-03-26T17:56:15.697754Z","end":"2026-03-26T17:56:16.001711Z","steps":["trace[1191058739] 'agreement among raft nodes before linearized reading' (duration: 303.902381ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.005276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.697733Z","time spent":"307.521822ms","remote":"127.0.0.1:52284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-03-26T17:56:16.00124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.333365Z","time spent":"667.855107ms","remote":"127.0.0.1:52220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-03-26T17:56:16.001025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.17281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:56:16.005626Z","caller":"traceutil/trace.go:171","msg":"trace[962585529] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:581; }","duration":"250.77963ms","start":"2026-03-26T17:56:15.754829Z","end":"2026-03-26T17:56:16.005608Z","steps":["trace[962585529] 'agreement among raft nodes before linearized reading' (duration: 246.179941ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.000551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.38802Z","time spent":"612.518633ms","remote":"127.0.0.1:52228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-03-26T17:56:16.0002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.692189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-26T17:56:16.006799Z","caller":"traceutil/trace.go:171","msg":"trace[1087406067] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"893.327986ms","start":"2026-03-26T17:56:15.113456Z","end":"2026-03-26T17:56:16.006784Z","steps":["trace[1087406067] 'agreement among raft nodes before linearized reading' (duration: 886.433372ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.006949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.113437Z","time spent":"893.494051ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-26T17:56:16.001351Z","caller":"traceutil/trace.go:171","msg":"trace[1233868919] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:581; }","duration":"283.974531ms","start":"2026-03-26T17:56:15.717371Z","end":"2026-03-26T17:56:16.001345Z","steps":["trace[1233868919] 'agreement among raft nodes before linearized reading' (duration: 283.94284ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.001092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.078112ms","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-03-26T17:56:16.007404Z","caller":"traceutil/trace.go:171","msg":"trace[817066163] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:581; }","duration":"742.44002ms","start":"2026-03-26T17:56:15.264954Z","end":"2026-03-26T17:56:16.007394Z","steps":["trace[817066163] 'agreement among raft nodes before linearized reading' (duration: 736.077761ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.000619Z","caller":"traceutil/trace.go:171","msg":"trace[191687918] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:581; }","duration":"437.549902ms","start":"2026-03-26T17:56:15.563056Z","end":"2026-03-26T17:56:16.000606Z","steps":["trace[191687918] 'agreement among raft nodes before linearized reading' (duration: 437.46879ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.003338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.615367Z","time spent":"387.96079ms","remote":"127.0.0.1:52266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T17:56:16.001265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.673986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.003544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.644183Z","time spent":"358.448622ms","remote":"127.0.0.1:52272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-03-26T17:56:16.004001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.344584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-03-26T17:56:16.004227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.06046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.004507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.305607ms","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-03-26T17:56:16.004622Z","caller":"traceutil/trace.go:171","msg":"trace[1298323267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"886.905206ms","start":"2026-03-26T17:56:15.117708Z","end":"2026-03-26T17:56:16.004614Z","steps":["trace[1298323267] 'agreement among raft nodes before linearized reading' (duration: 885.450645ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.004689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.532049ms","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-03-26T17:56:16.004694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.550713ms","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-03-26T17:56:16.004726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.156248ms","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":"warn","ts":"2026-03-26T17:56:16.004729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.631069ms","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-03-26T17:56:16.004771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.634791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T17:56:16.004776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.713811ms","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-03-26T17:56:16.007527Z","caller":"traceutil/trace.go:171","msg":"trace[670290306] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:581; }","duration":"163.475598ms","start":"2026-03-26T17:56:15.844045Z","end":"2026-03-26T17:56:16.00752Z","steps":["trace[670290306] 'agreement among raft nodes before linearized reading' (duration: 160.711791ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.007548Z","caller":"traceutil/trace.go:171","msg":"trace[2132541167] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:581; }","duration":"113.401863ms","start":"2026-03-26T17:56:15.894128Z","end":"2026-03-26T17:56:16.00753Z","steps":["trace[2132541167] 'agreement among raft nodes before linearized reading' (duration: 110.073329ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.007589Z","caller":"traceutil/trace.go:171","msg":"trace[1558448502] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:581; }","duration":"113.453324ms","start":"2026-03-26T17:56:15.894127Z","end":"2026-03-26T17:56:16.007581Z","steps":["trace[1558448502] 'agreement among raft nodes before linearized reading' (duration: 110.534622ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.008262Z","caller":"traceutil/trace.go:171","msg":"trace[824619028] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:581; }","duration":"114.142594ms","start":"2026-03-26T17:56:15.894113Z","end":"2026-03-26T17:56:16.008255Z","steps":["trace[824619028] 'agreement among raft nodes before linearized reading' (duration: 110.371848ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.008349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.117703Z","time spent":"890.63723ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-26T17:56:16.00874Z","caller":"traceutil/trace.go:171","msg":"trace[176537130] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:581; }","duration":"142.601163ms","start":"2026-03-26T17:56:15.866119Z","end":"2026-03-26T17:56:16.00872Z","steps":["trace[176537130] 'agreement among raft nodes before linearized reading' (duration: 138.630402ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:16.008837Z","caller":"traceutil/trace.go:171","msg":"trace[288863610] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:581; }","duration":"142.242503ms","start":"2026-03-26T17:56:15.866147Z","end":"2026-03-26T17:56:16.008389Z","steps":["trace[288863610] 'agreement among raft nodes before linearized reading' (duration: 138.513968ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.007753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.563046Z","time spent":"444.699533ms","remote":"127.0.0.1:52254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"info","ts":"2026-03-26T17:56:16.007873Z","caller":"traceutil/trace.go:171","msg":"trace[1405955258] 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:581; }","duration":"423.296112ms","start":"2026-03-26T17:56:15.584562Z","end":"2026-03-26T17:56:16.007858Z","steps":["trace[1405955258] 'agreement among raft nodes before linearized reading' (duration: 416.669136ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.010243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.584555Z","time spent":"425.676449ms","remote":"127.0.0.1:52264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"info","ts":"2026-03-26T17:56:16.007976Z","caller":"traceutil/trace.go:171","msg":"trace[492459217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"893.338976ms","start":"2026-03-26T17:56:15.114628Z","end":"2026-03-26T17:56:16.007967Z","steps":["trace[492459217] 'agreement among raft nodes before linearized reading' (duration: 889.256231ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.007721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.264941Z","time spent":"742.757629ms","remote":"127.0.0.1:52216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-03-26T17:56:16.007679Z","caller":"traceutil/trace.go:171","msg":"trace[364452247] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:581; }","duration":"141.115791ms","start":"2026-03-26T17:56:15.866556Z","end":"2026-03-26T17:56:16.007671Z","steps":["trace[364452247] 'agreement among raft nodes before linearized reading' (duration: 138.145957ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:16.012043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:56:15.114619Z","time spent":"897.415771ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-26T17:56:16.009176Z","caller":"traceutil/trace.go:171","msg":"trace[1380453641] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:581; }","duration":"165.105424ms","start":"2026-03-26T17:56:15.844058Z","end":"2026-03-26T17:56:16.009163Z","steps":["trace[1380453641] 'agreement among raft nodes before linearized reading' (duration: 160.633839ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:31.751069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.623454ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:56:31.751157Z","caller":"traceutil/trace.go:171","msg":"trace[1538820976] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:747; }","duration":"121.716827ms","start":"2026-03-26T17:56:31.629425Z","end":"2026-03-26T17:56:31.751142Z","steps":["trace[1538820976] 'range keys from in-memory index tree' (duration: 121.613074ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:31.969419Z","caller":"traceutil/trace.go:171","msg":"trace[1601274706] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"143.011104ms","start":"2026-03-26T17:56:31.826385Z","end":"2026-03-26T17:56:31.969396Z","steps":["trace[1601274706] 'read index received' (duration: 142.900211ms)","trace[1601274706] 'applied index is now lower than readState.Index' (duration: 110.003µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:56:31.969512Z","caller":"traceutil/trace.go:171","msg":"trace[1165398014] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"214.018767ms","start":"2026-03-26T17:56:31.755437Z","end":"2026-03-26T17:56:31.969455Z","steps":["trace[1165398014] 'process raft request' (duration: 213.831271ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:56:31.969613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.207599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lj658\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-03-26T17:56:31.969663Z","caller":"traceutil/trace.go:171","msg":"trace[1098707142] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lj658; range_end:; response_count:1; response_revision:748; }","duration":"143.289902ms","start":"2026-03-26T17:56:31.826348Z","end":"2026-03-26T17:56:31.969638Z","steps":["trace[1098707142] 'agreement among raft nodes before linearized reading' (duration: 143.141168ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:56:32.145284Z","caller":"traceutil/trace.go:171","msg":"trace[1234614732] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"166.769802ms","start":"2026-03-26T17:56:31.978487Z","end":"2026-03-26T17:56:32.145257Z","steps":["trace[1234614732] 'process raft request' (duration: 166.467623ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:07.716568Z","caller":"traceutil/trace.go:171","msg":"trace[1336268459] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"658.016611ms","start":"2026-03-26T17:57:07.058528Z","end":"2026-03-26T17:57:07.716545Z","steps":["trace[1336268459] 'process raft request' (duration: 657.900828ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:07.716709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:07.058498Z","time spent":"658.142505ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:57:08.366096Z","caller":"traceutil/trace.go:171","msg":"trace[831994425] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"229.876208ms","start":"2026-03-26T17:57:08.136193Z","end":"2026-03-26T17:57:08.366069Z","steps":["trace[831994425] 'process raft request' (duration: 229.541688ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:09.09668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.747462ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T17:57:09.09682Z","caller":"traceutil/trace.go:171","msg":"trace[731378918] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1003; }","duration":"723.306209ms","start":"2026-03-26T17:57:08.373502Z","end":"2026-03-26T17:57:09.096808Z","steps":["trace[731378918] 'read index received' (duration: 262.429103ms)","trace[731378918] 'applied index is now lower than readState.Index' (duration: 460.876216ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:57:09.096957Z","caller":"traceutil/trace.go:171","msg":"trace[792171399] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"725.037158ms","start":"2026-03-26T17:57:08.371912Z","end":"2026-03-26T17:57:09.096949Z","steps":["trace[792171399] 'process raft request' (duration: 263.962766ms)","trace[792171399] 'compare' (duration: 460.619339ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:57:09.097011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:08.371887Z","time spent":"725.10328ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:57:09.097123Z","caller":"traceutil/trace.go:171","msg":"trace[341496360] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"724.963716ms","start":"2026-03-26T17:57:08.372153Z","end":"2026-03-26T17:57:09.097117Z","steps":["trace[341496360] 'process raft request' (duration: 724.602385ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:09.097157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:08.372144Z","time spent":"724.992586ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:57:09.09745Z","caller":"traceutil/trace.go:171","msg":"trace[1414375713] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"723.897035ms","start":"2026-03-26T17:57:08.373527Z","end":"2026-03-26T17:57:09.097424Z","steps":["trace[1414375713] 'process raft request' (duration: 723.260397ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:09.097607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:08.373515Z","time spent":"724.018339ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:57:09.097639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.103991ms","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-03-26T17:57:09.097717Z","caller":"traceutil/trace.go:171","msg":"trace[1327786129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:967; }","duration":"724.215485ms","start":"2026-03-26T17:57:08.373484Z","end":"2026-03-26T17:57:09.097699Z","steps":["trace[1327786129] 'agreement among raft nodes before linearized reading' (duration: 723.989349ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:09.097763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:08.373474Z","time spent":"724.281166ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-26T17:57:09.281977Z","caller":"traceutil/trace.go:171","msg":"trace[1494053984] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"140.468302ms","start":"2026-03-26T17:57:09.141484Z","end":"2026-03-26T17:57:09.281952Z","steps":["trace[1494053984] 'read index received' (duration: 136.604313ms)","trace[1494053984] 'applied index is now lower than readState.Index' (duration: 3.863029ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:57:09.282109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.601035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:57:09.282091Z","caller":"traceutil/trace.go:171","msg":"trace[981021234] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"179.548231ms","start":"2026-03-26T17:57:09.102492Z","end":"2026-03-26T17:57:09.28204Z","steps":["trace[981021234] 'process raft request' (duration: 175.657192ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:09.282143Z","caller":"traceutil/trace.go:171","msg":"trace[1796806685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:968; }","duration":"140.678608ms","start":"2026-03-26T17:57:09.141454Z","end":"2026-03-26T17:57:09.282132Z","steps":["trace[1796806685] 'agreement among raft nodes before linearized reading' (duration: 140.600866ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:32.696433Z","caller":"traceutil/trace.go:171","msg":"trace[2047952867] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"211.006386ms","start":"2026-03-26T17:57:32.485395Z","end":"2026-03-26T17:57:32.696402Z","steps":["trace[2047952867] 'process raft request' (duration: 210.700717ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:33.351647Z","caller":"traceutil/trace.go:171","msg":"trace[808894397] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"133.428735ms","start":"2026-03-26T17:57:33.218194Z","end":"2026-03-26T17:57:33.351622Z","steps":["trace[808894397] 'read index received' (duration: 133.294151ms)","trace[808894397] 'applied index is now lower than readState.Index' (duration: 133.473µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:57:33.351908Z","caller":"traceutil/trace.go:171","msg":"trace[201703003] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"136.000016ms","start":"2026-03-26T17:57:33.215865Z","end":"2026-03-26T17:57:33.351865Z","steps":["trace[201703003] 'process raft request' (duration: 135.620216ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:33.35201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.544287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-03-26T17:57:33.352092Z","caller":"traceutil/trace.go:171","msg":"trace[118366694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1045; }","duration":"128.642429ms","start":"2026-03-26T17:57:33.223396Z","end":"2026-03-26T17:57:33.352038Z","steps":["trace[118366694] 'agreement among raft nodes before linearized reading' (duration: 128.492305ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:33.352011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.771164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-26T17:57:33.35219Z","caller":"traceutil/trace.go:171","msg":"trace[494584019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1045; }","duration":"134.005191ms","start":"2026-03-26T17:57:33.218163Z","end":"2026-03-26T17:57:33.352168Z","steps":["trace[494584019] 'agreement among raft nodes before linearized reading' (duration: 133.642791ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:33.685224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.789453ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T17:57:33.685403Z","caller":"traceutil/trace.go:171","msg":"trace[1549441404] linearizableReadLoop","detail":"{readStateIndex:1091; appliedIndex:1089; }","duration":"270.126779ms","start":"2026-03-26T17:57:33.41526Z","end":"2026-03-26T17:57:33.685387Z","steps":["trace[1549441404] 'read index received' (duration: 82.181882ms)","trace[1549441404] 'applied index is now lower than readState.Index' (duration: 187.943737ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:57:33.685625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.669564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:57:33.685671Z","caller":"traceutil/trace.go:171","msg":"trace[1001218561] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"328.296496ms","start":"2026-03-26T17:57:33.357364Z","end":"2026-03-26T17:57:33.68566Z","steps":["trace[1001218561] 'process raft request' (duration: 327.967487ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:33.685674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.393487ms","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-03-26T17:57:33.685669Z","caller":"traceutil/trace.go:171","msg":"trace[1514150430] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"328.745779ms","start":"2026-03-26T17:57:33.356904Z","end":"2026-03-26T17:57:33.68565Z","steps":["trace[1514150430] 'process raft request' (duration: 140.445791ms)","trace[1514150430] 'compare' (duration: 187.628619ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:57:33.685715Z","caller":"traceutil/trace.go:171","msg":"trace[1220356323] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1047; }","duration":"201.802248ms","start":"2026-03-26T17:57:33.483887Z","end":"2026-03-26T17:57:33.685689Z","steps":["trace[1220356323] 'agreement among raft nodes before linearized reading' (duration: 201.653263ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:33.685739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:33.357345Z","time spent":"328.359018ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:57:33.685745Z","caller":"traceutil/trace.go:171","msg":"trace[912453375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1047; }","duration":"270.536841ms","start":"2026-03-26T17:57:33.415191Z","end":"2026-03-26T17:57:33.685728Z","steps":["trace[912453375] 'agreement among raft nodes before linearized reading' (duration: 270.317385ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:33.685907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:33.356875Z","time spent":"328.938244ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:57:34.186457Z","caller":"traceutil/trace.go:171","msg":"trace[1020728306] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"338.979206ms","start":"2026-03-26T17:57:33.84745Z","end":"2026-03-26T17:57:34.186429Z","steps":["trace[1020728306] 'process raft request' (duration: 338.815912ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:34.186628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:33.847424Z","time spent":"339.11418ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:57:34.528976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.305111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T17:57:34.529089Z","caller":"traceutil/trace.go:171","msg":"trace[1873464653] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1092; }","duration":"470.25288ms","start":"2026-03-26T17:57:34.058818Z","end":"2026-03-26T17:57:34.529071Z","steps":["trace[1873464653] 'read index received' (duration: 127.542498ms)","trace[1873464653] 'applied index is now lower than readState.Index' (duration: 342.709002ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:57:34.529184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.363293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:57:34.529209Z","caller":"traceutil/trace.go:171","msg":"trace[454860017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1050; }","duration":"470.426175ms","start":"2026-03-26T17:57:34.058774Z","end":"2026-03-26T17:57:34.5292Z","steps":["trace[454860017] 'agreement among raft nodes before linearized reading' (duration: 470.343172ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:34.529239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:34.058754Z","time spent":"470.478877ms","remote":"127.0.0.1:41124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-26T17:57:34.529376Z","caller":"traceutil/trace.go:171","msg":"trace[1949424319] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"474.687585ms","start":"2026-03-26T17:57:34.054652Z","end":"2026-03-26T17:57:34.529339Z","steps":["trace[1949424319] 'process raft request' (duration: 212.936771ms)","trace[1949424319] 'compare' (duration: 261.016283ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:57:34.529614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:34.05463Z","time spent":"474.838659ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:57:35.059106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.261691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:57:35.059206Z","caller":"traceutil/trace.go:171","msg":"trace[1739214716] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1050; }","duration":"164.395235ms","start":"2026-03-26T17:57:34.89479Z","end":"2026-03-26T17:57:35.059185Z","steps":["trace[1739214716] 'count revisions from in-memory index tree' (duration: 164.159778ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:35.059368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.711512ms","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-03-26T17:57:35.059425Z","caller":"traceutil/trace.go:171","msg":"trace[521646920] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1050; }","duration":"358.811514ms","start":"2026-03-26T17:57:34.700601Z","end":"2026-03-26T17:57:35.059413Z","steps":["trace[521646920] 'range keys from in-memory index tree' (duration: 358.445584ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:35.059461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:34.700579Z","time spent":"358.873056ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-03-26T17:57:35.321657Z","caller":"traceutil/trace.go:171","msg":"trace[404810444] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"257.120714ms","start":"2026-03-26T17:57:35.064512Z","end":"2026-03-26T17:57:35.321633Z","steps":["trace[404810444] 'process raft request' (duration: 256.98437ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:35.482825Z","caller":"traceutil/trace.go:171","msg":"trace[1253290365] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"121.93026ms","start":"2026-03-26T17:57:35.360854Z","end":"2026-03-26T17:57:35.482784Z","steps":["trace[1253290365] 'process raft request' (duration: 89.22578ms)","trace[1253290365] 'compare' (duration: 32.426673ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:57:35.650784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.584051ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-03-26T17:57:39.582769Z","caller":"traceutil/trace.go:171","msg":"trace[35147028] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"160.63558ms","start":"2026-03-26T17:57:39.422104Z","end":"2026-03-26T17:57:39.582739Z","steps":["trace[35147028] 'process raft request' (duration: 160.463725ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:39.946317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.413312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-26T17:57:39.946481Z","caller":"traceutil/trace.go:171","msg":"trace[510300097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1063; }","duration":"176.624198ms","start":"2026-03-26T17:57:39.769839Z","end":"2026-03-26T17:57:39.946463Z","steps":["trace[510300097] 'range keys from in-memory index tree' (duration: 176.248708ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:39.946566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.713471ms","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-03-26T17:57:39.94664Z","caller":"traceutil/trace.go:171","msg":"trace[804848585] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1063; }","duration":"299.845135ms","start":"2026-03-26T17:57:39.646777Z","end":"2026-03-26T17:57:39.946622Z","steps":["trace[804848585] 'range keys from in-memory index tree' (duration: 299.430713ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:39.946388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.298775ms","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-03-26T17:57:39.946713Z","caller":"traceutil/trace.go:171","msg":"trace[1992138593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1063; }","duration":"189.693276ms","start":"2026-03-26T17:57:39.756996Z","end":"2026-03-26T17:57:39.946689Z","steps":["trace[1992138593] 'range keys from in-memory index tree' (duration: 189.157131ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:40.138245Z","caller":"traceutil/trace.go:171","msg":"trace[2017194901] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"188.247806ms","start":"2026-03-26T17:57:39.949977Z","end":"2026-03-26T17:57:40.138225Z","steps":["trace[2017194901] 'process raft request' (duration: 188.116892ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:40.248426Z","caller":"traceutil/trace.go:171","msg":"trace[1501748706] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"297.279343ms","start":"2026-03-26T17:57:39.951121Z","end":"2026-03-26T17:57:40.2484Z","steps":["trace[1501748706] 'process raft request' (duration: 297.085438ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:40.248667Z","caller":"traceutil/trace.go:171","msg":"trace[634243845] linearizableReadLoop","detail":"{readStateIndex:1112; appliedIndex:1109; }","duration":"191.458106ms","start":"2026-03-26T17:57:40.05719Z","end":"2026-03-26T17:57:40.248648Z","steps":["trace[634243845] 'read index received' (duration: 81.02982ms)","trace[634243845] 'applied index is now lower than readState.Index' (duration: 110.427576ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:57:40.248689Z","caller":"traceutil/trace.go:171","msg":"trace[106230645] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"297.409457ms","start":"2026-03-26T17:57:39.951259Z","end":"2026-03-26T17:57:40.248668Z","steps":["trace[106230645] 'process raft request' (duration: 297.097968ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:40.24871Z","caller":"traceutil/trace.go:171","msg":"trace[175043856] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"296.46853ms","start":"2026-03-26T17:57:39.952212Z","end":"2026-03-26T17:57:40.24868Z","steps":["trace[175043856] 'process raft request' (duration: 296.350977ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:40.248768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.570239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:57:40.248794Z","caller":"traceutil/trace.go:171","msg":"trace[1561364967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1067; }","duration":"191.633161ms","start":"2026-03-26T17:57:40.057152Z","end":"2026-03-26T17:57:40.248785Z","steps":["trace[1561364967] 'agreement among raft nodes before linearized reading' (duration: 191.576179ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:40.262092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.317186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-26T17:57:40.262162Z","caller":"traceutil/trace.go:171","msg":"trace[326487650] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:1068; }","duration":"146.45093ms","start":"2026-03-26T17:57:40.115699Z","end":"2026-03-26T17:57:40.26215Z","steps":["trace[326487650] 'agreement among raft nodes before linearized reading' (duration: 146.071759ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:40.428354Z","caller":"traceutil/trace.go:171","msg":"trace[1528906949] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"157.720458ms","start":"2026-03-26T17:57:40.270607Z","end":"2026-03-26T17:57:40.428327Z","steps":["trace[1528906949] 'process raft request' (duration: 112.143435ms)","trace[1528906949] 'compare' (duration: 45.467849ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:57:52.801405Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938290404220005346,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T17:57:53.301654Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938290404220005346,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T17:57:53.715499Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.526266029s","expected-duration":"1s"} {"level":"info","ts":"2026-03-26T17:57:53.715956Z","caller":"traceutil/trace.go:171","msg":"trace[1821081377] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"1.526827046s","start":"2026-03-26T17:57:52.189114Z","end":"2026-03-26T17:57:53.715941Z","steps":["trace[1821081377] 'process raft request' (duration: 1.526680672s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:53.716111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:52.189094Z","time spent":"1.526956189s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:57:53.71726Z","caller":"traceutil/trace.go:171","msg":"trace[404984991] linearizableReadLoop","detail":"{readStateIndex:1207; appliedIndex:1205; }","duration":"1.416928804s","start":"2026-03-26T17:57:52.30032Z","end":"2026-03-26T17:57:53.717249Z","steps":["trace[404984991] 'read index received' (duration: 1.415463833s)","trace[404984991] 'applied index is now lower than readState.Index' (duration: 1.464051ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:57:53.717321Z","caller":"traceutil/trace.go:171","msg":"trace[1278226021] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"1.419208708s","start":"2026-03-26T17:57:52.298105Z","end":"2026-03-26T17:57:53.717313Z","steps":["trace[1278226021] 'process raft request' (duration: 1.419095744s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:53.717381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:52.298081Z","time spent":"1.419257059s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:57:53.717548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.414156556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-26T17:57:53.717699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.417380616s","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-03-26T17:57:53.717733Z","caller":"traceutil/trace.go:171","msg":"trace[130811877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1157; }","duration":"1.417475649s","start":"2026-03-26T17:57:52.300249Z","end":"2026-03-26T17:57:53.717725Z","steps":["trace[130811877] 'agreement among raft nodes before linearized reading' (duration: 1.417407377s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:53.717753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:52.300236Z","time spent":"1.41751149s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-26T17:57:53.717965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.75047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:57:53.717993Z","caller":"traceutil/trace.go:171","msg":"trace[1117291712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1157; }","duration":"660.816892ms","start":"2026-03-26T17:57:53.057171Z","end":"2026-03-26T17:57:53.717988Z","steps":["trace[1117291712] 'agreement among raft nodes before linearized reading' (duration: 660.7734ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:53.718015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:53.057147Z","time spent":"660.862443ms","remote":"127.0.0.1:41124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T17:57:53.718217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.372578186s","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-03-26T17:57:53.718245Z","caller":"traceutil/trace.go:171","msg":"trace[651733765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1157; }","duration":"1.372637518s","start":"2026-03-26T17:57:52.345602Z","end":"2026-03-26T17:57:53.718239Z","steps":["trace[651733765] 'agreement among raft nodes before linearized reading' (duration: 1.372574656s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:53.718265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:52.345589Z","time spent":"1.372671218s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-26T17:57:53.71762Z","caller":"traceutil/trace.go:171","msg":"trace[57871765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1157; }","duration":"1.414273779s","start":"2026-03-26T17:57:52.30333Z","end":"2026-03-26T17:57:53.717604Z","steps":["trace[57871765] 'agreement among raft nodes before linearized reading' (duration: 1.414101174s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:53.723896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:57:52.303308Z","time spent":"1.420555855s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-26T17:57:57.867533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.035818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T17:57:57.867665Z","caller":"traceutil/trace.go:171","msg":"trace[52018240] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"127.656541ms","start":"2026-03-26T17:57:57.739987Z","end":"2026-03-26T17:57:57.867644Z","steps":["trace[52018240] 'process raft request' (duration: 18.422448ms)","trace[52018240] 'compare' (duration: 108.860073ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:57:57.87152Z","caller":"traceutil/trace.go:171","msg":"trace[1509909708] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1220; }","duration":"130.274605ms","start":"2026-03-26T17:57:57.741224Z","end":"2026-03-26T17:57:57.871498Z","steps":["trace[1509909708] 'read index received' (duration: 17.248615ms)","trace[1509909708] 'applied index is now lower than readState.Index' (duration: 113.02512ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:57:57.871539Z","caller":"traceutil/trace.go:171","msg":"trace[660257505] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"131.282113ms","start":"2026-03-26T17:57:57.740235Z","end":"2026-03-26T17:57:57.871517Z","steps":["trace[660257505] 'process raft request' (duration: 131.098708ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:57.87157Z","caller":"traceutil/trace.go:171","msg":"trace[1584857347] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"129.332808ms","start":"2026-03-26T17:57:57.742213Z","end":"2026-03-26T17:57:57.871546Z","steps":["trace[1584857347] 'process raft request' (duration: 129.253476ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:57:57.871705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.46342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-26T17:57:57.871762Z","caller":"traceutil/trace.go:171","msg":"trace[610092480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1173; }","duration":"130.558903ms","start":"2026-03-26T17:57:57.74119Z","end":"2026-03-26T17:57:57.871749Z","steps":["trace[610092480] 'agreement among raft nodes before linearized reading' (duration: 130.386528ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:57:57.871785Z","caller":"traceutil/trace.go:171","msg":"trace[1208506334] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"129.597186ms","start":"2026-03-26T17:57:57.742162Z","end":"2026-03-26T17:57:57.871759Z","steps":["trace[1208506334] 'process raft request' (duration: 129.269577ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:06.197142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.129194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:58:06.197231Z","caller":"traceutil/trace.go:171","msg":"trace[853684669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1201; }","duration":"139.247248ms","start":"2026-03-26T17:58:06.05796Z","end":"2026-03-26T17:58:06.197207Z","steps":["trace[853684669] 'range keys from in-memory index tree' (duration: 139.00024ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:09.478768Z","caller":"traceutil/trace.go:171","msg":"trace[451977312] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"386.193905ms","start":"2026-03-26T17:58:09.092557Z","end":"2026-03-26T17:58:09.478751Z","steps":["trace[451977312] 'process raft request' (duration: 386.090892ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:09.478876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:09.092535Z","time spent":"386.294238ms","remote":"127.0.0.1:41202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":871,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T17:58:13.90283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.385972ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-26T17:58:13.903009Z","caller":"traceutil/trace.go:171","msg":"trace[193007614] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"114.885612ms","start":"2026-03-26T17:58:13.78811Z","end":"2026-03-26T17:58:13.902995Z","steps":["trace[193007614] 'process raft request' (duration: 114.857711ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:13.903314Z","caller":"traceutil/trace.go:171","msg":"trace[1231189147] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"259.059198ms","start":"2026-03-26T17:58:13.644223Z","end":"2026-03-26T17:58:13.903283Z","steps":["trace[1231189147] 'process raft request' (duration: 258.699078ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:13.903338Z","caller":"traceutil/trace.go:171","msg":"trace[266407068] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"259.992145ms","start":"2026-03-26T17:58:13.643312Z","end":"2026-03-26T17:58:13.903304Z","steps":["trace[266407068] 'process raft request' (duration: 99.024126ms)","trace[266407068] 'compare' (duration: 160.244749ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:15.227256Z","caller":"traceutil/trace.go:171","msg":"trace[1842918094] linearizableReadLoop","detail":"{readStateIndex:1323; appliedIndex:1322; }","duration":"216.941473ms","start":"2026-03-26T17:58:15.010265Z","end":"2026-03-26T17:58:15.227207Z","steps":["trace[1842918094] 'read index received' (duration: 216.779699ms)","trace[1842918094] 'applied index is now lower than readState.Index' (duration: 160.584µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:15.227345Z","caller":"traceutil/trace.go:171","msg":"trace[1241465469] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"371.625775ms","start":"2026-03-26T17:58:14.855687Z","end":"2026-03-26T17:58:15.227313Z","steps":["trace[1241465469] 'process raft request' (duration: 371.308776ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:15.227437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.13701ms","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":"warn","ts":"2026-03-26T17:58:15.227499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:14.855667Z","time spent":"371.753229ms","remote":"127.0.0.1:41306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:15.227519Z","caller":"traceutil/trace.go:171","msg":"trace[1133827709] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1269; }","duration":"217.276493ms","start":"2026-03-26T17:58:15.010224Z","end":"2026-03-26T17:58:15.227501Z","steps":["trace[1133827709] 'agreement among raft nodes before linearized reading' (duration: 217.105849ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:15.452803Z","caller":"traceutil/trace.go:171","msg":"trace[142009937] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"225.457403ms","start":"2026-03-26T17:58:15.227321Z","end":"2026-03-26T17:58:15.452778Z","steps":["trace[142009937] 'read index received' (duration: 223.951881ms)","trace[142009937] 'applied index is now lower than readState.Index' (duration: 1.504602ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:15.452858Z","caller":"traceutil/trace.go:171","msg":"trace[113391272] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"310.817505ms","start":"2026-03-26T17:58:15.142013Z","end":"2026-03-26T17:58:15.45283Z","steps":["trace[113391272] 'process raft request' (duration: 309.335583ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:15.452938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.597012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:58:15.452974Z","caller":"traceutil/trace.go:171","msg":"trace[728621545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1270; }","duration":"394.682644ms","start":"2026-03-26T17:58:15.058281Z","end":"2026-03-26T17:58:15.452964Z","steps":["trace[728621545] 'agreement among raft nodes before linearized reading' (duration: 394.602602ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:15.453016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:15.058265Z","time spent":"394.743776ms","remote":"127.0.0.1:41124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T17:58:15.453032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:15.141986Z","time spent":"310.933818ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:17.115843Z","caller":"traceutil/trace.go:171","msg":"trace[53023154] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"104.980244ms","start":"2026-03-26T17:58:17.010844Z","end":"2026-03-26T17:58:17.115824Z","steps":["trace[53023154] 'process raft request' (duration: 104.538731ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:18.069348Z","caller":"traceutil/trace.go:171","msg":"trace[315948611] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"137.515928ms","start":"2026-03-26T17:58:17.931809Z","end":"2026-03-26T17:58:18.069325Z","steps":["trace[315948611] 'process raft request' (duration: 136.942612ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:18.496518Z","caller":"traceutil/trace.go:171","msg":"trace[1645152921] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"423.051112ms","start":"2026-03-26T17:58:18.073437Z","end":"2026-03-26T17:58:18.496488Z","steps":["trace[1645152921] 'process raft request' (duration: 418.115113ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:18.496683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:18.073417Z","time spent":"423.178056ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:18.584458Z","caller":"traceutil/trace.go:171","msg":"trace[652546012] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"509.781262ms","start":"2026-03-26T17:58:18.074646Z","end":"2026-03-26T17:58:18.584427Z","steps":["trace[652546012] 'process raft request' (duration: 509.443892ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:18.584586Z","caller":"traceutil/trace.go:171","msg":"trace[1349559642] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"508.808375ms","start":"2026-03-26T17:58:18.075766Z","end":"2026-03-26T17:58:18.584575Z","steps":["trace[1349559642] 'process raft request' (duration: 508.605849ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:18.584619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:18.07462Z","time spent":"509.917216ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:18.584628Z","caller":"traceutil/trace.go:171","msg":"trace[1819062204] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"508.546667ms","start":"2026-03-26T17:58:18.076018Z","end":"2026-03-26T17:58:18.584564Z","steps":["trace[1819062204] 'process raft request' (duration: 508.476175ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:18.584725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:18.075752Z","time spent":"508.901957ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:58:18.584772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:18.075993Z","time spent":"508.729352ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:18.584435Z","caller":"traceutil/trace.go:171","msg":"trace[536505385] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"509.578486ms","start":"2026-03-26T17:58:18.074831Z","end":"2026-03-26T17:58:18.58441Z","steps":["trace[536505385] 'process raft request' (duration: 509.467103ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:18.584897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:18.0748Z","time spent":"510.06885ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:19.254964Z","caller":"traceutil/trace.go:171","msg":"trace[1855439502] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"189.301135ms","start":"2026-03-26T17:58:19.065635Z","end":"2026-03-26T17:58:19.254936Z","steps":["trace[1855439502] 'process raft request' (duration: 189.12084ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:20.60009Z","caller":"traceutil/trace.go:171","msg":"trace[1792877709] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1347; }","duration":"482.874305ms","start":"2026-03-26T17:58:20.117197Z","end":"2026-03-26T17:58:20.600072Z","steps":["trace[1792877709] 'read index received' (duration: 482.781952ms)","trace[1792877709] 'applied index is now lower than readState.Index' (duration: 91.313µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:20.600202Z","caller":"traceutil/trace.go:171","msg":"trace[844105644] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"524.813285ms","start":"2026-03-26T17:58:20.075379Z","end":"2026-03-26T17:58:20.600192Z","steps":["trace[844105644] 'process raft request' (duration: 524.567118ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:20.600302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:20.075359Z","time spent":"524.872306ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:58:20.600754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.556654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-26T17:58:20.600925Z","caller":"traceutil/trace.go:171","msg":"trace[2143860409] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:1293; }","duration":"483.678848ms","start":"2026-03-26T17:58:20.117142Z","end":"2026-03-26T17:58:20.600821Z","steps":["trace[2143860409] 'agreement among raft nodes before linearized reading' (duration: 483.532744ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:20.600976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:20.117123Z","time spent":"483.840732ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.157\" "} {"level":"warn","ts":"2026-03-26T17:58:20.601296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.322463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-26T17:58:20.601386Z","caller":"traceutil/trace.go:171","msg":"trace[538043223] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1293; }","duration":"100.424575ms","start":"2026-03-26T17:58:20.500921Z","end":"2026-03-26T17:58:20.601346Z","steps":["trace[538043223] 'agreement among raft nodes before linearized reading' (duration: 100.281521ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:20.920839Z","caller":"traceutil/trace.go:171","msg":"trace[1822782027] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"315.63341ms","start":"2026-03-26T17:58:20.605183Z","end":"2026-03-26T17:58:20.920816Z","steps":["trace[1822782027] 'process raft request' (duration: 315.519317ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:20.920844Z","caller":"traceutil/trace.go:171","msg":"trace[817576914] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"315.684141ms","start":"2026-03-26T17:58:20.605132Z","end":"2026-03-26T17:58:20.920816Z","steps":["trace[817576914] 'process raft request' (duration: 295.490303ms)","trace[817576914] 'compare' (duration: 19.865259ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:20.92088Z","caller":"traceutil/trace.go:171","msg":"trace[51583603] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"315.460715ms","start":"2026-03-26T17:58:20.605403Z","end":"2026-03-26T17:58:20.920864Z","steps":["trace[51583603] 'process raft request' (duration: 315.425294ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:20.920971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:20.605395Z","time spent":"315.527337ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:58:20.92097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:20.60517Z","time spent":"315.732873ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:58:20.920975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:20.605115Z","time spent":"315.799945ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:20.921003Z","caller":"traceutil/trace.go:171","msg":"trace[128226125] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"315.755713ms","start":"2026-03-26T17:58:20.605227Z","end":"2026-03-26T17:58:20.920983Z","steps":["trace[128226125] 'process raft request' (duration: 315.523047ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:20.921084Z","caller":"traceutil/trace.go:171","msg":"trace[1926677120] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"315.829166ms","start":"2026-03-26T17:58:20.605245Z","end":"2026-03-26T17:58:20.921074Z","steps":["trace[1926677120] 'process raft request' (duration: 315.538658ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:20.921107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:20.605219Z","time spent":"315.829436ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:58:20.921143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:20.605229Z","time spent":"315.877117ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:20.949792Z","caller":"traceutil/trace.go:171","msg":"trace[1694360297] linearizableReadLoop","detail":"{readStateIndex:1356; appliedIndex:1349; }","duration":"203.165996ms","start":"2026-03-26T17:58:20.746608Z","end":"2026-03-26T17:58:20.949774Z","steps":["trace[1694360297] 'read index received' (duration: 154.029594ms)","trace[1694360297] 'applied index is now lower than readState.Index' (duration: 49.135572ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:20.949834Z","caller":"traceutil/trace.go:171","msg":"trace[470891699] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"312.377778ms","start":"2026-03-26T17:58:20.637434Z","end":"2026-03-26T17:58:20.949812Z","steps":["trace[470891699] 'process raft request' (duration: 312.197043ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:20.949892Z","caller":"traceutil/trace.go:171","msg":"trace[2125006743] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"304.843646ms","start":"2026-03-26T17:58:20.645039Z","end":"2026-03-26T17:58:20.949883Z","steps":["trace[2125006743] 'process raft request' (duration: 304.692292ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:20.949959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:20.637422Z","time spent":"312.464731ms","remote":"127.0.0.1:41146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:58:20.95006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.458294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:58:20.950101Z","caller":"traceutil/trace.go:171","msg":"trace[915403131] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:1300; }","duration":"203.537356ms","start":"2026-03-26T17:58:20.746555Z","end":"2026-03-26T17:58:20.950092Z","steps":["trace[915403131] 'agreement among raft nodes before linearized reading' (duration: 203.433553ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:20.949965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:20.645026Z","time spent":"304.896538ms","remote":"127.0.0.1:41202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":806,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T17:58:21.15605Z","caller":"traceutil/trace.go:171","msg":"trace[1988377245] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"201.876649ms","start":"2026-03-26T17:58:20.954143Z","end":"2026-03-26T17:58:21.15602Z","steps":["trace[1988377245] 'process raft request' (duration: 103.248875ms)","trace[1988377245] 'compare' (duration: 98.139521ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:21.189904Z","caller":"traceutil/trace.go:171","msg":"trace[599487682] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1356; }","duration":"235.071733ms","start":"2026-03-26T17:58:20.954812Z","end":"2026-03-26T17:58:21.189884Z","steps":["trace[599487682] 'read index received' (duration: 102.594566ms)","trace[599487682] 'applied index is now lower than readState.Index' (duration: 132.475987ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:21.190152Z","caller":"traceutil/trace.go:171","msg":"trace[2030391616] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"235.66177ms","start":"2026-03-26T17:58:20.954476Z","end":"2026-03-26T17:58:21.190138Z","steps":["trace[2030391616] 'process raft request' (duration: 235.29671ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:21.190344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.515845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-03-26T17:58:21.190379Z","caller":"traceutil/trace.go:171","msg":"trace[300070591] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1302; }","duration":"235.584858ms","start":"2026-03-26T17:58:20.954783Z","end":"2026-03-26T17:58:21.190368Z","steps":["trace[300070591] 'agreement among raft nodes before linearized reading' (duration: 235.507795ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:21.196805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.680831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:58:21.196909Z","caller":"traceutil/trace.go:171","msg":"trace[732786954] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:1303; }","duration":"240.826225ms","start":"2026-03-26T17:58:20.956057Z","end":"2026-03-26T17:58:21.196883Z","steps":["trace[732786954] 'agreement among raft nodes before linearized reading' (duration: 240.566168ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:24.383897Z","caller":"traceutil/trace.go:171","msg":"trace[1401949608] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"315.116706ms","start":"2026-03-26T17:58:24.068755Z","end":"2026-03-26T17:58:24.383871Z","steps":["trace[1401949608] 'process raft request' (duration: 314.92409ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:24.384035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:24.068734Z","time spent":"315.227048ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:24.643239Z","caller":"traceutil/trace.go:171","msg":"trace[1366442331] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"574.200254ms","start":"2026-03-26T17:58:24.068945Z","end":"2026-03-26T17:58:24.643146Z","steps":["trace[1366442331] 'process raft request' (duration: 571.987492ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:24.643828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:24.068937Z","time spent":"574.41361ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:58:25.21069Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938290404220005681,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T17:58:25.711736Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938290404220005681,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T17:58:26.018026Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.377153254s","expected-duration":"1s"} {"level":"info","ts":"2026-03-26T17:58:26.018866Z","caller":"traceutil/trace.go:171","msg":"trace[350502925] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"1.406307855s","start":"2026-03-26T17:58:24.612541Z","end":"2026-03-26T17:58:26.018849Z","steps":["trace[350502925] 'process raft request' (duration: 1.405768479s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.018978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:24.612516Z","time spent":"1.406404738s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T17:58:26.02069Z","caller":"traceutil/trace.go:171","msg":"trace[78315162] linearizableReadLoop","detail":"{readStateIndex:1382; appliedIndex:1379; }","duration":"1.310500539s","start":"2026-03-26T17:58:24.710175Z","end":"2026-03-26T17:58:26.020675Z","steps":["trace[78315162] 'read index received' (duration: 1.307961728s)","trace[78315162] 'applied index is now lower than readState.Index' (duration: 2.538181ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:26.020779Z","caller":"traceutil/trace.go:171","msg":"trace[855505677] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"325.118217ms","start":"2026-03-26T17:58:25.695628Z","end":"2026-03-26T17:58:26.020747Z","steps":["trace[855505677] 'process raft request' (duration: 324.985713ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.020879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:25.695604Z","time spent":"325.19924ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T17:58:26.020895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0873068s","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-03-26T17:58:26.020924Z","caller":"traceutil/trace.go:171","msg":"trace[752832952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1325; }","duration":"1.087397283s","start":"2026-03-26T17:58:24.933518Z","end":"2026-03-26T17:58:26.020915Z","steps":["trace[752832952] 'agreement among raft nodes before linearized reading' (duration: 1.08730076s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.020944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:24.933498Z","time spent":"1.087442263s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-26T17:58:26.021017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.310861419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-26T17:58:26.02104Z","caller":"traceutil/trace.go:171","msg":"trace[88610184] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1325; }","duration":"1.310931661s","start":"2026-03-26T17:58:24.710103Z","end":"2026-03-26T17:58:26.021035Z","steps":["trace[88610184] 'agreement among raft nodes before linearized reading' (duration: 1.31089368s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.021058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:24.710077Z","time spent":"1.310976033s","remote":"127.0.0.1:41452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":29,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-03-26T17:58:26.021187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.980636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-03-26T17:58:26.021223Z","caller":"traceutil/trace.go:171","msg":"trace[1123188483] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1325; }","duration":"800.058659ms","start":"2026-03-26T17:58:25.221156Z","end":"2026-03-26T17:58:26.021215Z","steps":["trace[1123188483] 'agreement among raft nodes before linearized reading' (duration: 799.991247ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.021336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084310825s","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-03-26T17:58:26.021369Z","caller":"traceutil/trace.go:171","msg":"trace[472567727] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1325; }","duration":"1.084397608s","start":"2026-03-26T17:58:24.936963Z","end":"2026-03-26T17:58:26.021361Z","steps":["trace[472567727] 'agreement among raft nodes before linearized reading' (duration: 1.084261054s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.02141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:24.936933Z","time spent":"1.084468909s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-26T17:58:26.021526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.787097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T17:58:26.021548Z","caller":"traceutil/trace.go:171","msg":"trace[1283709259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1325; }","duration":"962.850658ms","start":"2026-03-26T17:58:25.058692Z","end":"2026-03-26T17:58:26.021543Z","steps":["trace[1283709259] 'agreement among raft nodes before linearized reading' (duration: 962.815647ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.021592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:25.05867Z","time spent":"962.915961ms","remote":"127.0.0.1:41124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-26T17:58:26.021757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084402558s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-26T17:58:26.02181Z","caller":"traceutil/trace.go:171","msg":"trace[220828472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1325; }","duration":"1.08447449s","start":"2026-03-26T17:58:24.937324Z","end":"2026-03-26T17:58:26.021799Z","steps":["trace[220828472] 'agreement among raft nodes before linearized reading' (duration: 1.084367667s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.021833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:24.937313Z","time spent":"1.084515591s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-26T17:58:26.022154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.087959498s","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-03-26T17:58:26.022186Z","caller":"traceutil/trace.go:171","msg":"trace[979530140] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1325; }","duration":"1.087993499s","start":"2026-03-26T17:58:24.934186Z","end":"2026-03-26T17:58:26.022179Z","steps":["trace[979530140] 'agreement among raft nodes before linearized reading' (duration: 1.087912267s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.022204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:24.934133Z","time spent":"1.088066831s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-26T17:58:26.02236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.087195667s","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-03-26T17:58:26.022401Z","caller":"traceutil/trace.go:171","msg":"trace[526242497] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1325; }","duration":"1.087253788s","start":"2026-03-26T17:58:24.935136Z","end":"2026-03-26T17:58:26.022389Z","steps":["trace[526242497] 'agreement among raft nodes before linearized reading' (duration: 1.087136025s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T17:58:26.022432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:24.93513Z","time spent":"1.087296279s","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-26T17:58:26.021252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T17:58:25.221135Z","time spent":"800.11096ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-03-26T17:58:46.435772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.735443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T17:58:46.436048Z","caller":"traceutil/trace.go:171","msg":"trace[47100444] linearizableReadLoop","detail":"{readStateIndex:1484; appliedIndex:1479; }","duration":"199.77146ms","start":"2026-03-26T17:58:46.236259Z","end":"2026-03-26T17:58:46.436031Z","steps":["trace[47100444] 'read index received' (duration: 97.705969ms)","trace[47100444] 'applied index is now lower than readState.Index' (duration: 102.064221ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T17:58:46.436208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.942645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-03-26T17:58:46.436244Z","caller":"traceutil/trace.go:171","msg":"trace[997732747] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1423; }","duration":"199.994537ms","start":"2026-03-26T17:58:46.236238Z","end":"2026-03-26T17:58:46.436233Z","steps":["trace[997732747] 'agreement among raft nodes before linearized reading' (duration: 199.849203ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:46.436386Z","caller":"traceutil/trace.go:171","msg":"trace[117011921] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"201.947011ms","start":"2026-03-26T17:58:46.234149Z","end":"2026-03-26T17:58:46.436096Z","steps":["trace[117011921] 'process raft request' (duration: 201.783737ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:46.436509Z","caller":"traceutil/trace.go:171","msg":"trace[655964417] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"202.327293ms","start":"2026-03-26T17:58:46.23417Z","end":"2026-03-26T17:58:46.436497Z","steps":["trace[655964417] 'process raft request' (duration: 201.798418ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:46.436581Z","caller":"traceutil/trace.go:171","msg":"trace[655736737] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"203.65907ms","start":"2026-03-26T17:58:46.232774Z","end":"2026-03-26T17:58:46.436433Z","steps":["trace[655736737] 'process raft request' (duration: 101.176876ms)","trace[655736737] 'compare' (duration: 101.598589ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T17:58:46.436681Z","caller":"traceutil/trace.go:171","msg":"trace[1952074335] transaction","detail":"{read_only:false; response_revision:1423; number_of_response:1; }","duration":"202.375323ms","start":"2026-03-26T17:58:46.234296Z","end":"2026-03-26T17:58:46.436671Z","steps":["trace[1952074335] 'process raft request' (duration: 201.700914ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:58:46.436694Z","caller":"traceutil/trace.go:171","msg":"trace[1763802415] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"202.544629ms","start":"2026-03-26T17:58:46.234094Z","end":"2026-03-26T17:58:46.436639Z","steps":["trace[1763802415] 'process raft request' (duration: 201.784667ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T17:59:10.415374Z","caller":"traceutil/trace.go:171","msg":"trace[1871511586] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"164.536892ms","start":"2026-03-26T17:59:10.250801Z","end":"2026-03-26T17:59:10.415337Z","steps":["trace[1871511586] 'process raft request' (duration: 164.327046ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:01:42.412227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.667601ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T18:01:42.41233Z","caller":"traceutil/trace.go:171","msg":"trace[915376129] linearizableReadLoop","detail":"{readStateIndex:2354; appliedIndex:2353; }","duration":"516.28413ms","start":"2026-03-26T18:01:41.89603Z","end":"2026-03-26T18:01:42.412314Z","steps":["trace[915376129] 'read index received' (duration: 92.458595ms)","trace[915376129] 'applied index is now lower than readState.Index' (duration: 423.824345ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T18:01:42.412553Z","caller":"traceutil/trace.go:171","msg":"trace[1471157645] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"663.116321ms","start":"2026-03-26T18:01:41.749418Z","end":"2026-03-26T18:01:42.412534Z","steps":["trace[1471157645] 'process raft request' (duration: 239.06125ms)","trace[1471157645] 'compare' (duration: 423.523096ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T18:01:42.412626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T18:01:41.749398Z","time spent":"663.191193ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T18:01:42.412861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.835425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-03-26T18:01:42.4129Z","caller":"traceutil/trace.go:171","msg":"trace[490655145] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2257; }","duration":"516.910327ms","start":"2026-03-26T18:01:41.89598Z","end":"2026-03-26T18:01:42.41289Z","steps":["trace[490655145] 'agreement among raft nodes before linearized reading' (duration: 516.790783ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:01:42.412929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T18:01:41.895963Z","time spent":"516.959819ms","remote":"127.0.0.1:41438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-03-26T18:01:42.41304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.31492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T18:01:42.413119Z","caller":"traceutil/trace.go:171","msg":"trace[45879831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2257; }","duration":"355.445794ms","start":"2026-03-26T18:01:42.057652Z","end":"2026-03-26T18:01:42.413098Z","steps":["trace[45879831] 'agreement among raft nodes before linearized reading' (duration: 355.30516ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T18:01:42.413165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T18:01:42.05763Z","time spent":"355.527635ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}