{"level":"warn","ts":"2026-04-21T17:12:37.518911Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T17:12:37.519008Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.249:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.249:2380","--initial-cluster=instance=https://199.19.213.249:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.249:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.249:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-21T17:12:37.51909Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T17:12:37.519106Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.249:2380"]} {"level":"info","ts":"2026-04-21T17:12:37.519132Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-21T17:12:37.519839Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.249:2379"]} {"level":"info","ts":"2026-04-21T17:12:37.519927Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.249:2380"],"listen-peer-urls":["https://199.19.213.249:2380"],"advertise-client-urls":["https://199.19.213.249:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.249:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.249:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-21T17:12:37.525366Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.174743ms"} {"level":"info","ts":"2026-04-21T17:12:37.532818Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5835264b86215850","cluster-id":"4e10f3807bdbbd9b"} {"level":"info","ts":"2026-04-21T17:12:37.532892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T17:12:37.532918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became follower at term 0"} {"level":"info","ts":"2026-04-21T17:12:37.532929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5835264b86215850 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T17:12:37.53294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became follower at term 1"} {"level":"info","ts":"2026-04-21T17:12:37.532973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 switched to configuration voters=(6356028554918058064)"} {"level":"warn","ts":"2026-04-21T17:12:37.540548Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T17:12:37.543226Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T17:12:37.549836Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-21T17:12:37.551917Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5835264b86215850","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T17:12:37.556871Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-21T17:12:37.55716Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-21T17:12:37.557176Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-21T17:12:37.55719Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5835264b86215850","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T17:12:37.560957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 switched to configuration voters=(6356028554918058064)"} {"level":"info","ts":"2026-04-21T17:12:37.561023Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-21T17:12:37.561186Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4e10f3807bdbbd9b","local-member-id":"5835264b86215850","added-peer-id":"5835264b86215850","added-peer-peer-urls":["https://199.19.213.249:2380"]} {"level":"info","ts":"2026-04-21T17:12:37.561405Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5835264b86215850","initial-advertise-peer-urls":["https://199.19.213.249:2380"],"listen-peer-urls":["https://199.19.213.249:2380"],"advertise-client-urls":["https://199.19.213.249:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.249:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T17:12:37.561427Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T17:12:37.561428Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.249:2380"} {"level":"info","ts":"2026-04-21T17:12:37.561477Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.249:2380"} {"level":"info","ts":"2026-04-21T17:12:38.533454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T17:12:38.533528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T17:12:38.533551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 received MsgPreVoteResp from 5835264b86215850 at term 1"} {"level":"info","ts":"2026-04-21T17:12:38.53357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became candidate at term 2"} {"level":"info","ts":"2026-04-21T17:12:38.533586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 received MsgVoteResp from 5835264b86215850 at term 2"} {"level":"info","ts":"2026-04-21T17:12:38.533603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became leader at term 2"} {"level":"info","ts":"2026-04-21T17:12:38.533615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5835264b86215850 elected leader 5835264b86215850 at term 2"} {"level":"info","ts":"2026-04-21T17:12:38.53465Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5835264b86215850","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.249:2379]}","request-path":"/0/members/5835264b86215850/attributes","cluster-id":"4e10f3807bdbbd9b","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T17:12:38.5347Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:12:38.534875Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:12:38.534845Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:12:38.535905Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4e10f3807bdbbd9b","local-member-id":"5835264b86215850","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:12:38.536038Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:12:38.536084Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:12:38.536914Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.249:2379"} {"level":"info","ts":"2026-04-21T17:12:38.537859Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T17:12:38.542286Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T17:12:38.542316Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-04-21T17:13:07.620122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.05923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:13:07.62025Z","caller":"traceutil/trace.go:171","msg":"trace[2137171941] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:503; }","duration":"233.229866ms","start":"2026-04-21T17:13:07.387001Z","end":"2026-04-21T17:13:07.620231Z","steps":["trace[2137171941] 'range keys from in-memory index tree' (duration: 232.963327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:07.620412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.590652ms","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:329952"} {"level":"info","ts":"2026-04-21T17:13:07.62052Z","caller":"traceutil/trace.go:171","msg":"trace[2090923536] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:503; }","duration":"200.736797ms","start":"2026-04-21T17:13:07.419755Z","end":"2026-04-21T17:13:07.620492Z","steps":["trace[2090923536] 'range keys from in-memory index tree' (duration: 200.257034ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:09.32539Z","caller":"traceutil/trace.go:171","msg":"trace[52145209] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"432.491481ms","start":"2026-04-21T17:13:08.892855Z","end":"2026-04-21T17:13:09.325346Z","steps":["trace[52145209] 'process raft request' (duration: 432.326806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:09.32611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.892832Z","time spent":"432.675325ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:13:09.337242Z","caller":"traceutil/trace.go:171","msg":"trace[2064798485] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"438.127606ms","start":"2026-04-21T17:13:08.899095Z","end":"2026-04-21T17:13:09.337223Z","steps":["trace[2064798485] 'process raft request' (duration: 437.89064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:09.33735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.899079Z","time spent":"438.218359ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:13:09.337321Z","caller":"traceutil/trace.go:171","msg":"trace[735859757] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"431.921376ms","start":"2026-04-21T17:13:08.905365Z","end":"2026-04-21T17:13:09.337286Z","steps":["trace[735859757] 'process raft request' (duration: 431.781812ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:09.337468Z","caller":"traceutil/trace.go:171","msg":"trace[406991204] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"425.849097ms","start":"2026-04-21T17:13:08.911608Z","end":"2026-04-21T17:13:09.337457Z","steps":["trace[406991204] 'process raft request' (duration: 425.655552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:09.33758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.911605Z","time spent":"425.892738ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:13:09.337611Z","caller":"traceutil/trace.go:171","msg":"trace[1246422952] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"425.712794ms","start":"2026-04-21T17:13:08.911799Z","end":"2026-04-21T17:13:09.337512Z","steps":["trace[1246422952] 'process raft request' (duration: 425.495958ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:09.337666Z","caller":"traceutil/trace.go:171","msg":"trace[80115982] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"426.095643ms","start":"2026-04-21T17:13:08.911561Z","end":"2026-04-21T17:13:09.337657Z","steps":["trace[80115982] 'process raft request' (duration: 425.660651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:09.337708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.911551Z","time spent":"426.140415ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:13:09.337692Z","caller":"traceutil/trace.go:171","msg":"trace[1951643134] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"407.309335ms","start":"2026-04-21T17:13:08.930345Z","end":"2026-04-21T17:13:09.337654Z","steps":["trace[1951643134] 'process raft request' (duration: 407.018208ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:09.337656Z","caller":"traceutil/trace.go:171","msg":"trace[1858383573] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"431.869494ms","start":"2026-04-21T17:13:08.905702Z","end":"2026-04-21T17:13:09.337572Z","steps":["trace[1858383573] 'process raft request' (duration: 431.480114ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:09.337768Z","caller":"traceutil/trace.go:171","msg":"trace[1277514612] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"438.608949ms","start":"2026-04-21T17:13:08.899152Z","end":"2026-04-21T17:13:09.337761Z","steps":["trace[1277514612] 'process raft request' (duration: 437.951111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:09.33779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.930313Z","time spent":"407.432498ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:13:09.337828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.899147Z","time spent":"438.666841ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:13:09.337838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.911794Z","time spent":"425.92718ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:13:09.337869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.755785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:13:09.33793Z","caller":"traceutil/trace.go:171","msg":"trace[3894623] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"385.974725ms","start":"2026-04-21T17:13:08.951948Z","end":"2026-04-21T17:13:09.337923Z","steps":["trace[3894623] 'process raft request' (duration: 385.514052ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:09.337963Z","caller":"traceutil/trace.go:171","msg":"trace[2029765081] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"280.958644ms","start":"2026-04-21T17:13:09.056994Z","end":"2026-04-21T17:13:09.337952Z","steps":["trace[2029765081] 'process raft request' (duration: 280.606774ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:09.337992Z","caller":"traceutil/trace.go:171","msg":"trace[496299913] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"401.594827ms","start":"2026-04-21T17:13:08.936382Z","end":"2026-04-21T17:13:09.337977Z","steps":["trace[496299913] 'process raft request' (duration: 401.027992ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:09.33793Z","caller":"traceutil/trace.go:171","msg":"trace[1013663538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:520; }","duration":"328.871907ms","start":"2026-04-21T17:13:09.009042Z","end":"2026-04-21T17:13:09.337914Z","steps":["trace[1013663538] 'agreement among raft nodes before linearized reading' (duration: 328.735933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:09.338004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.905459Z","time spent":"432.355017ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:13:09.338062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.936364Z","time spent":"401.670099ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:13:09.337967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.951921Z","time spent":"386.030887ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:13:09.337682Z","caller":"traceutil/trace.go:171","msg":"trace[57352117] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:524; }","duration":"328.559088ms","start":"2026-04-21T17:13:09.009099Z","end":"2026-04-21T17:13:09.337658Z","steps":["trace[57352117] 'read index received' (duration: 316.348931ms)","trace[57352117] 'applied index is now lower than readState.Index' (duration: 12.209307ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:09.337504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:08.905345Z","time spent":"432.069129ms","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:13:09.338065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:09.009021Z","time spent":"329.025901ms","remote":"127.0.0.1:57712","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-04-21T17:13:10.694272Z","caller":"traceutil/trace.go:171","msg":"trace[1606652722] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"120.13447ms","start":"2026-04-21T17:13:10.574122Z","end":"2026-04-21T17:13:10.694257Z","steps":["trace[1606652722] 'process raft request' (duration: 92.094866ms)","trace[1606652722] 'compare' (duration: 27.771437ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:10.694559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.54783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-04-21T17:13:10.694665Z","caller":"traceutil/trace.go:171","msg":"trace[1638681516] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:587; }","duration":"116.700845ms","start":"2026-04-21T17:13:10.577942Z","end":"2026-04-21T17:13:10.694643Z","steps":["trace[1638681516] 'agreement among raft nodes before linearized reading' (duration: 116.422497ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:10.694754Z","caller":"traceutil/trace.go:171","msg":"trace[506723762] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"116.202831ms","start":"2026-04-21T17:13:10.577985Z","end":"2026-04-21T17:13:10.694187Z","steps":["trace[506723762] 'read index received' (duration: 88.097424ms)","trace[506723762] 'applied index is now lower than readState.Index' (duration: 28.104457ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:12.154925Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363759657136529858,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T17:13:12.252235Z","caller":"traceutil/trace.go:171","msg":"trace[1440440741] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"597.872231ms","start":"2026-04-21T17:13:11.654332Z","end":"2026-04-21T17:13:12.252204Z","steps":["trace[1440440741] 'read index received' (duration: 597.577904ms)","trace[1440440741] 'applied index is now lower than readState.Index' (duration: 293.067µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:12.252405Z","caller":"traceutil/trace.go:171","msg":"trace[1071130259] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"845.041763ms","start":"2026-04-21T17:13:11.407348Z","end":"2026-04-21T17:13:12.25239Z","steps":["trace[1071130259] 'process raft request' (duration: 844.679943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:12.252673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.557392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:13:12.252733Z","caller":"traceutil/trace.go:171","msg":"trace[821524542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"361.649435ms","start":"2026-04-21T17:13:11.891062Z","end":"2026-04-21T17:13:12.252712Z","steps":["trace[821524542] 'agreement among raft nodes before linearized reading' (duration: 361.492661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:12.252726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.367655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-21T17:13:12.252778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:11.891044Z","time spent":"361.723137ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:13:12.252795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:11.407334Z","time spent":"845.119245ms","remote":"127.0.0.1:57712","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-04-21T17:13:12.252784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.014343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:13:12.252816Z","caller":"traceutil/trace.go:171","msg":"trace[1372314561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"598.49757ms","start":"2026-04-21T17:13:11.654292Z","end":"2026-04-21T17:13:12.252789Z","steps":["trace[1372314561] 'agreement among raft nodes before linearized reading' (duration: 598.266454ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:12.252874Z","caller":"traceutil/trace.go:171","msg":"trace[1775162199] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:589; }","duration":"138.186908ms","start":"2026-04-21T17:13:12.114669Z","end":"2026-04-21T17:13:12.252856Z","steps":["trace[1775162199] 'agreement among raft nodes before linearized reading' (duration: 137.926152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:12.252883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:11.654272Z","time spent":"598.597502ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T17:13:12.720403Z","caller":"traceutil/trace.go:171","msg":"trace[1675567074] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"310.079668ms","start":"2026-04-21T17:13:12.410294Z","end":"2026-04-21T17:13:12.720373Z","steps":["trace[1675567074] 'process raft request' (duration: 309.863192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:12.720591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:12.410277Z","time spent":"310.216873ms","remote":"127.0.0.1:57650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:13:12.726334Z","caller":"traceutil/trace.go:171","msg":"trace[2140763760] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:611; }","duration":"249.408752ms","start":"2026-04-21T17:13:12.476902Z","end":"2026-04-21T17:13:12.726311Z","steps":["trace[2140763760] 'read index received' (duration: 243.237751ms)","trace[2140763760] 'applied index is now lower than readState.Index' (duration: 6.170041ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:12.726386Z","caller":"traceutil/trace.go:171","msg":"trace[2105919448] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"315.519509ms","start":"2026-04-21T17:13:12.410837Z","end":"2026-04-21T17:13:12.726357Z","steps":["trace[2105919448] 'process raft request' (duration: 315.350084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:12.726502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.591806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.249\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-21T17:13:12.726532Z","caller":"traceutil/trace.go:171","msg":"trace[6075535] range","detail":"{range_begin:/registry/masterleases/199.19.213.249; range_end:; response_count:1; response_revision:595; }","duration":"249.68454ms","start":"2026-04-21T17:13:12.47684Z","end":"2026-04-21T17:13:12.726525Z","steps":["trace[6075535] 'agreement among raft nodes before linearized reading' (duration: 249.577647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:12.726532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.116126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:12.726555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:12.410803Z","time spent":"315.658053ms","remote":"127.0.0.1:57550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1749,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:13:12.726587Z","caller":"traceutil/trace.go:171","msg":"trace[676079295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"172.215359ms","start":"2026-04-21T17:13:12.554358Z","end":"2026-04-21T17:13:12.726573Z","steps":["trace[676079295] 'agreement among raft nodes before linearized reading' (duration: 172.114876ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:14.953557Z","caller":"traceutil/trace.go:171","msg":"trace[1321232503] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"104.717343ms","start":"2026-04-21T17:13:14.848817Z","end":"2026-04-21T17:13:14.953534Z","steps":["trace[1321232503] 'process raft request' (duration: 104.285231ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:15.264097Z","caller":"traceutil/trace.go:171","msg":"trace[1238670915] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"169.893726ms","start":"2026-04-21T17:13:15.094172Z","end":"2026-04-21T17:13:15.264066Z","steps":["trace[1238670915] 'process raft request' (duration: 169.796253ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:15.264151Z","caller":"traceutil/trace.go:171","msg":"trace[190136105] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"257.621199ms","start":"2026-04-21T17:13:15.006487Z","end":"2026-04-21T17:13:15.264108Z","steps":["trace[190136105] 'process raft request' (duration: 226.178419ms)","trace[190136105] 'compare' (duration: 31.0772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.199257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.096078ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-21T17:13:18.399151Z","caller":"traceutil/trace.go:171","msg":"trace[1127428055] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:647; }","duration":"672.864304ms","start":"2026-04-21T17:13:17.726221Z","end":"2026-04-21T17:13:18.399085Z","steps":["trace[1127428055] 'read index received' (duration: 61.114559ms)","trace[1127428055] 'applied index is now lower than readState.Index' (duration: 611.748525ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.399543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.290606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.399619Z","caller":"traceutil/trace.go:171","msg":"trace[282219342] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:629; }","duration":"673.384989ms","start":"2026-04-21T17:13:17.726214Z","end":"2026-04-21T17:13:18.399599Z","steps":["trace[282219342] 'agreement among raft nodes before linearized reading' (duration: 673.208604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:18.399659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.726194Z","time spent":"673.45933ms","remote":"127.0.0.1:40936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:13:18.399927Z","caller":"traceutil/trace.go:171","msg":"trace[1854735755] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"804.483201ms","start":"2026-04-21T17:13:17.595435Z","end":"2026-04-21T17:13:18.399918Z","steps":["trace[1854735755] 'process raft request' (duration: 803.481234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:18.399991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.704967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.400035Z","caller":"traceutil/trace.go:171","msg":"trace[102830728] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:629; }","duration":"673.79653ms","start":"2026-04-21T17:13:17.726228Z","end":"2026-04-21T17:13:18.400024Z","steps":["trace[102830728] 'agreement among raft nodes before linearized reading' (duration: 673.676777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:18.400137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.726208Z","time spent":"673.917554ms","remote":"127.0.0.1:40936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:18.400246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.394153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.400284Z","caller":"traceutil/trace.go:171","msg":"trace[1085424959] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:629; }","duration":"549.454654ms","start":"2026-04-21T17:13:17.85082Z","end":"2026-04-21T17:13:18.400275Z","steps":["trace[1085424959] 'agreement among raft nodes before linearized reading' (duration: 549.360541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:18.400307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.850812Z","time spent":"549.489894ms","remote":"127.0.0.1:40982","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":"warn","ts":"2026-04-21T17:13:18.400004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.595411Z","time spent":"804.536721ms","remote":"127.0.0.1:57626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:13:18.40016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.153566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.400524Z","caller":"traceutil/trace.go:171","msg":"trace[659204710] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:629; }","duration":"257.516026ms","start":"2026-04-21T17:13:18.142999Z","end":"2026-04-21T17:13:18.400515Z","steps":["trace[659204710] 'agreement among raft nodes before linearized reading' (duration: 257.125826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:18.446555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.23939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.446679Z","caller":"traceutil/trace.go:171","msg":"trace[1110532134] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:629; }","duration":"544.381683ms","start":"2026-04-21T17:13:17.902274Z","end":"2026-04-21T17:13:18.446655Z","steps":["trace[1110532134] 'agreement among raft nodes before linearized reading' (duration: 498.241688ms)","trace[1110532134] 'range keys from in-memory index tree' (duration: 45.978631ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.446858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.902203Z","time spent":"544.6224ms","remote":"127.0.0.1:40990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:18.447012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.058511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.447052Z","caller":"traceutil/trace.go:171","msg":"trace[1084350733] 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:629; }","duration":"275.139943ms","start":"2026-04-21T17:13:18.171899Z","end":"2026-04-21T17:13:18.447039Z","steps":["trace[1084350733] 'agreement among raft nodes before linearized reading' (duration: 228.768022ms)","trace[1084350733] 'range keys from in-memory index tree' (duration: 46.32138ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.795542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.44709Z","caller":"traceutil/trace.go:171","msg":"trace[2082143702] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:629; }","duration":"596.957646ms","start":"2026-04-21T17:13:17.850119Z","end":"2026-04-21T17:13:18.447077Z","steps":["trace[2082143702] 'agreement among raft nodes before linearized reading' (duration: 550.203054ms)","trace[2082143702] 'count revisions from in-memory index tree' (duration: 46.70878ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.850088Z","time spent":"597.032929ms","remote":"127.0.0.1:40982","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-04-21T17:13:18.447153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.281544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.447178Z","caller":"traceutil/trace.go:171","msg":"trace[1185966056] 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:629; }","duration":"276.328576ms","start":"2026-04-21T17:13:18.170841Z","end":"2026-04-21T17:13:18.44717Z","steps":["trace[1185966056] 'agreement among raft nodes before linearized reading' (duration: 229.891992ms)","trace[1185966056] 'range keys from in-memory index tree' (duration: 46.405342ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.481998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.44729Z","caller":"traceutil/trace.go:171","msg":"trace[1526339190] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:629; }","duration":"163.539689ms","start":"2026-04-21T17:13:18.283743Z","end":"2026-04-21T17:13:18.447283Z","steps":["trace[1526339190] 'agreement among raft nodes before linearized reading' (duration: 116.991952ms)","trace[1526339190] 'range keys from in-memory index tree' (duration: 46.510104ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.364252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.447395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.544672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.447425Z","caller":"traceutil/trace.go:171","msg":"trace[812838452] 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:629; }","duration":"276.572282ms","start":"2026-04-21T17:13:18.170844Z","end":"2026-04-21T17:13:18.447416Z","steps":["trace[812838452] 'agreement among raft nodes before linearized reading' (duration: 229.896773ms)","trace[812838452] 'count revisions from in-memory index tree' (duration: 46.637719ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.292221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.447484Z","caller":"traceutil/trace.go:171","msg":"trace[804280781] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:629; }","duration":"337.364152ms","start":"2026-04-21T17:13:18.110107Z","end":"2026-04-21T17:13:18.447471Z","steps":["trace[804280781] 'agreement among raft nodes before linearized reading' (duration: 290.335784ms)","trace[804280781] 'count revisions from in-memory index tree' (duration: 46.971077ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.010612ms","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":"warn","ts":"2026-04-21T17:13:18.447531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.110087Z","time spent":"337.431304ms","remote":"127.0.0.1:41018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:18.447563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.130435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.447587Z","caller":"traceutil/trace.go:171","msg":"trace[1638638167] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:629; }","duration":"164.184056ms","start":"2026-04-21T17:13:18.283396Z","end":"2026-04-21T17:13:18.44758Z","steps":["trace[1638638167] 'agreement among raft nodes before linearized reading' (duration: 117.356833ms)","trace[1638638167] 'range keys from in-memory index tree' (duration: 46.798373ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.44749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.327549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.447653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.645501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.447677Z","caller":"traceutil/trace.go:171","msg":"trace[558420691] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:629; }","duration":"693.609707ms","start":"2026-04-21T17:13:17.754034Z","end":"2026-04-21T17:13:18.447644Z","steps":["trace[558420691] 'agreement among raft nodes before linearized reading' (duration: 646.402992ms)","trace[558420691] 'range keys from in-memory index tree' (duration: 46.871905ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.931043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.447771Z","caller":"traceutil/trace.go:171","msg":"trace[2029208269] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:629; }","duration":"721.006355ms","start":"2026-04-21T17:13:17.726753Z","end":"2026-04-21T17:13:18.44776Z","steps":["trace[2029208269] 'agreement among raft nodes before linearized reading' (duration: 673.694118ms)","trace[2029208269] 'range keys from in-memory index tree' (duration: 47.247416ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.44781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.726744Z","time spent":"721.056736ms","remote":"127.0.0.1:40936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:13:18.44783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.228967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.447835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.461789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.447897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.518193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.447892Z","caller":"traceutil/trace.go:171","msg":"trace[1295635536] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:629; }","duration":"304.308049ms","start":"2026-04-21T17:13:18.143576Z","end":"2026-04-21T17:13:18.447884Z","steps":["trace[1295635536] 'agreement among raft nodes before linearized reading' (duration: 257.149496ms)","trace[1295635536] 'range keys from in-memory index tree' (duration: 47.082992ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:18.447944Z","caller":"traceutil/trace.go:171","msg":"trace[1173453817] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:629; }","duration":"247.58206ms","start":"2026-04-21T17:13:18.200321Z","end":"2026-04-21T17:13:18.447903Z","steps":["trace[1173453817] 'agreement among raft nodes before linearized reading' (duration: 200.392587ms)","trace[1173453817] 'range keys from in-memory index tree' (duration: 47.081771ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:18.447951Z","caller":"traceutil/trace.go:171","msg":"trace[1014469892] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:629; }","duration":"664.614546ms","start":"2026-04-21T17:13:17.783326Z","end":"2026-04-21T17:13:18.44794Z","steps":["trace[1014469892] 'agreement among raft nodes before linearized reading' (duration: 617.055791ms)","trace[1014469892] 'range keys from in-memory index tree' (duration: 47.480362ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.863207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.448019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.739497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.448035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.783309Z","time spent":"664.698018ms","remote":"127.0.0.1:40966","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-04-21T17:13:18.448054Z","caller":"traceutil/trace.go:171","msg":"trace[1711924180] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:629; }","duration":"373.792429ms","start":"2026-04-21T17:13:18.074251Z","end":"2026-04-21T17:13:18.448043Z","steps":["trace[1711924180] 'agreement among raft nodes before linearized reading' (duration: 326.223984ms)","trace[1711924180] 'count revisions from in-memory index tree' (duration: 47.528773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.44799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.545382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.447497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.895643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.448093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.074229Z","time spent":"373.856201ms","remote":"127.0.0.1:41010","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-04-21T17:13:18.4481Z","caller":"traceutil/trace.go:171","msg":"trace[638726277] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:629; }","duration":"373.649835ms","start":"2026-04-21T17:13:18.074436Z","end":"2026-04-21T17:13:18.448086Z","steps":["trace[638726277] 'agreement among raft nodes before linearized reading' (duration: 326.031669ms)","trace[638726277] 'range keys from in-memory index tree' (duration: 47.508043ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:18.448123Z","caller":"traceutil/trace.go:171","msg":"trace[512340279] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:629; }","duration":"247.55427ms","start":"2026-04-21T17:13:18.200555Z","end":"2026-04-21T17:13:18.44811Z","steps":["trace[512340279] 'agreement among raft nodes before linearized reading' (duration: 200.15011ms)","trace[512340279] 'count revisions from in-memory index tree' (duration: 46.772723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.448147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.074338Z","time spent":"373.79833ms","remote":"127.0.0.1:41010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:18.448194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.880776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.447721Z","caller":"traceutil/trace.go:171","msg":"trace[1858689443] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:629; }","duration":"134.696502ms","start":"2026-04-21T17:13:18.312996Z","end":"2026-04-21T17:13:18.447693Z","steps":["trace[1858689443] 'agreement among raft nodes before linearized reading' (duration: 87.711173ms)","trace[1858689443] 'range keys from in-memory index tree' (duration: 46.926407ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.120743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.448237Z","caller":"traceutil/trace.go:171","msg":"trace[1354703217] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:629; }","duration":"646.945407ms","start":"2026-04-21T17:13:17.801276Z","end":"2026-04-21T17:13:18.448222Z","steps":["trace[1354703217] 'agreement among raft nodes before linearized reading' (duration: 599.073335ms)","trace[1354703217] 'count revisions from in-memory index tree' (duration: 47.807941ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.448284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.432362ms","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":"warn","ts":"2026-04-21T17:13:18.447957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.940395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.448301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.801272Z","time spent":"647.02202ms","remote":"127.0.0.1:40974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:18.448358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.353316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.448327Z","caller":"traceutil/trace.go:171","msg":"trace[406514547] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:629; }","duration":"373.339186ms","start":"2026-04-21T17:13:18.07498Z","end":"2026-04-21T17:13:18.448319Z","steps":["trace[406514547] 'agreement among raft nodes before linearized reading' (duration: 325.472414ms)","trace[406514547] 'range keys from in-memory index tree' (duration: 47.480262ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:18.448051Z","caller":"traceutil/trace.go:171","msg":"trace[791699202] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:629; }","duration":"232.019642ms","start":"2026-04-21T17:13:18.215998Z","end":"2026-04-21T17:13:18.448018Z","steps":["trace[791699202] 'agreement among raft nodes before linearized reading' (duration: 184.681784ms)","trace[791699202] 'range keys from in-memory index tree' (duration: 47.199674ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:18.448389Z","caller":"traceutil/trace.go:171","msg":"trace[1436182077] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:629; }","duration":"247.395616ms","start":"2026-04-21T17:13:18.200984Z","end":"2026-04-21T17:13:18.44838Z","steps":["trace[1436182077] 'agreement among raft nodes before linearized reading' (duration: 199.713938ms)","trace[1436182077] 'range keys from in-memory index tree' (duration: 47.644978ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.447344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.786064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.448324Z","caller":"traceutil/trace.go:171","msg":"trace[436122683] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:629; }","duration":"232.534936ms","start":"2026-04-21T17:13:18.215778Z","end":"2026-04-21T17:13:18.448313Z","steps":["trace[436122683] 'agreement among raft nodes before linearized reading' (duration: 184.91138ms)","trace[436122683] 'count revisions from in-memory index tree' (duration: 47.575505ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:18.447388Z","caller":"traceutil/trace.go:171","msg":"trace[782430175] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:629; }","duration":"502.428473ms","start":"2026-04-21T17:13:17.944926Z","end":"2026-04-21T17:13:18.447355Z","steps":["trace[782430175] 'agreement among raft nodes before linearized reading' (duration: 455.557188ms)","trace[782430175] 'range keys from in-memory index tree' (duration: 46.802414ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.448666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.204064ms","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-04-21T17:13:18.448698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.944918Z","time spent":"503.765182ms","remote":"127.0.0.1:40990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"info","ts":"2026-04-21T17:13:18.448717Z","caller":"traceutil/trace.go:171","msg":"trace[1582513201] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:629; }","duration":"694.290656ms","start":"2026-04-21T17:13:17.754415Z","end":"2026-04-21T17:13:18.448706Z","steps":["trace[1582513201] 'agreement among raft nodes before linearized reading' (duration: 645.973261ms)","trace[1582513201] 'range keys from in-memory index tree' (duration: 48.229833ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.448745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.754409Z","time spent":"694.327977ms","remote":"127.0.0.1:40950","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:13:18.448038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.143569Z","time spent":"304.451774ms","remote":"127.0.0.1:41026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:13:18.448836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.47108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.448872Z","caller":"traceutil/trace.go:171","msg":"trace[513889772] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:629; }","duration":"546.560953ms","start":"2026-04-21T17:13:17.902301Z","end":"2026-04-21T17:13:18.448861Z","steps":["trace[513889772] 'agreement among raft nodes before linearized reading' (duration: 498.204747ms)","trace[513889772] 'count revisions from in-memory index tree' (duration: 48.312065ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.448899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.902296Z","time spent":"546.596536ms","remote":"127.0.0.1:40990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:18.448986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.299975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.449016Z","caller":"traceutil/trace.go:171","msg":"trace[2046985036] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:629; }","duration":"504.374309ms","start":"2026-04-21T17:13:17.94463Z","end":"2026-04-21T17:13:18.449004Z","steps":["trace[2046985036] 'agreement among raft nodes before linearized reading' (duration: 455.861647ms)","trace[2046985036] 'count revisions from in-memory index tree' (duration: 48.477249ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.449041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.944607Z","time spent":"504.427959ms","remote":"127.0.0.1:41004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:18.448992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.022093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.449108Z","caller":"traceutil/trace.go:171","msg":"trace[1049141615] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:629; }","duration":"599.138327ms","start":"2026-04-21T17:13:17.849961Z","end":"2026-04-21T17:13:18.4491Z","steps":["trace[1049141615] 'agreement among raft nodes before linearized reading' (duration: 550.37218ms)","trace[1049141615] 'range keys from in-memory index tree' (duration: 48.640523ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.44916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.849923Z","time spent":"599.230159ms","remote":"127.0.0.1:40982","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-04-21T17:13:18.449263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.068379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.449291Z","caller":"traceutil/trace.go:171","msg":"trace[1569977550] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:629; }","duration":"648.12949ms","start":"2026-04-21T17:13:17.801154Z","end":"2026-04-21T17:13:18.449283Z","steps":["trace[1569977550] 'agreement among raft nodes before linearized reading' (duration: 599.202858ms)","trace[1569977550] 'range keys from in-memory index tree' (duration: 48.890991ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.449318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.801136Z","time spent":"648.175402ms","remote":"127.0.0.1:40974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:18.449365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.233242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:18.449386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.383976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.449403Z","caller":"traceutil/trace.go:171","msg":"trace[1429379692] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:629; }","duration":"695.283514ms","start":"2026-04-21T17:13:17.75411Z","end":"2026-04-21T17:13:18.449394Z","steps":["trace[1429379692] 'agreement among raft nodes before linearized reading' (duration: 646.28934ms)","trace[1429379692] 'count revisions from in-memory index tree' (duration: 48.912372ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:18.449424Z","caller":"traceutil/trace.go:171","msg":"trace[347880250] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:629; }","duration":"665.432788ms","start":"2026-04-21T17:13:17.783979Z","end":"2026-04-21T17:13:18.449412Z","steps":["trace[347880250] 'agreement among raft nodes before linearized reading' (duration: 616.384273ms)","trace[347880250] 'range keys from in-memory index tree' (duration: 48.986784ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.449472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.754105Z","time spent":"695.358606ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:18.449485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.783974Z","time spent":"665.50306ms","remote":"127.0.0.1:40966","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-04-21T17:13:18.449555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.255086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.448292Z","caller":"traceutil/trace.go:171","msg":"trace[577400453] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:629; }","duration":"135.768272ms","start":"2026-04-21T17:13:18.312509Z","end":"2026-04-21T17:13:18.448278Z","steps":["trace[577400453] 'agreement among raft nodes before linearized reading' (duration: 88.207318ms)","trace[577400453] 'range keys from in-memory index tree' (duration: 46.935537ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:18.44754Z","caller":"traceutil/trace.go:171","msg":"trace[396955484] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:629; }","duration":"164.056463ms","start":"2026-04-21T17:13:18.283477Z","end":"2026-04-21T17:13:18.447534Z","steps":["trace[396955484] 'agreement among raft nodes before linearized reading' (duration: 117.2678ms)","trace[396955484] 'count revisions from in-memory index tree' (duration: 46.753782ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.449602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.349967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.449694Z","caller":"traceutil/trace.go:171","msg":"trace[1568131694] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:629; }","duration":"339.490431ms","start":"2026-04-21T17:13:18.110194Z","end":"2026-04-21T17:13:18.449684Z","steps":["trace[1568131694] 'agreement among raft nodes before linearized reading' (duration: 290.23939ms)","trace[1568131694] 'range keys from in-memory index tree' (duration: 49.151357ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:18.450741Z","caller":"traceutil/trace.go:171","msg":"trace[563994876] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:629; }","duration":"136.106691ms","start":"2026-04-21T17:13:18.31243Z","end":"2026-04-21T17:13:18.448536Z","steps":["trace[563994876] 'agreement among raft nodes before linearized reading' (duration: 88.29395ms)","trace[563994876] 'count revisions from in-memory index tree' (duration: 46.461594ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.450778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.110165Z","time spent":"340.597812ms","remote":"127.0.0.1:41018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:18.447794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.754015Z","time spent":"693.747211ms","remote":"127.0.0.1:40950","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:18.449132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.665446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.450935Z","caller":"traceutil/trace.go:171","msg":"trace[428356714] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:629; }","duration":"506.497747ms","start":"2026-04-21T17:13:17.944423Z","end":"2026-04-21T17:13:18.45092Z","steps":["trace[428356714] 'agreement among raft nodes before linearized reading' (duration: 456.075914ms)","trace[428356714] 'range keys from in-memory index tree' (duration: 48.618144ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.450975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.944397Z","time spent":"506.566149ms","remote":"127.0.0.1:41004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:18.448984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.005806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.451062Z","caller":"traceutil/trace.go:171","msg":"trace[1719418636] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:629; }","duration":"308.124024ms","start":"2026-04-21T17:13:18.142926Z","end":"2026-04-21T17:13:18.45105Z","steps":["trace[1719418636] 'agreement among raft nodes before linearized reading' (duration: 257.490254ms)","trace[1719418636] 'count revisions from in-memory index tree' (duration: 48.529481ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.451094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.142907Z","time spent":"308.177307ms","remote":"127.0.0.1:41026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:13:18.449889Z","caller":"traceutil/trace.go:171","msg":"trace[1826391242] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:629; }","duration":"647.861704ms","start":"2026-04-21T17:13:17.802013Z","end":"2026-04-21T17:13:18.449874Z","steps":["trace[1826391242] 'agreement among raft nodes before linearized reading' (duration: 598.328505ms)","trace[1826391242] 'range keys from in-memory index tree' (duration: 48.926252ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.451181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.802008Z","time spent":"649.141349ms","remote":"127.0.0.1:40974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:13:18.450011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.597111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.451253Z","caller":"traceutil/trace.go:171","msg":"trace[1921765883] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:629; }","duration":"667.900816ms","start":"2026-04-21T17:13:17.783343Z","end":"2026-04-21T17:13:18.451244Z","steps":["trace[1921765883] 'agreement among raft nodes before linearized reading' (duration: 617.03165ms)","trace[1921765883] 'count revisions from in-memory index tree' (duration: 49.57515ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.451285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:17.783328Z","time spent":"667.947848ms","remote":"127.0.0.1:40966","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":"warn","ts":"2026-04-21T17:13:18.450992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.937552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:18.452353Z","caller":"traceutil/trace.go:171","msg":"trace[1259334295] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:629; }","duration":"236.030463ms","start":"2026-04-21T17:13:18.216307Z","end":"2026-04-21T17:13:18.452337Z","steps":["trace[1259334295] 'agreement among raft nodes before linearized reading' (duration: 184.089807ms)","trace[1259334295] 'range keys from in-memory index tree' (duration: 46.820113ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:18.448521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.074971Z","time spent":"373.517891ms","remote":"127.0.0.1:41010","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-04-21T17:13:18.576175Z","caller":"traceutil/trace.go:171","msg":"trace[2122831059] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"118.577396ms","start":"2026-04-21T17:13:18.457556Z","end":"2026-04-21T17:13:18.576134Z","steps":["trace[2122831059] 'process raft request' (duration: 118.411732ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:19.236188Z","caller":"traceutil/trace.go:171","msg":"trace[392192764] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:649; }","duration":"720.540841ms","start":"2026-04-21T17:13:18.515625Z","end":"2026-04-21T17:13:19.236166Z","steps":["trace[392192764] 'read index received' (duration: 60.369779ms)","trace[392192764] 'applied index is now lower than readState.Index' (duration: 660.170012ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:19.236231Z","caller":"traceutil/trace.go:171","msg":"trace[330031667] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"777.806823ms","start":"2026-04-21T17:13:18.458382Z","end":"2026-04-21T17:13:19.236189Z","steps":["trace[330031667] 'process raft request' (duration: 758.684644ms)","trace[330031667] 'compare' (duration: 18.707167ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:19.23632Z","caller":"traceutil/trace.go:171","msg":"trace[1790069224] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"776.95883ms","start":"2026-04-21T17:13:18.459345Z","end":"2026-04-21T17:13:19.236304Z","steps":["trace[1790069224] 'process raft request' (duration: 776.694083ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:19.236423Z","caller":"traceutil/trace.go:171","msg":"trace[233868915] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"777.029691ms","start":"2026-04-21T17:13:18.459366Z","end":"2026-04-21T17:13:19.236396Z","steps":["trace[233868915] 'process raft request' (duration: 776.761554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.236467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.459326Z","time spent":"777.029843ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:13:19.236488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.480027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:19.236574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.459351Z","time spent":"777.137174ms","remote":"127.0.0.1:57712","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-04-21T17:13:19.23657Z","caller":"traceutil/trace.go:171","msg":"trace[2009223563] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"476.614109ms","start":"2026-04-21T17:13:18.759942Z","end":"2026-04-21T17:13:19.236556Z","steps":["trace[2009223563] 'agreement among raft nodes before linearized reading' (duration: 476.499576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.236582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.458365Z","time spent":"778.014509ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:13:19.23659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.459259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:19.236737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.630183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.236788Z","caller":"traceutil/trace.go:171","msg":"trace[244373482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"682.697305ms","start":"2026-04-21T17:13:18.554078Z","end":"2026-04-21T17:13:19.236775Z","steps":["trace[244373482] 'agreement among raft nodes before linearized reading' (duration: 682.634893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.2368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.327714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:19.236814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.784847ms","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":"warn","ts":"2026-04-21T17:13:19.236832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.554068Z","time spent":"682.755117ms","remote":"127.0.0.1:57462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:13:19.23683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.709614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.23686Z","caller":"traceutil/trace.go:171","msg":"trace[1938031846] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:633; }","duration":"628.377695ms","start":"2026-04-21T17:13:18.60846Z","end":"2026-04-21T17:13:19.236838Z","steps":["trace[1938031846] 'agreement among raft nodes before linearized reading' (duration: 628.309642ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:19.236873Z","caller":"traceutil/trace.go:171","msg":"trace[1854029959] 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:633; }","duration":"699.854119ms","start":"2026-04-21T17:13:18.536988Z","end":"2026-04-21T17:13:19.236842Z","steps":["trace[1854029959] 'agreement among raft nodes before linearized reading' (duration: 699.765106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.2366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.692673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:19.236923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.608375Z","time spent":"628.519149ms","remote":"127.0.0.1:41096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:19.236962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.49771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.236966Z","caller":"traceutil/trace.go:171","msg":"trace[743399121] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:633; }","duration":"663.100683ms","start":"2026-04-21T17:13:18.573848Z","end":"2026-04-21T17:13:19.236949Z","steps":["trace[743399121] 'agreement among raft nodes before linearized reading' (duration: 662.696331ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:19.236994Z","caller":"traceutil/trace.go:171","msg":"trace[1187031745] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"314.54589ms","start":"2026-04-21T17:13:18.922438Z","end":"2026-04-21T17:13:19.236983Z","steps":["trace[1187031745] 'agreement among raft nodes before linearized reading' (duration: 314.475899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.237032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.569141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:19.237057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.922432Z","time spent":"314.613043ms","remote":"127.0.0.1:41138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:13:19.237081Z","caller":"traceutil/trace.go:171","msg":"trace[2003689775] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:633; }","duration":"340.635242ms","start":"2026-04-21T17:13:18.896437Z","end":"2026-04-21T17:13:19.237073Z","steps":["trace[2003689775] 'agreement among raft nodes before linearized reading' (duration: 340.575051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.23708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.573828Z","time spent":"663.234487ms","remote":"127.0.0.1:41094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:13:19.236811Z","caller":"traceutil/trace.go:171","msg":"trace[1077741549] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:633; }","duration":"720.761886ms","start":"2026-04-21T17:13:18.515988Z","end":"2026-04-21T17:13:19.23675Z","steps":["trace[1077741549] 'agreement among raft nodes before linearized reading' (duration: 720.447987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.237186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.764157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.237218Z","caller":"traceutil/trace.go:171","msg":"trace[637028770] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"314.8482ms","start":"2026-04-21T17:13:18.92236Z","end":"2026-04-21T17:13:19.237208Z","steps":["trace[637028770] 'agreement among raft nodes before linearized reading' (duration: 314.790108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.23726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.922336Z","time spent":"314.896531ms","remote":"127.0.0.1:41138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:19.237283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.36069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:19.237321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.099335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:19.237327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.586662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.237362Z","caller":"traceutil/trace.go:171","msg":"trace[1052644969] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:633; }","duration":"663.451054ms","start":"2026-04-21T17:13:18.573897Z","end":"2026-04-21T17:13:19.237348Z","steps":["trace[1052644969] 'agreement among raft nodes before linearized reading' (duration: 663.341721ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:19.237371Z","caller":"traceutil/trace.go:171","msg":"trace[1101410838] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:633; }","duration":"721.195049ms","start":"2026-04-21T17:13:18.516164Z","end":"2026-04-21T17:13:19.237359Z","steps":["trace[1101410838] 'agreement among raft nodes before linearized reading' (duration: 721.126387ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:19.237388Z","caller":"traceutil/trace.go:171","msg":"trace[3832957] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"352.688475ms","start":"2026-04-21T17:13:18.884689Z","end":"2026-04-21T17:13:19.237377Z","steps":["trace[3832957] 'agreement among raft nodes before linearized reading' (duration: 352.606453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.237406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.573892Z","time spent":"663.500115ms","remote":"127.0.0.1:41094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:19.237409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.516136Z","time spent":"721.259ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:19.236677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.760774ms","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-04-21T17:13:19.237436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.720414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.237481Z","caller":"traceutil/trace.go:171","msg":"trace[1758727656] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:633; }","duration":"340.779966ms","start":"2026-04-21T17:13:18.896694Z","end":"2026-04-21T17:13:19.237474Z","steps":["trace[1758727656] 'agreement among raft nodes before linearized reading' (duration: 340.719074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.236745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.574022ms","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":"warn","ts":"2026-04-21T17:13:19.237578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.085574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.237612Z","caller":"traceutil/trace.go:171","msg":"trace[3206098] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:633; }","duration":"341.116145ms","start":"2026-04-21T17:13:18.896485Z","end":"2026-04-21T17:13:19.237601Z","steps":["trace[3206098] 'agreement among raft nodes before linearized reading' (duration: 341.055703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.237634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.896468Z","time spent":"341.159756ms","remote":"127.0.0.1:41122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:19.236679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.847378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:13:19.236654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.759915Z","time spent":"476.723203ms","remote":"127.0.0.1:41110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:13:19.237738Z","caller":"traceutil/trace.go:171","msg":"trace[902253327] 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:633; }","duration":"700.908437ms","start":"2026-04-21T17:13:18.536788Z","end":"2026-04-21T17:13:19.237697Z","steps":["trace[902253327] 'agreement among raft nodes before linearized reading' (duration: 699.851338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.237572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.841328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.236895Z","caller":"traceutil/trace.go:171","msg":"trace[1682010970] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"302.786476ms","start":"2026-04-21T17:13:18.934098Z","end":"2026-04-21T17:13:19.236884Z","steps":["trace[1682010970] 'agreement among raft nodes before linearized reading' (duration: 302.712054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.237817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.536776Z","time spent":"701.003241ms","remote":"127.0.0.1:41086","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":"info","ts":"2026-04-21T17:13:19.237827Z","caller":"traceutil/trace.go:171","msg":"trace[2059574192] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"354.127135ms","start":"2026-04-21T17:13:18.883689Z","end":"2026-04-21T17:13:19.237816Z","steps":["trace[2059574192] 'agreement among raft nodes before linearized reading' (duration: 353.855418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.237862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.883662Z","time spent":"354.190877ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:13:19.237866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.934086Z","time spent":"303.761763ms","remote":"127.0.0.1:41142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:13:19.237598Z","caller":"traceutil/trace.go:171","msg":"trace[745096333] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"477.671539ms","start":"2026-04-21T17:13:18.759907Z","end":"2026-04-21T17:13:19.237578Z","steps":["trace[745096333] 'agreement among raft nodes before linearized reading' (duration: 476.744703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.237972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.759843Z","time spent":"478.121472ms","remote":"127.0.0.1:41110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:19.237526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.896688Z","time spent":"340.829607ms","remote":"127.0.0.1:41122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:13:19.236727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.21707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.238013Z","caller":"traceutil/trace.go:171","msg":"trace[524255007] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"303.510616ms","start":"2026-04-21T17:13:18.93449Z","end":"2026-04-21T17:13:19.238001Z","steps":["trace[524255007] 'agreement among raft nodes before linearized reading' (duration: 302.20918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.237135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.89642Z","time spent":"340.705365ms","remote":"127.0.0.1:41122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:19.237266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.515959Z","time spent":"721.2297ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:13:19.236904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.53698Z","time spent":"699.915301ms","remote":"127.0.0.1:41086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:13:19.23806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.934484Z","time spent":"303.557497ms","remote":"127.0.0.1:41138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:13:19.237426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.884665Z","time spent":"352.751676ms","remote":"127.0.0.1:41110","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-04-21T17:13:19.237646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.991181ms","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-04-21T17:13:19.237205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.806235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.238254Z","caller":"traceutil/trace.go:171","msg":"trace[832299038] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:633; }","duration":"354.622329ms","start":"2026-04-21T17:13:18.883616Z","end":"2026-04-21T17:13:19.238239Z","steps":["trace[832299038] 'agreement among raft nodes before linearized reading' (duration: 353.980702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.238308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.883598Z","time spent":"354.693271ms","remote":"127.0.0.1:41114","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-04-21T17:13:19.238314Z","caller":"traceutil/trace.go:171","msg":"trace[853623460] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:633; }","duration":"629.902076ms","start":"2026-04-21T17:13:18.608383Z","end":"2026-04-21T17:13:19.238285Z","steps":["trace[853623460] 'agreement among raft nodes before linearized reading' (duration: 628.789585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.236966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.142477ms","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":"warn","ts":"2026-04-21T17:13:19.236791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.439438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.23857Z","caller":"traceutil/trace.go:171","msg":"trace[980771132] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:633; }","duration":"304.249626ms","start":"2026-04-21T17:13:18.934311Z","end":"2026-04-21T17:13:19.238561Z","steps":["trace[980771132] 'agreement among raft nodes before linearized reading' (duration: 302.433466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.238621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.934276Z","time spent":"304.333329ms","remote":"127.0.0.1:41142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:13:19.238634Z","caller":"traceutil/trace.go:171","msg":"trace[679108332] 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:633; }","duration":"701.672578ms","start":"2026-04-21T17:13:18.536784Z","end":"2026-04-21T17:13:19.238456Z","steps":["trace[679108332] 'agreement among raft nodes before linearized reading' (duration: 700.159447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.238398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.608312Z","time spent":"630.04711ms","remote":"127.0.0.1:41096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:13:19.237586Z","caller":"traceutil/trace.go:171","msg":"trace[983336930] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:633; }","duration":"628.429585ms","start":"2026-04-21T17:13:18.609136Z","end":"2026-04-21T17:13:19.237566Z","steps":["trace[983336930] 'agreement among raft nodes before linearized reading' (duration: 627.573021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.23923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.609077Z","time spent":"630.136862ms","remote":"127.0.0.1:41094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-21T17:13:19.239423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.536737Z","time spent":"702.659617ms","remote":"127.0.0.1:41086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-21T17:13:19.240218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.556952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:19.240407Z","caller":"traceutil/trace.go:171","msg":"trace[949615459] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:633; }","duration":"724.778388ms","start":"2026-04-21T17:13:18.515617Z","end":"2026-04-21T17:13:19.240396Z","steps":["trace[949615459] 'agreement among raft nodes before linearized reading' (duration: 720.734467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:19.240495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:18.515553Z","time spent":"724.925501ms","remote":"127.0.0.1:41074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-21T17:13:20.98499Z","caller":"traceutil/trace.go:171","msg":"trace[690611053] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"125.900769ms","start":"2026-04-21T17:13:20.859069Z","end":"2026-04-21T17:13:20.98497Z","steps":["trace[690611053] 'process raft request' (duration: 125.788036ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:37.611645Z","caller":"traceutil/trace.go:171","msg":"trace[1298474793] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"282.29381ms","start":"2026-04-21T17:13:37.329326Z","end":"2026-04-21T17:13:37.61162Z","steps":["trace[1298474793] 'read index received' (duration: 282.177287ms)","trace[1298474793] 'applied index is now lower than readState.Index' (duration: 115.573µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:37.611709Z","caller":"traceutil/trace.go:171","msg":"trace[1664901027] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"286.98056ms","start":"2026-04-21T17:13:37.324706Z","end":"2026-04-21T17:13:37.611686Z","steps":["trace[1664901027] 'process raft request' (duration: 286.752063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:37.611909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.574417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-21T17:13:37.612026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.172966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:13:37.612077Z","caller":"traceutil/trace.go:171","msg":"trace[1519726718] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:794; }","duration":"282.781764ms","start":"2026-04-21T17:13:37.329277Z","end":"2026-04-21T17:13:37.612058Z","steps":["trace[1519726718] 'agreement among raft nodes before linearized reading' (duration: 282.500986ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:37.612145Z","caller":"traceutil/trace.go:171","msg":"trace[440607488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"278.316081ms","start":"2026-04-21T17:13:37.33379Z","end":"2026-04-21T17:13:37.612107Z","steps":["trace[440607488] 'agreement among raft nodes before linearized reading' (duration: 278.033543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:37.612204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.140667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:13:37.612326Z","caller":"traceutil/trace.go:171","msg":"trace[1016157619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:794; }","duration":"277.330653ms","start":"2026-04-21T17:13:37.334964Z","end":"2026-04-21T17:13:37.612295Z","steps":["trace[1016157619] 'agreement among raft nodes before linearized reading' (duration: 276.987223ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:11.16919Z","caller":"traceutil/trace.go:171","msg":"trace[1539966164] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"193.481144ms","start":"2026-04-21T17:14:10.975689Z","end":"2026-04-21T17:14:11.16917Z","steps":["trace[1539966164] 'process raft request' (duration: 193.373931ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:11.556365Z","caller":"traceutil/trace.go:171","msg":"trace[1341933170] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"248.921223ms","start":"2026-04-21T17:14:11.307392Z","end":"2026-04-21T17:14:11.556313Z","steps":["trace[1341933170] 'process raft request' (duration: 248.705167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:12.213564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.204159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-21T17:14:12.213664Z","caller":"traceutil/trace.go:171","msg":"trace[1113370797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1005; }","duration":"421.342852ms","start":"2026-04-21T17:14:11.792301Z","end":"2026-04-21T17:14:12.213644Z","steps":["trace[1113370797] 'range keys from in-memory index tree' (duration: 421.037874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:12.213701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:11.792285Z","time spent":"421.407884ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:14:12.213739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.638071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:14:12.213781Z","caller":"traceutil/trace.go:171","msg":"trace[1174766941] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1005; }","duration":"304.716333ms","start":"2026-04-21T17:14:11.90905Z","end":"2026-04-21T17:14:12.213766Z","steps":["trace[1174766941] 'count revisions from in-memory index tree' (duration: 304.565249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:12.213805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:11.909029Z","time spent":"304.769165ms","remote":"127.0.0.1:57778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:14:12.213832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.418963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:14:12.213932Z","caller":"traceutil/trace.go:171","msg":"trace[310382028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1005; }","duration":"341.539286ms","start":"2026-04-21T17:14:11.872365Z","end":"2026-04-21T17:14:12.213904Z","steps":["trace[310382028] 'range keys from in-memory index tree' (duration: 341.31471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:12.213977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:11.872353Z","time spent":"341.614598ms","remote":"127.0.0.1:57712","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-04-21T17:14:12.214066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.002609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:14:12.214154Z","caller":"traceutil/trace.go:171","msg":"trace[1019533069] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1005; }","duration":"396.128332ms","start":"2026-04-21T17:14:11.818003Z","end":"2026-04-21T17:14:12.214131Z","steps":["trace[1019533069] 'range keys from in-memory index tree' (duration: 395.753102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:12.214199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:11.817985Z","time spent":"396.203924ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T17:14:12.21414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.945208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:14:12.214294Z","caller":"traceutil/trace.go:171","msg":"trace[1857053949] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1005; }","duration":"503.184526ms","start":"2026-04-21T17:14:11.711075Z","end":"2026-04-21T17:14:12.214259Z","steps":["trace[1857053949] 'count revisions from in-memory index tree' (duration: 502.853186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:12.214356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.762793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:14:12.214446Z","caller":"traceutil/trace.go:171","msg":"trace[1927230664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1005; }","duration":"345.878385ms","start":"2026-04-21T17:14:11.868555Z","end":"2026-04-21T17:14:12.214434Z","steps":["trace[1927230664] 'range keys from in-memory index tree' (duration: 344.652523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:12.214492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:11.868539Z","time spent":"345.944539ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:14:12.214368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:11.711058Z","time spent":"503.294798ms","remote":"127.0.0.1:57556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:14:12.440569Z","caller":"traceutil/trace.go:171","msg":"trace[1436998352] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"220.573426ms","start":"2026-04-21T17:14:12.219958Z","end":"2026-04-21T17:14:12.440532Z","steps":["trace[1436998352] 'process raft request' (duration: 220.34594ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:12.490854Z","caller":"traceutil/trace.go:171","msg":"trace[1716105856] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"270.600335ms","start":"2026-04-21T17:14:12.220171Z","end":"2026-04-21T17:14:12.490772Z","steps":["trace[1716105856] 'process raft request' (duration: 270.282956ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:12.491357Z","caller":"traceutil/trace.go:171","msg":"trace[264877909] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"270.959756ms","start":"2026-04-21T17:14:12.22039Z","end":"2026-04-21T17:14:12.491349Z","steps":["trace[264877909] 'process raft request' (duration: 270.629626ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:12.492121Z","caller":"traceutil/trace.go:171","msg":"trace[1251938448] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"105.85775ms","start":"2026-04-21T17:14:12.386243Z","end":"2026-04-21T17:14:12.492101Z","steps":["trace[1251938448] 'process raft request' (duration: 105.073307ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:12.491132Z","caller":"traceutil/trace.go:171","msg":"trace[418764764] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"270.862253ms","start":"2026-04-21T17:14:12.220247Z","end":"2026-04-21T17:14:12.491109Z","steps":["trace[418764764] 'process raft request' (duration: 270.4294ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:34.815109Z","caller":"traceutil/trace.go:171","msg":"trace[2145276645] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"260.846424ms","start":"2026-04-21T17:14:34.554237Z","end":"2026-04-21T17:14:34.815084Z","steps":["trace[2145276645] 'read index received' (duration: 260.722851ms)","trace[2145276645] 'applied index is now lower than readState.Index' (duration: 122.363µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:34.815204Z","caller":"traceutil/trace.go:171","msg":"trace[1776137122] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"274.060002ms","start":"2026-04-21T17:14:34.54111Z","end":"2026-04-21T17:14:34.81517Z","steps":["trace[1776137122] 'process raft request' (duration: 273.828276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:34.815341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.090392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:14:34.815404Z","caller":"traceutil/trace.go:171","msg":"trace[1955413074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1080; }","duration":"261.199494ms","start":"2026-04-21T17:14:34.554185Z","end":"2026-04-21T17:14:34.815384Z","steps":["trace[1955413074] 'agreement among raft nodes before linearized reading' (duration: 261.089561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:34.815576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.959487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:14:34.815652Z","caller":"traceutil/trace.go:171","msg":"trace[591262740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1080; }","duration":"212.074131ms","start":"2026-04-21T17:14:34.603557Z","end":"2026-04-21T17:14:34.815631Z","steps":["trace[591262740] 'agreement among raft nodes before linearized reading' (duration: 211.892126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:34.815903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.202645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:14:34.816006Z","caller":"traceutil/trace.go:171","msg":"trace[586932423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1080; }","duration":"207.35652ms","start":"2026-04-21T17:14:34.608625Z","end":"2026-04-21T17:14:34.815981Z","steps":["trace[586932423] 'agreement among raft nodes before linearized reading' (duration: 207.051421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:34.816472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.487265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-21T17:14:34.816755Z","caller":"traceutil/trace.go:171","msg":"trace[1353578503] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1080; }","duration":"206.850735ms","start":"2026-04-21T17:14:34.609864Z","end":"2026-04-21T17:14:34.816715Z","steps":["trace[1353578503] 'agreement among raft nodes before linearized reading' (duration: 205.680453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:36.110851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.743955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:14:36.111075Z","caller":"traceutil/trace.go:171","msg":"trace[955219724] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"1.290740718s","start":"2026-04-21T17:14:34.820296Z","end":"2026-04-21T17:14:36.111037Z","steps":["trace[955219724] 'process raft request' (duration: 900.711875ms)","trace[955219724] 'compare' (duration: 389.356875ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:36.111134Z","caller":"traceutil/trace.go:171","msg":"trace[819213626] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1119; }","duration":"742.017438ms","start":"2026-04-21T17:14:35.369099Z","end":"2026-04-21T17:14:36.111117Z","steps":["trace[819213626] 'read index received' (duration: 351.913443ms)","trace[819213626] 'applied index is now lower than readState.Index' (duration: 390.103215ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:36.111264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:34.820263Z","time spent":"1.290896232s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:14:36.111347Z","caller":"traceutil/trace.go:171","msg":"trace[1154611263] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"1.28970698s","start":"2026-04-21T17:14:34.821629Z","end":"2026-04-21T17:14:36.111336Z","steps":["trace[1154611263] 'process raft request' (duration: 1.289329259s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:36.111414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:34.821602Z","time spent":"1.289778741s","remote":"127.0.0.1:57712","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-04-21T17:14:36.111437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.314476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T17:14:36.11149Z","caller":"traceutil/trace.go:171","msg":"trace[535731424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1084; }","duration":"742.398868ms","start":"2026-04-21T17:14:35.369078Z","end":"2026-04-21T17:14:36.111477Z","steps":["trace[535731424] 'agreement among raft nodes before linearized reading' (duration: 742.253644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:36.111523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:35.369065Z","time spent":"742.451571ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:14:36.111646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.951732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:14:36.111692Z","caller":"traceutil/trace.go:171","msg":"trace[376647982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"560.023424ms","start":"2026-04-21T17:14:35.551657Z","end":"2026-04-21T17:14:36.111681Z","steps":["trace[376647982] 'agreement among raft nodes before linearized reading' (duration: 559.958462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:36.111722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:35.551638Z","time spent":"560.076324ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T17:14:36.111728Z","caller":"traceutil/trace.go:171","msg":"trace[1628773597] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"425.134698ms","start":"2026-04-21T17:14:35.686546Z","end":"2026-04-21T17:14:36.11168Z","steps":["trace[1628773597] 'process raft request' (duration: 424.531561ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:36.111665Z","caller":"traceutil/trace.go:171","msg":"trace[1861355289] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"1.289972877s","start":"2026-04-21T17:14:34.821683Z","end":"2026-04-21T17:14:36.111656Z","steps":["trace[1861355289] 'process raft request' (duration: 1.28936134s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:36.111852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:34.821659Z","time spent":"1.290143551s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:14:36.111866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:35.686523Z","time spent":"425.244681ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:14:36.318108Z","caller":"traceutil/trace.go:171","msg":"trace[975344676] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"202.914577ms","start":"2026-04-21T17:14:36.115172Z","end":"2026-04-21T17:14:36.318086Z","steps":["trace[975344676] 'process raft request' (duration: 202.754442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:38.131235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.673393ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-21T17:14:38.323296Z","caller":"traceutil/trace.go:171","msg":"trace[312200351] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"132.054778ms","start":"2026-04-21T17:14:38.19121Z","end":"2026-04-21T17:14:38.323265Z","steps":["trace[312200351] 'process raft request' (duration: 92.612602ms)","trace[312200351] 'compare' (duration: 38.997754ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:38.353515Z","caller":"traceutil/trace.go:171","msg":"trace[672118216] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"159.939722ms","start":"2026-04-21T17:14:38.193554Z","end":"2026-04-21T17:14:38.353494Z","steps":["trace[672118216] 'process raft request' (duration: 159.908261ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:38.353557Z","caller":"traceutil/trace.go:171","msg":"trace[875450269] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"162.118472ms","start":"2026-04-21T17:14:38.191409Z","end":"2026-04-21T17:14:38.353527Z","steps":["trace[875450269] 'process raft request' (duration: 161.949137ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:40.452363Z","caller":"traceutil/trace.go:171","msg":"trace[915129913] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"102.137816ms","start":"2026-04-21T17:14:40.350204Z","end":"2026-04-21T17:14:40.452342Z","steps":["trace[915129913] 'process raft request' (duration: 101.972342ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:40.673297Z","caller":"traceutil/trace.go:171","msg":"trace[558730768] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"216.617877ms","start":"2026-04-21T17:14:40.456648Z","end":"2026-04-21T17:14:40.673266Z","steps":["trace[558730768] 'process raft request' (duration: 125.132156ms)","trace[558730768] 'compare' (duration: 91.204323ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:40.673739Z","caller":"traceutil/trace.go:171","msg":"trace[248518509] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"215.000202ms","start":"2026-04-21T17:14:40.458731Z","end":"2026-04-21T17:14:40.673731Z","steps":["trace[248518509] 'process raft request' (duration: 214.879289ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:40.67368Z","caller":"traceutil/trace.go:171","msg":"trace[1213757224] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"216.448392ms","start":"2026-04-21T17:14:40.45722Z","end":"2026-04-21T17:14:40.673668Z","steps":["trace[1213757224] 'process raft request' (duration: 215.988019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:44.988648Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363759657136530997,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T17:14:45.013134Z","caller":"traceutil/trace.go:171","msg":"trace[1152849793] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1148; }","duration":"542.640222ms","start":"2026-04-21T17:14:44.470469Z","end":"2026-04-21T17:14:45.013109Z","steps":["trace[1152849793] 'read index received' (duration: 542.443626ms)","trace[1152849793] 'applied index is now lower than readState.Index' (duration: 195.646µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:45.013488Z","caller":"traceutil/trace.go:171","msg":"trace[502024504] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"790.29975ms","start":"2026-04-21T17:14:44.223175Z","end":"2026-04-21T17:14:45.013475Z","steps":["trace[502024504] 'process raft request' (duration: 789.793826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:45.013589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:44.223157Z","time spent":"790.366872ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:14:45.013895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.475146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-21T17:14:45.013994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.204048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-21T17:14:45.013987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.800125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:14:45.01401Z","caller":"traceutil/trace.go:171","msg":"trace[2128941308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1108; }","duration":"327.62441ms","start":"2026-04-21T17:14:44.686353Z","end":"2026-04-21T17:14:45.013977Z","steps":["trace[2128941308] 'agreement among raft nodes before linearized reading' (duration: 327.348313ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:45.014028Z","caller":"traceutil/trace.go:171","msg":"trace[1825926923] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1108; }","duration":"327.255539ms","start":"2026-04-21T17:14:44.686763Z","end":"2026-04-21T17:14:45.014018Z","steps":["trace[1825926923] 'agreement among raft nodes before linearized reading' (duration: 327.133445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:45.01406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:44.686755Z","time spent":"327.29844ms","remote":"127.0.0.1:57712","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":"info","ts":"2026-04-21T17:14:45.014058Z","caller":"traceutil/trace.go:171","msg":"trace[505309322] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1108; }","duration":"138.916629ms","start":"2026-04-21T17:14:44.875124Z","end":"2026-04-21T17:14:45.01404Z","steps":["trace[505309322] 'agreement among raft nodes before linearized reading' (duration: 138.633821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:45.014073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:44.686328Z","time spent":"327.731142ms","remote":"127.0.0.1:57712","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-04-21T17:14:45.014255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.790614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-21T17:14:45.014286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.754553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:14:45.014287Z","caller":"traceutil/trace.go:171","msg":"trace[1299780590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1108; }","duration":"543.856975ms","start":"2026-04-21T17:14:44.470421Z","end":"2026-04-21T17:14:45.014278Z","steps":["trace[1299780590] 'agreement among raft nodes before linearized reading' (duration: 543.749142ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:45.014323Z","caller":"traceutil/trace.go:171","msg":"trace[455023902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1108; }","duration":"327.829135ms","start":"2026-04-21T17:14:44.686485Z","end":"2026-04-21T17:14:45.014314Z","steps":["trace[455023902] 'agreement among raft nodes before linearized reading' (duration: 327.738562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:45.014352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:44.686466Z","time spent":"327.879047ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:14:45.014353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:44.470403Z","time spent":"543.921276ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-21T17:14:47.167081Z","caller":"traceutil/trace.go:171","msg":"trace[1282408027] linearizableReadLoop","detail":"{readStateIndex:1155; appliedIndex:1154; }","duration":"142.241451ms","start":"2026-04-21T17:14:47.024815Z","end":"2026-04-21T17:14:47.167056Z","steps":["trace[1282408027] 'read index received' (duration: 142.169709ms)","trace[1282408027] 'applied index is now lower than readState.Index' (duration: 70.802µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:47.167244Z","caller":"traceutil/trace.go:171","msg":"trace[1333465656] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"147.250239ms","start":"2026-04-21T17:14:47.019982Z","end":"2026-04-21T17:14:47.167232Z","steps":["trace[1333465656] 'process raft request' (duration: 146.88568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:47.168335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.504185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:14:47.168534Z","caller":"traceutil/trace.go:171","msg":"trace[1881759119] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1114; }","duration":"143.714431ms","start":"2026-04-21T17:14:47.0248Z","end":"2026-04-21T17:14:47.168514Z","steps":["trace[1881759119] 'agreement among raft nodes before linearized reading' (duration: 142.543879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:47.189686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.11806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-21T17:14:47.189715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.582803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T17:14:47.189778Z","caller":"traceutil/trace.go:171","msg":"trace[921813907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1115; }","duration":"163.256654ms","start":"2026-04-21T17:14:47.026502Z","end":"2026-04-21T17:14:47.189759Z","steps":["trace[921813907] 'agreement among raft nodes before linearized reading' (duration: 163.040118ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:47.189787Z","caller":"traceutil/trace.go:171","msg":"trace[96664534] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1115; }","duration":"163.687806ms","start":"2026-04-21T17:14:47.026083Z","end":"2026-04-21T17:14:47.189771Z","steps":["trace[96664534] 'agreement among raft nodes before linearized reading' (duration: 163.456159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:47.19002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.469929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-21T17:14:47.19011Z","caller":"traceutil/trace.go:171","msg":"trace[818344501] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1116; }","duration":"163.596634ms","start":"2026-04-21T17:14:47.0265Z","end":"2026-04-21T17:14:47.190097Z","steps":["trace[818344501] 'agreement among raft nodes before linearized reading' (duration: 163.066919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:47.190033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.659808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:14:47.190279Z","caller":"traceutil/trace.go:171","msg":"trace[1583074629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1116; }","duration":"163.052448ms","start":"2026-04-21T17:14:47.027204Z","end":"2026-04-21T17:14:47.190256Z","steps":["trace[1583074629] 'agreement among raft nodes before linearized reading' (duration: 162.41959ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:53.307718Z","caller":"traceutil/trace.go:171","msg":"trace[699782603] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"118.426539ms","start":"2026-04-21T17:14:53.189268Z","end":"2026-04-21T17:14:53.307694Z","steps":["trace[699782603] 'process raft request' (duration: 118.243824ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:55.721037Z","caller":"traceutil/trace.go:171","msg":"trace[53779932] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1236; }","duration":"399.225367ms","start":"2026-04-21T17:14:55.321792Z","end":"2026-04-21T17:14:55.721018Z","steps":["trace[53779932] 'read index received' (duration: 399.180017ms)","trace[53779932] 'applied index is now lower than readState.Index' (duration: 44.26µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:55.721125Z","caller":"traceutil/trace.go:171","msg":"trace[622661883] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"400.985816ms","start":"2026-04-21T17:14:55.320114Z","end":"2026-04-21T17:14:55.721099Z","steps":["trace[622661883] 'process raft request' (duration: 400.79157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:55.721208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.401943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-21T17:14:55.721236Z","caller":"traceutil/trace.go:171","msg":"trace[1708107976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1192; }","duration":"399.449644ms","start":"2026-04-21T17:14:55.321779Z","end":"2026-04-21T17:14:55.721229Z","steps":["trace[1708107976] 'agreement among raft nodes before linearized reading' (duration: 399.324791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:55.721258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:55.321773Z","time spent":"399.479466ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-21T17:14:55.721251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:55.320089Z","time spent":"401.09219ms","remote":"127.0.0.1:57712","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-04-21T17:14:56.221674Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363759657136531173,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T17:14:56.337288Z","caller":"traceutil/trace.go:171","msg":"trace[863993837] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"1.014209678s","start":"2026-04-21T17:14:55.323052Z","end":"2026-04-21T17:14:56.337262Z","steps":["trace[863993837] 'process raft request' (duration: 1.01320352s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:56.337657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:55.323041Z","time spent":"1.014538857s","remote":"127.0.0.1:57712","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-04-21T17:14:56.415388Z","caller":"traceutil/trace.go:171","msg":"trace[106926338] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1237; }","duration":"694.278193ms","start":"2026-04-21T17:14:55.72109Z","end":"2026-04-21T17:14:56.415368Z","steps":["trace[106926338] 'read index received' (duration: 615.179276ms)","trace[106926338] 'applied index is now lower than readState.Index' (duration: 79.098017ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:56.415563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.089262962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-21T17:14:56.415591Z","caller":"traceutil/trace.go:171","msg":"trace[1950901275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1194; }","duration":"1.089312785s","start":"2026-04-21T17:14:55.326269Z","end":"2026-04-21T17:14:56.415582Z","steps":["trace[1950901275] 'agreement among raft nodes before linearized reading' (duration: 1.08917386s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:56.415618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:55.326263Z","time spent":"1.089349035s","remote":"127.0.0.1:57712","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-04-21T17:14:56.41583Z","caller":"traceutil/trace.go:171","msg":"trace[483605272] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"689.546061ms","start":"2026-04-21T17:14:55.726276Z","end":"2026-04-21T17:14:56.415822Z","steps":["trace[483605272] 'process raft request' (duration: 688.993336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:56.415946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:55.726249Z","time spent":"689.655775ms","remote":"127.0.0.1:57712","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-04-21T17:14:56.416062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.615956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:14:56.416083Z","caller":"traceutil/trace.go:171","msg":"trace[680157790] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1194; }","duration":"863.662997ms","start":"2026-04-21T17:14:55.552415Z","end":"2026-04-21T17:14:56.416078Z","steps":["trace[680157790] 'agreement among raft nodes before linearized reading' (duration: 863.627896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:56.416099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:55.552399Z","time spent":"863.696018ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:14:56.416217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.089663723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-21T17:14:56.416239Z","caller":"traceutil/trace.go:171","msg":"trace[111239000] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1194; }","duration":"1.089695976s","start":"2026-04-21T17:14:55.326538Z","end":"2026-04-21T17:14:56.416234Z","steps":["trace[111239000] 'agreement among raft nodes before linearized reading' (duration: 1.089639994s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:56.416255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:55.326532Z","time spent":"1.089718626s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:14:56.416386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.089970683s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:14:56.416407Z","caller":"traceutil/trace.go:171","msg":"trace[186907206] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1194; }","duration":"1.090025124s","start":"2026-04-21T17:14:55.326376Z","end":"2026-04-21T17:14:56.416401Z","steps":["trace[186907206] 'agreement among raft nodes before linearized reading' (duration: 1.089967293s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:56.416423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:55.326359Z","time spent":"1.090059345s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T17:14:56.556716Z","caller":"traceutil/trace.go:171","msg":"trace[151171848] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"135.993627ms","start":"2026-04-21T17:14:56.420696Z","end":"2026-04-21T17:14:56.556689Z","steps":["trace[151171848] 'process raft request' (duration: 132.399717ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:56.556934Z","caller":"traceutil/trace.go:171","msg":"trace[1410778333] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"136.067859ms","start":"2026-04-21T17:14:56.420842Z","end":"2026-04-21T17:14:56.55691Z","steps":["trace[1410778333] 'process raft request' (duration: 135.785061ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:15:11.021774Z","caller":"traceutil/trace.go:171","msg":"trace[909076747] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"337.210006ms","start":"2026-04-21T17:15:10.684544Z","end":"2026-04-21T17:15:11.021754Z","steps":["trace[909076747] 'process raft request' (duration: 337.056432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:11.021895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:10.684506Z","time spent":"337.328658ms","remote":"127.0.0.1:57712","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-04-21T17:15:11.060139Z","caller":"traceutil/trace.go:171","msg":"trace[977195851] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"360.098801ms","start":"2026-04-21T17:15:10.699993Z","end":"2026-04-21T17:15:11.060092Z","steps":["trace[977195851] 'process raft request' (duration: 360.034979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:11.060344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:10.699972Z","time spent":"360.286997ms","remote":"127.0.0.1:57530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":870,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:15:11.060825Z","caller":"traceutil/trace.go:171","msg":"trace[2112582847] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"375.53069ms","start":"2026-04-21T17:15:10.685282Z","end":"2026-04-21T17:15:11.060813Z","steps":["trace[2112582847] 'process raft request' (duration: 374.477341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:11.060928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:10.68525Z","time spent":"375.639253ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:15:11.955191Z","caller":"traceutil/trace.go:171","msg":"trace[276622108] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"176.233245ms","start":"2026-04-21T17:15:11.778941Z","end":"2026-04-21T17:15:11.955174Z","steps":["trace[276622108] 'process raft request' (duration: 176.101181ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:15:12.679055Z","caller":"traceutil/trace.go:171","msg":"trace[993905666] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1299; }","duration":"123.208012ms","start":"2026-04-21T17:15:12.55582Z","end":"2026-04-21T17:15:12.679028Z","steps":["trace[993905666] 'read index received' (duration: 123.181572ms)","trace[993905666] 'applied index is now lower than readState.Index' (duration: 25.27µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:15:12.679144Z","caller":"traceutil/trace.go:171","msg":"trace[943200595] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"123.371227ms","start":"2026-04-21T17:15:12.555738Z","end":"2026-04-21T17:15:12.679109Z","steps":["trace[943200595] 'process raft request' (duration: 123.141289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:12.67923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.396237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:15:12.679269Z","caller":"traceutil/trace.go:171","msg":"trace[473429899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"123.528451ms","start":"2026-04-21T17:15:12.555728Z","end":"2026-04-21T17:15:12.679256Z","steps":["trace[473429899] 'agreement among raft nodes before linearized reading' (duration: 123.430248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:12.768738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.435033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:15:12.768755Z","caller":"traceutil/trace.go:171","msg":"trace[438995555] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"209.356415ms","start":"2026-04-21T17:15:12.559359Z","end":"2026-04-21T17:15:12.768716Z","steps":["trace[438995555] 'process raft request' (duration: 174.527247ms)","trace[438995555] 'compare' (duration: 34.55505ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:15:12.76882Z","caller":"traceutil/trace.go:171","msg":"trace[1556543247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1252; }","duration":"193.600277ms","start":"2026-04-21T17:15:12.575194Z","end":"2026-04-21T17:15:12.768795Z","steps":["trace[1556543247] 'agreement among raft nodes before linearized reading' (duration: 193.409542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:14.057328Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363759657136531326,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:15:14.557726Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363759657136531326,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:15:14.580625Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.02400191s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:15:14.581042Z","caller":"traceutil/trace.go:171","msg":"trace[1323991904] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"1.024531736s","start":"2026-04-21T17:15:13.556486Z","end":"2026-04-21T17:15:14.581017Z","steps":["trace[1323991904] 'process raft request' (duration: 1.024380351s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:14.581195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:13.556462Z","time spent":"1.024651069s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:15:15.557716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000550854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-21T17:15:15.557819Z","caller":"traceutil/trace.go:171","msg":"trace[1468673721] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000697737s","start":"2026-04-21T17:15:13.557103Z","end":"2026-04-21T17:15:15.557801Z","steps":["trace[1468673721] 'agreement among raft nodes before linearized reading' (duration: 2.000570334s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:15.557867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:13.557092Z","time spent":"2.000765598s","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:15:15.794663Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.210292714s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:15:15.795026Z","caller":"traceutil/trace.go:171","msg":"trace[118460121] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1304; }","duration":"2.237867043s","start":"2026-04-21T17:15:13.557141Z","end":"2026-04-21T17:15:15.795008Z","steps":["trace[118460121] 'read index received' (duration: 1.023733292s)","trace[118460121] 'applied index is now lower than readState.Index' (duration: 1.214132761s)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:15:15.795094Z","caller":"traceutil/trace.go:171","msg":"trace[970010117] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"1.833427901s","start":"2026-04-21T17:15:13.961637Z","end":"2026-04-21T17:15:15.795065Z","steps":["trace[970010117] 'process raft request' (duration: 1.833240135s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:15.795226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:13.961616Z","time spent":"1.833535754s","remote":"127.0.0.1:57712","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-04-21T17:15:16.297874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.47809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:15:16.297947Z","caller":"traceutil/trace.go:171","msg":"trace[1564866378] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1306; }","duration":"502.847726ms","start":"2026-04-21T17:15:15.795089Z","end":"2026-04-21T17:15:16.297937Z","steps":["trace[1564866378] 'read index received' (duration: 303.209831ms)","trace[1564866378] 'applied index is now lower than readState.Index' (duration: 199.636355ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:15:16.298058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.775400769s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T17:15:16.298078Z","caller":"traceutil/trace.go:171","msg":"trace[455501157] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1258; }","duration":"1.775458341s","start":"2026-04-21T17:15:14.522615Z","end":"2026-04-21T17:15:16.298073Z","steps":["trace[455501157] 'agreement among raft nodes before linearized reading' (duration: 1.775347688s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.298095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:14.522596Z","time spent":"1.775494413s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T17:15:16.298205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252845916s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-21T17:15:16.298275Z","caller":"traceutil/trace.go:171","msg":"trace[2072704603] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1258; }","duration":"1.252953619s","start":"2026-04-21T17:15:15.045305Z","end":"2026-04-21T17:15:16.298258Z","steps":["trace[2072704603] 'agreement among raft nodes before linearized reading' (duration: 1.252729213s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.298315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:15.045289Z","time spent":"1.253017551s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:15:16.298378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.426957772s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:15:16.298404Z","caller":"traceutil/trace.go:171","msg":"trace[1756785669] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1258; }","duration":"1.427007633s","start":"2026-04-21T17:15:14.871388Z","end":"2026-04-21T17:15:16.298396Z","steps":["trace[1756785669] 'agreement among raft nodes before linearized reading' (duration: 1.426967082s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.298418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:14.871374Z","time spent":"1.427040354s","remote":"127.0.0.1:41060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:15:16.298416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.499773105s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:15:16.298444Z","caller":"traceutil/trace.go:171","msg":"trace[261669953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1258; }","duration":"1.499829256s","start":"2026-04-21T17:15:14.798607Z","end":"2026-04-21T17:15:16.298436Z","steps":["trace[261669953] 'agreement among raft nodes before linearized reading' (duration: 1.499744594s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.298465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:14.798588Z","time spent":"1.499872357s","remote":"127.0.0.1:57712","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-04-21T17:15:16.298519Z","caller":"traceutil/trace.go:171","msg":"trace[1438713942] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"1.661024644s","start":"2026-04-21T17:15:14.637481Z","end":"2026-04-21T17:15:16.298505Z","steps":["trace[1438713942] 'process raft request' (duration: 1.460870564s)","trace[1438713942] 'compare' (duration: 199.338097ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:15:16.298586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.21482404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-21T17:15:16.298604Z","caller":"traceutil/trace.go:171","msg":"trace[94932051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1258; }","duration":"1.214861s","start":"2026-04-21T17:15:15.083738Z","end":"2026-04-21T17:15:16.298599Z","steps":["trace[94932051] 'agreement among raft nodes before linearized reading' (duration: 1.214815579s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.298565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.524668537s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-21T17:15:16.298675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.107806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:15:16.298689Z","caller":"traceutil/trace.go:171","msg":"trace[254652521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1258; }","duration":"740.154207ms","start":"2026-04-21T17:15:15.558531Z","end":"2026-04-21T17:15:16.298685Z","steps":["trace[254652521] 'agreement among raft nodes before linearized reading' (duration: 740.132757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.298701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:15.558513Z","time spent":"740.185777ms","remote":"127.0.0.1:57462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T17:15:16.298689Z","caller":"traceutil/trace.go:171","msg":"trace[1236445418] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1258; }","duration":"1.524836591s","start":"2026-04-21T17:15:14.773832Z","end":"2026-04-21T17:15:16.298668Z","steps":["trace[1236445418] 'agreement among raft nodes before linearized reading' (duration: 1.524550022s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.298771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:14.773815Z","time spent":"1.524946253s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:15:16.298654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:15.083723Z","time spent":"1.214928512s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:15:16.298596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:14.637459Z","time spent":"1.661091434s","remote":"127.0.0.1:57530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":784,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:15:16.298221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.268670865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:15:16.298941Z","caller":"traceutil/trace.go:171","msg":"trace[498074521] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1258; }","duration":"1.269414578s","start":"2026-04-21T17:15:15.029522Z","end":"2026-04-21T17:15:16.298936Z","steps":["trace[498074521] 'agreement among raft nodes before linearized reading' (duration: 1.268678687s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.298959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:15.029507Z","time spent":"1.269446548s","remote":"127.0.0.1:36654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:15:16.691618Z","caller":"traceutil/trace.go:171","msg":"trace[2113131280] linearizableReadLoop","detail":"{readStateIndex:1313; appliedIndex:1307; }","duration":"384.073988ms","start":"2026-04-21T17:15:16.307522Z","end":"2026-04-21T17:15:16.691596Z","steps":["trace[2113131280] 'read index received' (duration: 73.78802ms)","trace[2113131280] 'applied index is now lower than readState.Index' (duration: 310.285168ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:15:16.691664Z","caller":"traceutil/trace.go:171","msg":"trace[891439796] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"386.231518ms","start":"2026-04-21T17:15:16.305393Z","end":"2026-04-21T17:15:16.691624Z","steps":["trace[891439796] 'process raft request' (duration: 386.050732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.691742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.200671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:15:16.691773Z","caller":"traceutil/trace.go:171","msg":"trace[1978427780] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1264; }","duration":"384.263862ms","start":"2026-04-21T17:15:16.3075Z","end":"2026-04-21T17:15:16.691764Z","steps":["trace[1978427780] 'agreement among raft nodes before linearized reading' (duration: 384.1824ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:15:16.691798Z","caller":"traceutil/trace.go:171","msg":"trace[1220195495] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"386.541925ms","start":"2026-04-21T17:15:16.305236Z","end":"2026-04-21T17:15:16.691778Z","steps":["trace[1220195495] 'process raft request' (duration: 385.914178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.691817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:16.307493Z","time spent":"384.308363ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:15:16.691887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:16.30536Z","time spent":"386.403982ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:15:16.691914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:16.305216Z","time spent":"386.628568ms","remote":"127.0.0.1:57530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":784,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:15:16.692103Z","caller":"traceutil/trace.go:171","msg":"trace[2004969310] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"386.671499ms","start":"2026-04-21T17:15:16.305417Z","end":"2026-04-21T17:15:16.692089Z","steps":["trace[2004969310] 'process raft request' (duration: 386.089453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.692175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:16.305411Z","time spent":"386.724301ms","remote":"127.0.0.1:57712","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-04-21T17:15:16.692262Z","caller":"traceutil/trace.go:171","msg":"trace[2121263362] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"386.800063ms","start":"2026-04-21T17:15:16.305453Z","end":"2026-04-21T17:15:16.692253Z","steps":["trace[2121263362] 'process raft request' (duration: 386.085813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.692312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:16.305449Z","time spent":"386.838724ms","remote":"127.0.0.1:57712","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-04-21T17:15:16.692341Z","caller":"traceutil/trace.go:171","msg":"trace[1217001489] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"385.779005ms","start":"2026-04-21T17:15:16.306551Z","end":"2026-04-21T17:15:16.69233Z","steps":["trace[1217001489] 'process raft request' (duration: 385.015104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:16.692411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:16.306545Z","time spent":"385.833427ms","remote":"127.0.0.1:57712","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-04-21T17:15:28.632169Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363759657136531509,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:15:29.132294Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363759657136531509,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:15:29.253183Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.376954173s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:15:29.253549Z","caller":"traceutil/trace.go:171","msg":"trace[954329817] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"1.377435716s","start":"2026-04-21T17:15:27.876093Z","end":"2026-04-21T17:15:29.253529Z","steps":["trace[954329817] 'process raft request' (duration: 1.377303493s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.253686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:27.87607Z","time spent":"1.37754792s","remote":"127.0.0.1:57712","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-04-21T17:15:29.879997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.399299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:15:29.88037Z","caller":"traceutil/trace.go:171","msg":"trace[1529166376] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"1.942164221s","start":"2026-04-21T17:15:27.938168Z","end":"2026-04-21T17:15:29.880332Z","steps":["trace[1529166376] 'process raft request' (duration: 1.383348111s)","trace[1529166376] 'compare' (duration: 558.08023ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:15:29.880739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:27.938152Z","time spent":"1.942340797s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:15:29.967579Z","caller":"traceutil/trace.go:171","msg":"trace[61334227] linearizableReadLoop","detail":"{readStateIndex:1412; appliedIndex:1409; }","duration":"1.836058293s","start":"2026-04-21T17:15:28.131496Z","end":"2026-04-21T17:15:29.967554Z","steps":["trace[61334227] 'read index received' (duration: 1.121929209s)","trace[61334227] 'applied index is now lower than readState.Index' (duration: 714.127764ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:15:29.967945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.836426784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:15:29.967977Z","caller":"traceutil/trace.go:171","msg":"trace[536348129] 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:1360; }","duration":"1.836477775s","start":"2026-04-21T17:15:28.13149Z","end":"2026-04-21T17:15:29.967968Z","steps":["trace[536348129] 'agreement among raft nodes before linearized reading' (duration: 1.836397723s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.968001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.131436Z","time spent":"1.836558488s","remote":"127.0.0.1:41032","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-04-21T17:15:29.968555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221120536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-21T17:15:29.968585Z","caller":"traceutil/trace.go:171","msg":"trace[1020512023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1360; }","duration":"1.221150916s","start":"2026-04-21T17:15:28.747426Z","end":"2026-04-21T17:15:29.968577Z","steps":["trace[1020512023] 'agreement among raft nodes before linearized reading' (duration: 1.221044673s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.968603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.747309Z","time spent":"1.22128899s","remote":"127.0.0.1:57712","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-04-21T17:15:29.968721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.158187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:15:29.968743Z","caller":"traceutil/trace.go:171","msg":"trace[187931095] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1360; }","duration":"794.181217ms","start":"2026-04-21T17:15:29.174556Z","end":"2026-04-21T17:15:29.968738Z","steps":["trace[187931095] 'agreement among raft nodes before linearized reading' (duration: 794.143847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.968762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:29.174498Z","time spent":"794.259471ms","remote":"127.0.0.1:57740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":27,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:15:29.968731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.208211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-21T17:15:29.968887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221254439s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-21T17:15:29.968924Z","caller":"traceutil/trace.go:171","msg":"trace[1183131675] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1360; }","duration":"1.221316751s","start":"2026-04-21T17:15:28.747603Z","end":"2026-04-21T17:15:29.968919Z","steps":["trace[1183131675] 'agreement among raft nodes before linearized reading' (duration: 1.221245058s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.968941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.747591Z","time spent":"1.221346452s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:15:29.969057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221443654s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-21T17:15:29.969079Z","caller":"traceutil/trace.go:171","msg":"trace[108304476] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1360; }","duration":"1.221492835s","start":"2026-04-21T17:15:28.74758Z","end":"2026-04-21T17:15:29.969073Z","steps":["trace[108304476] 'agreement among raft nodes before linearized reading' (duration: 1.221429194s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:15:29.969019Z","caller":"traceutil/trace.go:171","msg":"trace[725214991] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1360; }","duration":"734.595643ms","start":"2026-04-21T17:15:29.234384Z","end":"2026-04-21T17:15:29.96898Z","steps":["trace[725214991] 'agreement among raft nodes before linearized reading' (duration: 734.150189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.969099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.74757Z","time spent":"1.221524107s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:15:29.968542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.546353378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-21T17:15:29.969187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:29.234367Z","time spent":"734.792158ms","remote":"127.0.0.1:57698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:15:29.969265Z","caller":"traceutil/trace.go:171","msg":"trace[1589074674] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1360; }","duration":"1.547107179s","start":"2026-04-21T17:15:28.422114Z","end":"2026-04-21T17:15:29.969221Z","steps":["trace[1589074674] 'agreement among raft nodes before linearized reading' (duration: 1.546316848s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.969226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.436933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-21T17:15:29.969398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.414429813s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:15:29.969421Z","caller":"traceutil/trace.go:171","msg":"trace[274775185] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1360; }","duration":"1.414487727s","start":"2026-04-21T17:15:28.554927Z","end":"2026-04-21T17:15:29.969415Z","steps":["trace[274775185] 'agreement among raft nodes before linearized reading' (duration: 1.414447425s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.969392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.422096Z","time spent":"1.547255004s","remote":"127.0.0.1:57886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:15:29.969445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.554904Z","time spent":"1.414536507s","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T17:15:29.96943Z","caller":"traceutil/trace.go:171","msg":"trace[1893053603] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1360; }","duration":"116.810855ms","start":"2026-04-21T17:15:29.852594Z","end":"2026-04-21T17:15:29.969405Z","steps":["trace[1893053603] 'agreement among raft nodes before linearized reading' (duration: 116.361061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.969572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.222401962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-21T17:15:29.969595Z","caller":"traceutil/trace.go:171","msg":"trace[2043393400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1360; }","duration":"1.222425382s","start":"2026-04-21T17:15:28.747163Z","end":"2026-04-21T17:15:29.969589Z","steps":["trace[2043393400] 'agreement among raft nodes before linearized reading' (duration: 1.222368981s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.96961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.747117Z","time spent":"1.222489473s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:15:29.9697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.279870267s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:15:29.969721Z","caller":"traceutil/trace.go:171","msg":"trace[1007068624] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1360; }","duration":"1.279924097s","start":"2026-04-21T17:15:28.689792Z","end":"2026-04-21T17:15:29.969716Z","steps":["trace[1007068624] 'agreement among raft nodes before linearized reading' (duration: 1.279890227s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.969737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.689764Z","time spent":"1.279969101s","remote":"127.0.0.1:57768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:15:29.969972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.441038064s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-21T17:15:29.970043Z","caller":"traceutil/trace.go:171","msg":"trace[1486715186] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1360; }","duration":"1.441143415s","start":"2026-04-21T17:15:28.528884Z","end":"2026-04-21T17:15:29.970027Z","steps":["trace[1486715186] 'agreement among raft nodes before linearized reading' (duration: 1.440907859s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.970095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.528867Z","time spent":"1.441215629s","remote":"127.0.0.1:57712","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-04-21T17:15:29.970335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.53527334s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-21T17:15:29.970367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.482256417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-21T17:15:29.970389Z","caller":"traceutil/trace.go:171","msg":"trace[1804650624] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1360; }","duration":"1.48230651s","start":"2026-04-21T17:15:28.488077Z","end":"2026-04-21T17:15:29.970383Z","steps":["trace[1804650624] 'agreement among raft nodes before linearized reading' (duration: 1.482245498s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:15:29.970384Z","caller":"traceutil/trace.go:171","msg":"trace[1150072239] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1360; }","duration":"1.535366563s","start":"2026-04-21T17:15:28.435004Z","end":"2026-04-21T17:15:29.970371Z","steps":["trace[1150072239] 'agreement among raft nodes before linearized reading' (duration: 1.535113526s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:15:29.970411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.48806Z","time spent":"1.48234423s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-21T17:15:29.970422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:15:28.434978Z","time spent":"1.535434975s","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T17:15:29.971706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.435977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-21T17:15:29.972271Z","caller":"traceutil/trace.go:171","msg":"trace[47461044] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1360; }","duration":"182.93236ms","start":"2026-04-21T17:15:29.789227Z","end":"2026-04-21T17:15:29.97216Z","steps":["trace[47461044] 'agreement among raft nodes before linearized reading' (duration: 180.454312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:22.055471Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6363759657136532094,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T17:16:22.070924Z","caller":"traceutil/trace.go:171","msg":"trace[284911958] linearizableReadLoop","detail":"{readStateIndex:1663; appliedIndex:1662; }","duration":"516.014022ms","start":"2026-04-21T17:16:21.554891Z","end":"2026-04-21T17:16:22.070905Z","steps":["trace[284911958] 'read index received' (duration: 515.852517ms)","trace[284911958] 'applied index is now lower than readState.Index' (duration: 160.725µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:16:22.071029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.131496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:16:22.071058Z","caller":"traceutil/trace.go:171","msg":"trace[492710563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1601; }","duration":"516.174916ms","start":"2026-04-21T17:16:21.554874Z","end":"2026-04-21T17:16:22.071049Z","steps":["trace[492710563] 'agreement among raft nodes before linearized reading' (duration: 516.113974ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:16:22.071087Z","caller":"traceutil/trace.go:171","msg":"trace[865237156] transaction","detail":"{read_only:false; response_revision:1601; number_of_response:1; }","duration":"567.579683ms","start":"2026-04-21T17:16:21.503458Z","end":"2026-04-21T17:16:22.071038Z","steps":["trace[865237156] 'process raft request' (duration: 567.327797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:22.071113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:21.554816Z","time spent":"516.288779ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:16:22.071144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.775733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:16:22.071212Z","caller":"traceutil/trace.go:171","msg":"trace[450422647] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1601; }","duration":"280.879335ms","start":"2026-04-21T17:16:21.790315Z","end":"2026-04-21T17:16:22.071194Z","steps":["trace[450422647] 'agreement among raft nodes before linearized reading' (duration: 280.758292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:16:22.071233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:16:21.503439Z","time spent":"567.718316ms","remote":"127.0.0.1:57712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:17:26.543636Z","caller":"traceutil/trace.go:171","msg":"trace[289953065] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"219.663756ms","start":"2026-04-21T17:17:26.323861Z","end":"2026-04-21T17:17:26.543525Z","steps":["trace[289953065] 'process raft request' (duration: 219.445849ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:38.724108Z","caller":"traceutil/trace.go:171","msg":"trace[628831859] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"131.952991ms","start":"2026-04-21T17:17:38.592127Z","end":"2026-04-21T17:17:38.72408Z","steps":["trace[628831859] 'process raft request' (duration: 79.345783ms)","trace[628831859] 'compare' (duration: 52.455404ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:17:39.002535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.684779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:17:39.002673Z","caller":"traceutil/trace.go:171","msg":"trace[452886584] linearizableReadLoop","detail":"{readStateIndex:2032; appliedIndex:2030; }","duration":"197.994474ms","start":"2026-04-21T17:17:38.804658Z","end":"2026-04-21T17:17:39.002652Z","steps":["trace[452886584] 'read index received' (duration: 14.276079ms)","trace[452886584] 'applied index is now lower than readState.Index' (duration: 183.716415ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:17:39.002824Z","caller":"traceutil/trace.go:171","msg":"trace[1516442689] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"237.664661ms","start":"2026-04-21T17:17:38.765145Z","end":"2026-04-21T17:17:39.00281Z","steps":["trace[1516442689] 'process raft request' (duration: 94.586652ms)","trace[1516442689] 'compare' (duration: 142.39039ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:17:39.003015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.500971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-21T17:17:39.003071Z","caller":"traceutil/trace.go:171","msg":"trace[766672558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1954; }","duration":"122.614093ms","start":"2026-04-21T17:17:38.880447Z","end":"2026-04-21T17:17:39.003061Z","steps":["trace[766672558] 'agreement among raft nodes before linearized reading' (duration: 122.438129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:17:39.003058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.2516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-21T17:17:39.003172Z","caller":"traceutil/trace.go:171","msg":"trace[267973399] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1954; }","duration":"102.422035ms","start":"2026-04-21T17:17:38.900731Z","end":"2026-04-21T17:17:39.003153Z","steps":["trace[267973399] 'agreement among raft nodes before linearized reading' (duration: 102.174268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:17:39.003155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.910091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-21T17:17:39.003253Z","caller":"traceutil/trace.go:171","msg":"trace[15160922] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1954; }","duration":"110.100585ms","start":"2026-04-21T17:17:38.893128Z","end":"2026-04-21T17:17:39.003228Z","steps":["trace[15160922] 'agreement among raft nodes before linearized reading' (duration: 109.781426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:17:39.003207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.436767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-21T17:17:39.003339Z","caller":"traceutil/trace.go:171","msg":"trace[153330226] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1954; }","duration":"198.718085ms","start":"2026-04-21T17:17:38.804589Z","end":"2026-04-21T17:17:39.003307Z","steps":["trace[153330226] 'agreement among raft nodes before linearized reading' (duration: 198.234241ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:39.289737Z","caller":"traceutil/trace.go:171","msg":"trace[1330727089] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"280.422546ms","start":"2026-04-21T17:17:39.009286Z","end":"2026-04-21T17:17:39.289708Z","steps":["trace[1330727089] 'process raft request' (duration: 280.362245ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:39.290037Z","caller":"traceutil/trace.go:171","msg":"trace[1295299022] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"281.155658ms","start":"2026-04-21T17:17:39.008842Z","end":"2026-04-21T17:17:39.289998Z","steps":["trace[1295299022] 'process raft request' (duration: 279.270293ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:39.290111Z","caller":"traceutil/trace.go:171","msg":"trace[1095167503] transaction","detail":"{read_only:false; response_revision:1957; number_of_response:1; }","duration":"281.2261ms","start":"2026-04-21T17:17:39.008876Z","end":"2026-04-21T17:17:39.290102Z","steps":["trace[1095167503] 'process raft request' (duration: 280.658493ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:44.845636Z","caller":"traceutil/trace.go:171","msg":"trace[2036405146] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"101.004115ms","start":"2026-04-21T17:17:44.744599Z","end":"2026-04-21T17:17:44.845603Z","steps":["trace[2036405146] 'process raft request' (duration: 100.735228ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:45.181335Z","caller":"traceutil/trace.go:171","msg":"trace[1313315484] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"108.345275ms","start":"2026-04-21T17:17:45.072965Z","end":"2026-04-21T17:17:45.18131Z","steps":["trace[1313315484] 'process raft request' (duration: 107.052098ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:45.518279Z","caller":"traceutil/trace.go:171","msg":"trace[1391319925] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"150.773911ms","start":"2026-04-21T17:17:45.36747Z","end":"2026-04-21T17:17:45.518244Z","steps":["trace[1391319925] 'process raft request' (duration: 150.467162ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:45.518486Z","caller":"traceutil/trace.go:171","msg":"trace[1132779609] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"150.273016ms","start":"2026-04-21T17:17:45.368172Z","end":"2026-04-21T17:17:45.518445Z","steps":["trace[1132779609] 'process raft request' (duration: 150.029149ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:59.797576Z","caller":"traceutil/trace.go:171","msg":"trace[431203900] transaction","detail":"{read_only:false; response_revision:2049; number_of_response:1; }","duration":"140.056697ms","start":"2026-04-21T17:17:59.657487Z","end":"2026-04-21T17:17:59.797544Z","steps":["trace[431203900] 'process raft request' (duration: 139.877423ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:59.798293Z","caller":"traceutil/trace.go:171","msg":"trace[675923881] linearizableReadLoop","detail":"{readStateIndex:2131; appliedIndex:2131; }","duration":"134.867472ms","start":"2026-04-21T17:17:59.66341Z","end":"2026-04-21T17:17:59.798278Z","steps":["trace[675923881] 'read index received' (duration: 134.861382ms)","trace[675923881] 'applied index is now lower than readState.Index' (duration: 4.97µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:17:59.798466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.037977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-21T17:17:59.798506Z","caller":"traceutil/trace.go:171","msg":"trace[976827342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2049; }","duration":"135.13353ms","start":"2026-04-21T17:17:59.663363Z","end":"2026-04-21T17:17:59.798496Z","steps":["trace[976827342] 'agreement among raft nodes before linearized reading' (duration: 134.972816ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:18:39.654275Z","caller":"traceutil/trace.go:171","msg":"trace[1664443406] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"100.75415ms","start":"2026-04-21T17:18:39.553479Z","end":"2026-04-21T17:18:39.654233Z","steps":["trace[1664443406] 'process raft request' (duration: 99.339531ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:18:55.657332Z","caller":"traceutil/trace.go:171","msg":"trace[1864130635] linearizableReadLoop","detail":"{readStateIndex:2422; appliedIndex:2421; }","duration":"151.296631ms","start":"2026-04-21T17:18:55.506004Z","end":"2026-04-21T17:18:55.657301Z","steps":["trace[1864130635] 'read index received' (duration: 116.329495ms)","trace[1864130635] 'applied index is now lower than readState.Index' (duration: 34.965826ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:18:55.657437Z","caller":"traceutil/trace.go:171","msg":"trace[1109004353] transaction","detail":"{read_only:false; response_revision:2328; number_of_response:1; }","duration":"178.111638ms","start":"2026-04-21T17:18:55.479275Z","end":"2026-04-21T17:18:55.657386Z","steps":["trace[1109004353] 'process raft request' (duration: 143.01007ms)","trace[1109004353] 'compare' (duration: 34.836501ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:18:55.657698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.669371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-21T17:18:55.657767Z","caller":"traceutil/trace.go:171","msg":"trace[1867456108] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2328; }","duration":"151.834936ms","start":"2026-04-21T17:18:55.505918Z","end":"2026-04-21T17:18:55.657753Z","steps":["trace[1867456108] 'agreement among raft nodes before linearized reading' (duration: 151.508267ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:18:56.325222Z","caller":"traceutil/trace.go:171","msg":"trace[162128522] transaction","detail":"{read_only:false; response_revision:2333; number_of_response:1; }","duration":"136.057445ms","start":"2026-04-21T17:18:56.189136Z","end":"2026-04-21T17:18:56.325193Z","steps":["trace[162128522] 'process raft request' (duration: 135.8592ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:18:56.325726Z","caller":"traceutil/trace.go:171","msg":"trace[1581753305] transaction","detail":"{read_only:false; response_revision:2334; number_of_response:1; }","duration":"136.267131ms","start":"2026-04-21T17:18:56.189445Z","end":"2026-04-21T17:18:56.325712Z","steps":["trace[1581753305] 'process raft request' (duration: 136.200769ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:19:02.617887Z","caller":"traceutil/trace.go:171","msg":"trace[1681687913] linearizableReadLoop","detail":"{readStateIndex:2462; appliedIndex:2461; }","duration":"124.969607ms","start":"2026-04-21T17:19:02.492879Z","end":"2026-04-21T17:19:02.617848Z","steps":["trace[1681687913] 'read index received' (duration: 26.963913ms)","trace[1681687913] 'applied index is now lower than readState.Index' (duration: 98.004274ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:19:02.617986Z","caller":"traceutil/trace.go:171","msg":"trace[114863970] transaction","detail":"{read_only:false; response_revision:2367; number_of_response:1; }","duration":"177.216104ms","start":"2026-04-21T17:19:02.440726Z","end":"2026-04-21T17:19:02.617942Z","steps":["trace[114863970] 'process raft request' (duration: 79.132728ms)","trace[114863970] 'compare' (duration: 97.789278ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:19:02.618204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.298396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.249\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-21T17:19:02.618258Z","caller":"traceutil/trace.go:171","msg":"trace[195506489] range","detail":"{range_begin:/registry/masterleases/199.19.213.249; range_end:; response_count:1; response_revision:2367; }","duration":"125.382508ms","start":"2026-04-21T17:19:02.492862Z","end":"2026-04-21T17:19:02.618244Z","steps":["trace[195506489] 'agreement among raft nodes before linearized reading' (duration: 125.127871ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:19:03.13244Z","caller":"traceutil/trace.go:171","msg":"trace[1542343431] transaction","detail":"{read_only:false; response_revision:2369; number_of_response:1; }","duration":"132.003168ms","start":"2026-04-21T17:19:03.000391Z","end":"2026-04-21T17:19:03.132395Z","steps":["trace[1542343431] 'process raft request' (duration: 131.71407ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:19:03.315121Z","caller":"traceutil/trace.go:171","msg":"trace[1386344376] transaction","detail":"{read_only:false; response_revision:2370; number_of_response:1; }","duration":"163.102644ms","start":"2026-04-21T17:19:03.151979Z","end":"2026-04-21T17:19:03.315082Z","steps":["trace[1386344376] 'process raft request' (duration: 106.149161ms)","trace[1386344376] 'compare' (duration: 56.794218ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:19:41.155097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.538599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-lsjfj\" ","response":"range_response_count:1 size:13724"} {"level":"info","ts":"2026-04-21T17:19:41.155183Z","caller":"traceutil/trace.go:171","msg":"trace[958977370] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-lsjfj; range_end:; response_count:1; response_revision:2551; }","duration":"138.658474ms","start":"2026-04-21T17:19:41.016504Z","end":"2026-04-21T17:19:41.155162Z","steps":["trace[958977370] 'range keys from in-memory index tree' (duration: 138.269432ms)"],"step_count":1}