{"level":"warn","ts":"2026-08-20T20:27:28.032159Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T20:27:28.032283Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.188: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.188:2380","--initial-cluster=instance=https://199.19.213.188:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.188:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.188: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-08-20T20:27:28.032387Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T20:27:28.032408Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.188:2380"]} {"level":"info","ts":"2026-08-20T20:27:28.032432Z","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-08-20T20:27:28.033465Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.188:2379"]} {"level":"info","ts":"2026-08-20T20:27:28.033586Z","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.188:2380"],"listen-peer-urls":["https://199.19.213.188:2380"],"advertise-client-urls":["https://199.19.213.188:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.188:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.188: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-08-20T20:27:28.039941Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.039891ms"} {"level":"info","ts":"2026-08-20T20:27:28.050631Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"201fe5d2d7e0161a","cluster-id":"92c0fc3a33fabd38"} {"level":"info","ts":"2026-08-20T20:27:28.050726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a switched to configuration voters=()"} {"level":"info","ts":"2026-08-20T20:27:28.050827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a became follower at term 0"} {"level":"info","ts":"2026-08-20T20:27:28.050843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 201fe5d2d7e0161a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-20T20:27:28.05085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a became follower at term 1"} {"level":"info","ts":"2026-08-20T20:27:28.050909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a switched to configuration voters=(2314821427219404314)"} {"level":"warn","ts":"2026-08-20T20:27:28.061016Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-20T20:27:28.062361Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-20T20:27:28.063441Z","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-08-20T20:27:28.06557Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"201fe5d2d7e0161a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-20T20:27:28.066038Z","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-08-20T20:27:28.066177Z","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-08-20T20:27:28.066192Z","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-08-20T20:27:28.065716Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"201fe5d2d7e0161a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-20T20:27:28.076438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a switched to configuration voters=(2314821427219404314)"} {"level":"info","ts":"2026-08-20T20:27:28.076505Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"92c0fc3a33fabd38","local-member-id":"201fe5d2d7e0161a","added-peer-id":"201fe5d2d7e0161a","added-peer-peer-urls":["https://199.19.213.188:2380"]} {"level":"info","ts":"2026-08-20T20:27:28.077748Z","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-08-20T20:27:28.07795Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.188:2380"} {"level":"info","ts":"2026-08-20T20:27:28.077989Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"201fe5d2d7e0161a","initial-advertise-peer-urls":["https://199.19.213.188:2380"],"listen-peer-urls":["https://199.19.213.188:2380"],"advertise-client-urls":["https://199.19.213.188:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.188:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-20T20:27:28.078044Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-20T20:27:28.078026Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.188:2380"} {"level":"info","ts":"2026-08-20T20:27:28.251854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a is starting a new election at term 1"} {"level":"info","ts":"2026-08-20T20:27:28.251925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a became pre-candidate at term 1"} {"level":"info","ts":"2026-08-20T20:27:28.251943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a received MsgPreVoteResp from 201fe5d2d7e0161a at term 1"} {"level":"info","ts":"2026-08-20T20:27:28.251957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a became candidate at term 2"} {"level":"info","ts":"2026-08-20T20:27:28.251964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a received MsgVoteResp from 201fe5d2d7e0161a at term 2"} {"level":"info","ts":"2026-08-20T20:27:28.251974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"201fe5d2d7e0161a became leader at term 2"} {"level":"info","ts":"2026-08-20T20:27:28.251985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 201fe5d2d7e0161a elected leader 201fe5d2d7e0161a at term 2"} {"level":"info","ts":"2026-08-20T20:27:28.253219Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"201fe5d2d7e0161a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.188:2379]}","request-path":"/0/members/201fe5d2d7e0161a/attributes","cluster-id":"92c0fc3a33fabd38","publish-timeout":"7s"} {"level":"info","ts":"2026-08-20T20:27:28.253265Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T20:27:28.253384Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T20:27:28.253519Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T20:27:28.254838Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"92c0fc3a33fabd38","local-member-id":"201fe5d2d7e0161a","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T20:27:28.254982Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T20:27:28.255022Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T20:27:28.255904Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.188:2379"} {"level":"info","ts":"2026-08-20T20:27:28.256025Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-20T20:27:28.256067Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-20T20:27:28.257111Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-20T20:27:33.099593Z","caller":"traceutil/trace.go:171","msg":"trace[976573535] linearizableReadLoop","detail":"{readStateIndex:228; appliedIndex:227; }","duration":"147.225143ms","start":"2026-08-20T20:27:32.952344Z","end":"2026-08-20T20:27:33.099569Z","steps":["trace[976573535] 'read index received' (duration: 144.171198ms)","trace[976573535] 'applied index is now lower than readState.Index' (duration: 3.053165ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:27:33.099673Z","caller":"traceutil/trace.go:171","msg":"trace[159491068] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"147.513349ms","start":"2026-08-20T20:27:32.952121Z","end":"2026-08-20T20:27:33.099634Z","steps":["trace[159491068] 'process raft request' (duration: 144.468704ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:33.099753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.380277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:27:33.10013Z","caller":"traceutil/trace.go:171","msg":"trace[1386225301] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:222; }","duration":"147.818965ms","start":"2026-08-20T20:27:32.952296Z","end":"2026-08-20T20:27:33.100115Z","steps":["trace[1386225301] 'agreement among raft nodes before linearized reading' (duration: 147.390276ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:33.645527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.474369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:27:33.645666Z","caller":"traceutil/trace.go:171","msg":"trace[1406289088] linearizableReadLoop","detail":"{readStateIndex:239; appliedIndex:238; }","duration":"319.128952ms","start":"2026-08-20T20:27:33.32652Z","end":"2026-08-20T20:27:33.645648Z","steps":["trace[1406289088] 'read index received' (duration: 38.00727ms)","trace[1406289088] 'applied index is now lower than readState.Index' (duration: 281.120512ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:33.645751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.229304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:27:33.645788Z","caller":"traceutil/trace.go:171","msg":"trace[405664826] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:0; response_revision:233; }","duration":"319.298416ms","start":"2026-08-20T20:27:33.326481Z","end":"2026-08-20T20:27:33.645779Z","steps":["trace[405664826] 'agreement among raft nodes before linearized reading' (duration: 319.218004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:33.645827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:33.326462Z","time spent":"319.356157ms","remote":"127.0.0.1:57172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" "} {"level":"info","ts":"2026-08-20T20:27:33.646015Z","caller":"traceutil/trace.go:171","msg":"trace[1182768398] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"352.418781ms","start":"2026-08-20T20:27:33.293526Z","end":"2026-08-20T20:27:33.645945Z","steps":["trace[1182768398] 'process raft request' (duration: 71.016153ms)","trace[1182768398] 'compare' (duration: 280.335166ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:33.646356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:33.293506Z","time spent":"352.664667ms","remote":"127.0.0.1:57066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1944,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:27:36.877265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.369518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-20T20:27:36.877359Z","caller":"traceutil/trace.go:171","msg":"trace[2090732427] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:291; }","duration":"124.51791ms","start":"2026-08-20T20:27:36.752819Z","end":"2026-08-20T20:27:36.877337Z","steps":["trace[2090732427] 'range keys from in-memory index tree' (duration: 124.267895ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:38.193772Z","caller":"traceutil/trace.go:171","msg":"trace[1042626780] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:335; }","duration":"173.3859ms","start":"2026-08-20T20:27:38.020361Z","end":"2026-08-20T20:27:38.193747Z","steps":["trace[1042626780] 'read index received' (duration: 136.785406ms)","trace[1042626780] 'applied index is now lower than readState.Index' (duration: 36.599674ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:27:38.194129Z","caller":"traceutil/trace.go:171","msg":"trace[250277066] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"183.798896ms","start":"2026-08-20T20:27:38.010316Z","end":"2026-08-20T20:27:38.194115Z","steps":["trace[250277066] 'process raft request' (duration: 146.889156ms)","trace[250277066] 'compare' (duration: 36.4205ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:38.194352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.972533ms","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-08-20T20:27:38.194392Z","caller":"traceutil/trace.go:171","msg":"trace[932071451] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:324; }","duration":"174.047924ms","start":"2026-08-20T20:27:38.020334Z","end":"2026-08-20T20:27:38.194382Z","steps":["trace[932071451] 'agreement among raft nodes before linearized reading' (duration: 173.948692ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:38.194563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.511184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-08-20T20:27:38.194598Z","caller":"traceutil/trace.go:171","msg":"trace[553397587] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:324; }","duration":"141.569996ms","start":"2026-08-20T20:27:38.053019Z","end":"2026-08-20T20:27:38.194589Z","steps":["trace[553397587] 'agreement among raft nodes before linearized reading' (duration: 141.514865ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:38.486759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.911683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:27:38.487142Z","caller":"traceutil/trace.go:171","msg":"trace[1745257180] linearizableReadLoop","detail":"{readStateIndex:345; appliedIndex:341; }","duration":"191.181391ms","start":"2026-08-20T20:27:38.295942Z","end":"2026-08-20T20:27:38.487124Z","steps":["trace[1745257180] 'read index received' (duration: 71.871909ms)","trace[1745257180] 'applied index is now lower than readState.Index' (duration: 119.308512ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:27:38.487245Z","caller":"traceutil/trace.go:171","msg":"trace[281505745] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"235.998957ms","start":"2026-08-20T20:27:38.251235Z","end":"2026-08-20T20:27:38.487234Z","steps":["trace[281505745] 'process raft request' (duration: 235.65052ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:38.487211Z","caller":"traceutil/trace.go:171","msg":"trace[795082221] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"231.344691ms","start":"2026-08-20T20:27:38.255825Z","end":"2026-08-20T20:27:38.48717Z","steps":["trace[795082221] 'process raft request' (duration: 231.171137ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:38.487418Z","caller":"traceutil/trace.go:171","msg":"trace[1502887931] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"231.205156ms","start":"2026-08-20T20:27:38.256195Z","end":"2026-08-20T20:27:38.4874Z","steps":["trace[1502887931] 'process raft request' (duration: 230.88729ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:38.487467Z","caller":"traceutil/trace.go:171","msg":"trace[1923344924] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"237.393356ms","start":"2026-08-20T20:27:38.25006Z","end":"2026-08-20T20:27:38.487454Z","steps":["trace[1923344924] 'process raft request' (duration: 117.736818ms)","trace[1923344924] 'compare' (duration: 118.7406ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:38.48723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.277392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:1 size:2108"} {"level":"info","ts":"2026-08-20T20:27:38.487898Z","caller":"traceutil/trace.go:171","msg":"trace[680737637] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:1; response_revision:333; }","duration":"191.981997ms","start":"2026-08-20T20:27:38.295898Z","end":"2026-08-20T20:27:38.48788Z","steps":["trace[680737637] 'agreement among raft nodes before linearized reading' (duration: 191.288823ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:38.505043Z","caller":"traceutil/trace.go:171","msg":"trace[619401391] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"207.862529ms","start":"2026-08-20T20:27:38.297163Z","end":"2026-08-20T20:27:38.505025Z","steps":["trace[619401391] 'process raft request' (duration: 207.652354ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:38.505248Z","caller":"traceutil/trace.go:171","msg":"trace[1455443843] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"205.999391ms","start":"2026-08-20T20:27:38.299222Z","end":"2026-08-20T20:27:38.505221Z","steps":["trace[1455443843] 'process raft request' (duration: 205.770985ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:38.933103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.959123ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:27:38.9332Z","caller":"traceutil/trace.go:171","msg":"trace[450660783] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"294.10905ms","start":"2026-08-20T20:27:38.639075Z","end":"2026-08-20T20:27:38.933184Z","steps":["trace[450660783] 'read index received' (duration: 105.921272ms)","trace[450660783] 'applied index is now lower than readState.Index' (duration: 188.186628ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:38.933284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.219622ms","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-08-20T20:27:38.933316Z","caller":"traceutil/trace.go:171","msg":"trace[1034069726] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"364.650072ms","start":"2026-08-20T20:27:38.568627Z","end":"2026-08-20T20:27:38.933277Z","steps":["trace[1034069726] 'process raft request' (duration: 176.318911ms)","trace[1034069726] 'compare' (duration: 187.687158ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:38.933476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:38.568601Z","time spent":"364.783615ms","remote":"127.0.0.1:57454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:27:38.933309Z","caller":"traceutil/trace.go:171","msg":"trace[1766276871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:341; }","duration":"294.279254ms","start":"2026-08-20T20:27:38.639022Z","end":"2026-08-20T20:27:38.933301Z","steps":["trace[1766276871] 'agreement among raft nodes before linearized reading' (duration: 294.232123ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:39.989241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.529926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-08-20T20:27:39.989311Z","caller":"traceutil/trace.go:171","msg":"trace[1495736340] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:347; }","duration":"120.647458ms","start":"2026-08-20T20:27:39.868648Z","end":"2026-08-20T20:27:39.989296Z","steps":["trace[1495736340] 'range keys from in-memory index tree' (duration: 120.441344ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:45.482713Z","caller":"traceutil/trace.go:171","msg":"trace[2007661417] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"115.370364ms","start":"2026-08-20T20:27:45.367314Z","end":"2026-08-20T20:27:45.482685Z","steps":["trace[2007661417] 'process raft request' (duration: 115.17606ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:46.442872Z","caller":"traceutil/trace.go:171","msg":"trace[620689570] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"206.977749ms","start":"2026-08-20T20:27:46.23587Z","end":"2026-08-20T20:27:46.442847Z","steps":["trace[620689570] 'process raft request' (duration: 206.818896ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:47.549689Z","caller":"traceutil/trace.go:171","msg":"trace[1983899501] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"239.874538ms","start":"2026-08-20T20:27:47.309779Z","end":"2026-08-20T20:27:47.549653Z","steps":["trace[1983899501] 'process raft request' (duration: 236.589202ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:51.62307Z","caller":"traceutil/trace.go:171","msg":"trace[1223269870] linearizableReadLoop","detail":"{readStateIndex:401; appliedIndex:400; }","duration":"456.944066ms","start":"2026-08-20T20:27:51.166102Z","end":"2026-08-20T20:27:51.623046Z","steps":["trace[1223269870] 'read index received' (duration: 456.677971ms)","trace[1223269870] 'applied index is now lower than readState.Index' (duration: 264.955µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:27:51.623433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.311753ms","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-08-20T20:27:51.623478Z","caller":"traceutil/trace.go:171","msg":"trace[191769869] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"468.035787ms","start":"2026-08-20T20:27:51.155417Z","end":"2026-08-20T20:27:51.623452Z","steps":["trace[191769869] 'process raft request' (duration: 467.500136ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:27:51.62353Z","caller":"traceutil/trace.go:171","msg":"trace[306200785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:386; }","duration":"457.428506ms","start":"2026-08-20T20:27:51.166067Z","end":"2026-08-20T20:27:51.623495Z","steps":["trace[306200785] 'agreement among raft nodes before linearized reading' (duration: 457.260622ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:51.623508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.900468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.188\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-20T20:27:51.623582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:51.166053Z","time spent":"457.520117ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-20T20:27:51.623593Z","caller":"traceutil/trace.go:171","msg":"trace[657762846] range","detail":"{range_begin:/registry/masterleases/199.19.213.188; range_end:; response_count:1; response_revision:386; }","duration":"174.01945ms","start":"2026-08-20T20:27:51.449556Z","end":"2026-08-20T20:27:51.623575Z","steps":["trace[657762846] 'agreement among raft nodes before linearized reading' (duration: 173.759995ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:27:51.623629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:27:51.155395Z","time spent":"468.133018ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:28:01.708895Z","caller":"traceutil/trace.go:171","msg":"trace[768946887] linearizableReadLoop","detail":"{readStateIndex:457; appliedIndex:456; }","duration":"126.129859ms","start":"2026-08-20T20:28:01.582738Z","end":"2026-08-20T20:28:01.708868Z","steps":["trace[768946887] 'read index received' (duration: 125.885324ms)","trace[768946887] 'applied index is now lower than readState.Index' (duration: 242.835µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:01.708968Z","caller":"traceutil/trace.go:171","msg":"trace[119790724] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"241.372157ms","start":"2026-08-20T20:28:01.467544Z","end":"2026-08-20T20:28:01.708916Z","steps":["trace[119790724] 'process raft request' (duration: 241.156552ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:01.709432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.642578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:01.709565Z","caller":"traceutil/trace.go:171","msg":"trace[797224899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:439; }","duration":"126.869083ms","start":"2026-08-20T20:28:01.582676Z","end":"2026-08-20T20:28:01.709545Z","steps":["trace[797224899] 'agreement among raft nodes before linearized reading' (duration: 126.325593ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:03.115728Z","caller":"traceutil/trace.go:171","msg":"trace[917596505] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"569.83739ms","start":"2026-08-20T20:28:02.545865Z","end":"2026-08-20T20:28:03.115702Z","steps":["trace[917596505] 'process raft request' (duration: 569.659907ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:03.11588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:02.545843Z","time spent":"569.963072ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:03.909267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.676234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:03.90934Z","caller":"traceutil/trace.go:171","msg":"trace[155228374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:443; }","duration":"322.801556ms","start":"2026-08-20T20:28:03.586525Z","end":"2026-08-20T20:28:03.909327Z","steps":["trace[155228374] 'range keys from in-memory index tree' (duration: 322.592632ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:03.909368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:03.586498Z","time spent":"322.863327ms","remote":"127.0.0.1:56970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T20:28:03.909355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.675181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-20T20:28:03.909352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.673368ms","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-08-20T20:28:03.909419Z","caller":"traceutil/trace.go:171","msg":"trace[1674167262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:443; }","duration":"163.744842ms","start":"2026-08-20T20:28:03.745652Z","end":"2026-08-20T20:28:03.909397Z","steps":["trace[1674167262] 'range keys from in-memory index tree' (duration: 163.614ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:03.90946Z","caller":"traceutil/trace.go:171","msg":"trace[2045896772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:443; }","duration":"190.869972ms","start":"2026-08-20T20:28:03.718566Z","end":"2026-08-20T20:28:03.909436Z","steps":["trace[2045896772] 'range keys from in-memory index tree' (duration: 190.542126ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:03.909639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.026838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T20:28:03.909687Z","caller":"traceutil/trace.go:171","msg":"trace[678678406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:443; }","duration":"164.10019ms","start":"2026-08-20T20:28:03.745576Z","end":"2026-08-20T20:28:03.909676Z","steps":["trace[678678406] 'range keys from in-memory index tree' (duration: 163.899775ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:04.175849Z","caller":"traceutil/trace.go:171","msg":"trace[592108933] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"262.589175ms","start":"2026-08-20T20:28:03.913236Z","end":"2026-08-20T20:28:04.175825Z","steps":["trace[592108933] 'process raft request' (duration: 262.451152ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:05.619827Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083088,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:06.06438Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.88820717s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T20:28:06.064887Z","caller":"traceutil/trace.go:171","msg":"trace[1461361063] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"2.150945337s","start":"2026-08-20T20:28:03.913911Z","end":"2026-08-20T20:28:06.064857Z","steps":["trace[1461361063] 'process raft request' (duration: 2.150661092s)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:06.06504Z","caller":"traceutil/trace.go:171","msg":"trace[214195542] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"2.150962098s","start":"2026-08-20T20:28:03.914051Z","end":"2026-08-20T20:28:06.065013Z","steps":["trace[214195542] 'process raft request' (duration: 2.150754403s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:06.065151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:03.914043Z","time spent":"2.151040239s","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:06.065126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:03.913889Z","time spent":"2.151130401s","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:06.747648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.874109ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:28:06.747741Z","caller":"traceutil/trace.go:171","msg":"trace[804685599] linearizableReadLoop","detail":"{readStateIndex:465; appliedIndex:462; }","duration":"1.627999087s","start":"2026-08-20T20:28:05.119729Z","end":"2026-08-20T20:28:06.747729Z","steps":["trace[804685599] 'read index received' (duration: 944.8484ms)","trace[804685599] 'applied index is now lower than readState.Index' (duration: 683.149867ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:06.747803Z","caller":"traceutil/trace.go:171","msg":"trace[1370956700] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"1.891380194s","start":"2026-08-20T20:28:04.856416Z","end":"2026-08-20T20:28:06.747796Z","steps":["trace[1370956700] 'process raft request' (duration: 1.67023429s)","trace[1370956700] 'compare' (duration: 220.795358ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:06.747843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:04.856393Z","time spent":"1.891426886s","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:06.747939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.628214791s","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-08-20T20:28:06.747956Z","caller":"traceutil/trace.go:171","msg":"trace[1128305804] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:447; }","duration":"1.628270382s","start":"2026-08-20T20:28:05.11968Z","end":"2026-08-20T20:28:06.74795Z","steps":["trace[1128305804] 'agreement among raft nodes before linearized reading' (duration: 1.628232972s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:06.747974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:05.119659Z","time spent":"1.628311333s","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-20T20:28:06.748073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.16501416s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:06.748148Z","caller":"traceutil/trace.go:171","msg":"trace[1682033210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:447; }","duration":"1.165161134s","start":"2026-08-20T20:28:05.58297Z","end":"2026-08-20T20:28:06.748131Z","steps":["trace[1682033210] 'agreement among raft nodes before linearized reading' (duration: 1.16497993s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:06.748218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:05.582947Z","time spent":"1.165262835s","remote":"127.0.0.1:56970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T20:28:06.748206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.166516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T20:28:06.748311Z","caller":"traceutil/trace.go:171","msg":"trace[1978515381] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:447; }","duration":"560.323368ms","start":"2026-08-20T20:28:06.187963Z","end":"2026-08-20T20:28:06.748286Z","steps":["trace[1978515381] 'agreement among raft nodes before linearized reading' (duration: 560.159635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:06.748376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:06.187939Z","time spent":"560.4225ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T20:28:06.748656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.957039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-08-20T20:28:06.748723Z","caller":"traceutil/trace.go:171","msg":"trace[521345488] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:447; }","duration":"156.07845ms","start":"2026-08-20T20:28:06.592627Z","end":"2026-08-20T20:28:06.748705Z","steps":["trace[521345488] 'agreement among raft nodes before linearized reading' (duration: 155.420407ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:06.988117Z","caller":"traceutil/trace.go:171","msg":"trace[974814562] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:465; }","duration":"230.292918ms","start":"2026-08-20T20:28:06.757797Z","end":"2026-08-20T20:28:06.98809Z","steps":["trace[974814562] 'read index received' (duration: 50.08287ms)","trace[974814562] 'applied index is now lower than readState.Index' (duration: 180.208848ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:06.988258Z","caller":"traceutil/trace.go:171","msg":"trace[1868890370] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"235.602408ms","start":"2026-08-20T20:28:06.752643Z","end":"2026-08-20T20:28:06.988246Z","steps":["trace[1868890370] 'process raft request' (duration: 154.268495ms)","trace[1868890370] 'compare' (duration: 80.965066ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:06.988397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.585124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:06.98851Z","caller":"traceutil/trace.go:171","msg":"trace[1071632847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:449; }","duration":"230.717426ms","start":"2026-08-20T20:28:06.757767Z","end":"2026-08-20T20:28:06.988484Z","steps":["trace[1071632847] 'agreement among raft nodes before linearized reading' (duration: 230.566763ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:08.128168Z","caller":"traceutil/trace.go:171","msg":"trace[338120199] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"303.86397ms","start":"2026-08-20T20:28:07.824281Z","end":"2026-08-20T20:28:08.128145Z","steps":["trace[338120199] 'process raft request' (duration: 303.427142ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:08.128298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:07.824268Z","time spent":"303.969872ms","remote":"127.0.0.1:57054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317292,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:08.259932Z","caller":"traceutil/trace.go:171","msg":"trace[548422180] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"126.588647ms","start":"2026-08-20T20:28:08.133243Z","end":"2026-08-20T20:28:08.259832Z","steps":["trace[548422180] 'process raft request' (duration: 64.481906ms)","trace[548422180] 'compare' (duration: 61.853757ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:08.260204Z","caller":"traceutil/trace.go:171","msg":"trace[842300055] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"106.54239ms","start":"2026-08-20T20:28:08.153638Z","end":"2026-08-20T20:28:08.26018Z","steps":["trace[842300055] 'process raft request' (duration: 106.132722ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:08.260453Z","caller":"traceutil/trace.go:171","msg":"trace[466674827] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"106.425058ms","start":"2026-08-20T20:28:08.154015Z","end":"2026-08-20T20:28:08.26044Z","steps":["trace[466674827] 'process raft request' (duration: 106.03406ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:08.26063Z","caller":"traceutil/trace.go:171","msg":"trace[761690370] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"126.371213ms","start":"2026-08-20T20:28:08.134202Z","end":"2026-08-20T20:28:08.260573Z","steps":["trace[761690370] 'process raft request' (duration: 125.529907ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:08.980163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.850291ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:28:08.98064Z","caller":"traceutil/trace.go:171","msg":"trace[1526107342] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:485; }","duration":"168.208673ms","start":"2026-08-20T20:28:08.812419Z","end":"2026-08-20T20:28:08.980628Z","steps":["trace[1526107342] 'read index received' (duration: 167.915717ms)","trace[1526107342] 'applied index is now lower than readState.Index' (duration: 292.056µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:08.980618Z","caller":"traceutil/trace.go:171","msg":"trace[154837337] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"304.813559ms","start":"2026-08-20T20:28:08.675769Z","end":"2026-08-20T20:28:08.980583Z","steps":["trace[154837337] 'process raft request' (duration: 304.612575ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:08.980682Z","caller":"traceutil/trace.go:171","msg":"trace[1491343764] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"303.865451ms","start":"2026-08-20T20:28:08.676784Z","end":"2026-08-20T20:28:08.980649Z","steps":["trace[1491343764] 'process raft request' (duration: 303.763599ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:08.980759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.344875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-20T20:28:08.980758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:08.675755Z","time spent":"304.956592ms","remote":"127.0.0.1:57146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15015,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:08.980791Z","caller":"traceutil/trace.go:171","msg":"trace[870966980] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:470; }","duration":"168.424916ms","start":"2026-08-20T20:28:08.812356Z","end":"2026-08-20T20:28:08.980781Z","steps":["trace[870966980] 'agreement among raft nodes before linearized reading' (duration: 168.335095ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:08.980784Z","caller":"traceutil/trace.go:171","msg":"trace[1611336849] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"304.194837ms","start":"2026-08-20T20:28:08.676567Z","end":"2026-08-20T20:28:08.980762Z","steps":["trace[1611336849] 'process raft request' (duration: 303.910112ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:08.980853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:08.676773Z","time spent":"304.006453ms","remote":"127.0.0.1:57146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3576,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:08.980869Z","caller":"traceutil/trace.go:171","msg":"trace[1123400884] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"302.299342ms","start":"2026-08-20T20:28:08.678549Z","end":"2026-08-20T20:28:08.980849Z","steps":["trace[1123400884] 'process raft request' (duration: 302.036537ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:08.980884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:08.676551Z","time spent":"304.289739ms","remote":"127.0.0.1:57040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:08.980962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:08.67854Z","time spent":"302.371633ms","remote":"127.0.0.1:57432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4320,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:28:08.98111Z","caller":"traceutil/trace.go:171","msg":"trace[1396541033] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"310.270262ms","start":"2026-08-20T20:28:08.670035Z","end":"2026-08-20T20:28:08.980306Z","steps":["trace[1396541033] 'process raft request' (duration: 121.200496ms)","trace[1396541033] 'compare' (duration: 188.461934ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:08.981205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:08.670015Z","time spent":"311.152599ms","remote":"127.0.0.1:57054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317275,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:10.851682Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083174,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-20T20:28:10.929096Z","caller":"traceutil/trace.go:171","msg":"trace[1158667258] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"659.782586ms","start":"2026-08-20T20:28:10.269287Z","end":"2026-08-20T20:28:10.92907Z","steps":["trace[1158667258] 'process raft request' (duration: 659.641214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:10.929251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:10.269277Z","time spent":"659.899998ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:28:10.931744Z","caller":"traceutil/trace.go:171","msg":"trace[1666823234] linearizableReadLoop","detail":"{readStateIndex:508; appliedIndex:507; }","duration":"580.537799ms","start":"2026-08-20T20:28:10.351192Z","end":"2026-08-20T20:28:10.93173Z","steps":["trace[1666823234] 'read index received' (duration: 577.931389ms)","trace[1666823234] 'applied index is now lower than readState.Index' (duration: 2.60544ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:10.931842Z","caller":"traceutil/trace.go:171","msg":"trace[1941098466] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"661.071899ms","start":"2026-08-20T20:28:10.27076Z","end":"2026-08-20T20:28:10.931832Z","steps":["trace[1941098466] 'process raft request' (duration: 660.897946ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:10.931904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:10.270753Z","time spent":"661.11186ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:10.932102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.906236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:10.932137Z","caller":"traceutil/trace.go:171","msg":"trace[675432007] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:489; }","duration":"580.970107ms","start":"2026-08-20T20:28:10.351155Z","end":"2026-08-20T20:28:10.932125Z","steps":["trace[675432007] 'agreement among raft nodes before linearized reading' (duration: 580.912566ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:10.932168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:10.35114Z","time spent":"581.020077ms","remote":"127.0.0.1:57054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-08-20T20:28:10.932416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.558858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:10.932632Z","caller":"traceutil/trace.go:171","msg":"trace[1595987314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:489; }","duration":"348.682329ms","start":"2026-08-20T20:28:10.583805Z","end":"2026-08-20T20:28:10.932487Z","steps":["trace[1595987314] 'agreement among raft nodes before linearized reading' (duration: 348.555597ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:10.932703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:10.583761Z","time spent":"348.929364ms","remote":"127.0.0.1:56970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-20T20:28:11.591099Z","caller":"traceutil/trace.go:171","msg":"trace[279109995] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"455.166524ms","start":"2026-08-20T20:28:11.135907Z","end":"2026-08-20T20:28:11.591073Z","steps":["trace[279109995] 'process raft request' (duration: 455.035852ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:11.591307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.135883Z","time spent":"455.298726ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:11.59978Z","caller":"traceutil/trace.go:171","msg":"trace[507686525] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"453.743898ms","start":"2026-08-20T20:28:11.146022Z","end":"2026-08-20T20:28:11.599766Z","steps":["trace[507686525] 'process raft request' (duration: 453.578725ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:11.599846Z","caller":"traceutil/trace.go:171","msg":"trace[1346884062] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"450.265882ms","start":"2026-08-20T20:28:11.149554Z","end":"2026-08-20T20:28:11.59982Z","steps":["trace[1346884062] 'process raft request' (duration: 450.16152ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:11.59989Z","caller":"traceutil/trace.go:171","msg":"trace[1590684764] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"444.663577ms","start":"2026-08-20T20:28:11.155214Z","end":"2026-08-20T20:28:11.599877Z","steps":["trace[1590684764] 'process raft request' (duration: 444.569045ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:11.599907Z","caller":"traceutil/trace.go:171","msg":"trace[128860507] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"449.61516ms","start":"2026-08-20T20:28:11.150256Z","end":"2026-08-20T20:28:11.599872Z","steps":["trace[128860507] 'process raft request' (duration: 449.491278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:11.59999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.149546Z","time spent":"450.376284ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:11.599993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.155207Z","time spent":"444.730748ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:11.60009Z","caller":"traceutil/trace.go:171","msg":"trace[1841469673] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"442.843233ms","start":"2026-08-20T20:28:11.157224Z","end":"2026-08-20T20:28:11.600067Z","steps":["trace[1841469673] 'process raft request' (duration: 442.64539ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:11.600104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.150249Z","time spent":"449.777053ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:11.600108Z","caller":"traceutil/trace.go:171","msg":"trace[584689594] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"442.837404ms","start":"2026-08-20T20:28:11.157204Z","end":"2026-08-20T20:28:11.600041Z","steps":["trace[584689594] 'process raft request' (duration: 442.63031ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:11.600193Z","caller":"traceutil/trace.go:171","msg":"trace[953416784] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"426.240544ms","start":"2026-08-20T20:28:11.173942Z","end":"2026-08-20T20:28:11.600182Z","steps":["trace[953416784] 'process raft request' (duration: 426.02398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:11.600211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.157207Z","time spent":"442.941016ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:11.600249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.173924Z","time spent":"426.300624ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:11.600262Z","caller":"traceutil/trace.go:171","msg":"trace[690730310] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"419.862704ms","start":"2026-08-20T20:28:11.18039Z","end":"2026-08-20T20:28:11.600253Z","steps":["trace[690730310] 'process raft request' (duration: 419.63527ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:11.60031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.180375Z","time spent":"419.911694ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:11.600322Z","caller":"traceutil/trace.go:171","msg":"trace[180786238] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:511; }","duration":"148.866135ms","start":"2026-08-20T20:28:11.451441Z","end":"2026-08-20T20:28:11.600307Z","steps":["trace[180786238] 'read index received' (duration: 139.447699ms)","trace[180786238] 'applied index is now lower than readState.Index' (duration: 9.417616ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:11.600346Z","caller":"traceutil/trace.go:171","msg":"trace[1800116451] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"381.305542ms","start":"2026-08-20T20:28:11.219029Z","end":"2026-08-20T20:28:11.600335Z","steps":["trace[1800116451] 'process raft request' (duration: 381.105809ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:11.600382Z","caller":"traceutil/trace.go:171","msg":"trace[359909331] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"249.846224ms","start":"2026-08-20T20:28:11.350527Z","end":"2026-08-20T20:28:11.600374Z","steps":["trace[359909331] 'process raft request' (duration: 249.718512ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:11.600397Z","caller":"traceutil/trace.go:171","msg":"trace[971815705] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"383.736308ms","start":"2026-08-20T20:28:11.21665Z","end":"2026-08-20T20:28:11.600387Z","steps":["trace[971815705] 'process raft request' (duration: 383.430753ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:11.600305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.157186Z","time spent":"443.056128ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:11.600439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.219015Z","time spent":"381.383985ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:11.600445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.216624Z","time spent":"383.799289ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:11.600561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.10978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.188\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T20:28:11.600663Z","caller":"traceutil/trace.go:171","msg":"trace[224040157] range","detail":"{range_begin:/registry/masterleases/199.19.213.188; range_end:; response_count:1; response_revision:504; }","duration":"149.215422ms","start":"2026-08-20T20:28:11.451434Z","end":"2026-08-20T20:28:11.60065Z","steps":["trace[224040157] 'agreement among raft nodes before linearized reading' (duration: 148.945116ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:11.599845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:11.146006Z","time spent":"453.808169ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:17.752929Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083362,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:18.25339Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083362,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:18.442372Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.196254865s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T20:28:18.443351Z","caller":"traceutil/trace.go:171","msg":"trace[580062172] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"1.191227282s","start":"2026-08-20T20:28:17.2521Z","end":"2026-08-20T20:28:18.443327Z","steps":["trace[580062172] 'read index received' (duration: 1.190406717s)","trace[580062172] 'applied index is now lower than readState.Index' (duration: 819.735µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:18.443409Z","caller":"traceutil/trace.go:171","msg":"trace[480509785] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"1.199475574s","start":"2026-08-20T20:28:17.243895Z","end":"2026-08-20T20:28:18.44337Z","steps":["trace[480509785] 'process raft request' (duration: 1.198845022s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:18.443509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.191390075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j9mcq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-20T20:28:18.443574Z","caller":"traceutil/trace.go:171","msg":"trace[1796742871] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j9mcq; range_end:; response_count:1; response_revision:597; }","duration":"1.191473006s","start":"2026-08-20T20:28:17.252088Z","end":"2026-08-20T20:28:18.443561Z","steps":["trace[1796742871] 'agreement among raft nodes before linearized reading' (duration: 1.191347464s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:18.443591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:17.243851Z","time spent":"1.199634277s","remote":"127.0.0.1:57054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:18.44361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:17.252051Z","time spent":"1.191550628s","remote":"127.0.0.1:57146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-j9mcq\" "} {"level":"warn","ts":"2026-08-20T20:28:18.443953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.891441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:18.443983Z","caller":"traceutil/trace.go:171","msg":"trace[1229746610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"126.953993ms","start":"2026-08-20T20:28:18.31702Z","end":"2026-08-20T20:28:18.443974Z","steps":["trace[1229746610] 'agreement among raft nodes before linearized reading' (duration: 126.907722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:19.083152Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083365,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-20T20:28:19.166073Z","caller":"traceutil/trace.go:171","msg":"trace[948247712] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"704.308963ms","start":"2026-08-20T20:28:18.461731Z","end":"2026-08-20T20:28:19.16604Z","steps":["trace[948247712] 'process raft request' (duration: 704.117529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:19.166249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:18.4617Z","time spent":"704.458626ms","remote":"127.0.0.1:57146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:28:19.187506Z","caller":"traceutil/trace.go:171","msg":"trace[182122506] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:623; }","duration":"605.293633ms","start":"2026-08-20T20:28:18.582181Z","end":"2026-08-20T20:28:19.187475Z","steps":["trace[182122506] 'read index received' (duration: 583.734768ms)","trace[182122506] 'applied index is now lower than readState.Index' (duration: 21.557595ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:19.187646Z","caller":"traceutil/trace.go:171","msg":"trace[384530679] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"687.172588ms","start":"2026-08-20T20:28:18.500458Z","end":"2026-08-20T20:28:19.18763Z","steps":["trace[384530679] 'process raft request' (duration: 686.877322ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:19.187757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:18.500433Z","time spent":"687.249908ms","remote":"127.0.0.1:57316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:19.188292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.017839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-20T20:28:19.188357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.165779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:19.18837Z","caller":"traceutil/trace.go:171","msg":"trace[1553976277] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"102.126271ms","start":"2026-08-20T20:28:19.086222Z","end":"2026-08-20T20:28:19.188348Z","steps":["trace[1553976277] 'agreement among raft nodes before linearized reading' (duration: 101.985489ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.188421Z","caller":"traceutil/trace.go:171","msg":"trace[1197400416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"606.28834ms","start":"2026-08-20T20:28:18.582116Z","end":"2026-08-20T20:28:19.188404Z","steps":["trace[1197400416] 'agreement among raft nodes before linearized reading' (duration: 606.153878ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:19.188454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:18.582094Z","time spent":"606.353882ms","remote":"127.0.0.1:56986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T20:28:19.188666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.470778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-20T20:28:19.187963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.813747ms","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-08-20T20:28:19.189114Z","caller":"traceutil/trace.go:171","msg":"trace[1567502548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"185.981468ms","start":"2026-08-20T20:28:19.003117Z","end":"2026-08-20T20:28:19.189099Z","steps":["trace[1567502548] 'agreement among raft nodes before linearized reading' (duration: 184.622303ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.18882Z","caller":"traceutil/trace.go:171","msg":"trace[904342160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"185.618602ms","start":"2026-08-20T20:28:19.003133Z","end":"2026-08-20T20:28:19.188751Z","steps":["trace[904342160] 'agreement among raft nodes before linearized reading' (duration: 185.126283ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.335267Z","caller":"traceutil/trace.go:171","msg":"trace[1622010632] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"141.719538ms","start":"2026-08-20T20:28:19.193524Z","end":"2026-08-20T20:28:19.335243Z","steps":["trace[1622010632] 'process raft request' (duration: 112.94719ms)","trace[1622010632] 'compare' (duration: 28.511152ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:19.335552Z","caller":"traceutil/trace.go:171","msg":"trace[525597729] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:626; }","duration":"137.661553ms","start":"2026-08-20T20:28:19.197882Z","end":"2026-08-20T20:28:19.335543Z","steps":["trace[525597729] 'read index received' (duration: 6.306326ms)","trace[525597729] 'applied index is now lower than readState.Index' (duration: 131.354637ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:19.335664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.779825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:19.335749Z","caller":"traceutil/trace.go:171","msg":"trace[1131869638] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:603; }","duration":"137.900338ms","start":"2026-08-20T20:28:19.197841Z","end":"2026-08-20T20:28:19.335741Z","steps":["trace[1131869638] 'agreement among raft nodes before linearized reading' (duration: 137.777075ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.335892Z","caller":"traceutil/trace.go:171","msg":"trace[200059572] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"140.75977ms","start":"2026-08-20T20:28:19.195123Z","end":"2026-08-20T20:28:19.335883Z","steps":["trace[200059572] 'process raft request' (duration: 140.089358ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:19.335274Z","caller":"traceutil/trace.go:171","msg":"trace[5972143] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"140.257551ms","start":"2026-08-20T20:28:19.194997Z","end":"2026-08-20T20:28:19.335255Z","steps":["trace[5972143] 'process raft request' (duration: 140.149699ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:20.639014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055375247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:20.639101Z","caller":"traceutil/trace.go:171","msg":"trace[135833428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"1.05552056s","start":"2026-08-20T20:28:19.583566Z","end":"2026-08-20T20:28:20.639086Z","steps":["trace[135833428] 'range keys from in-memory index tree' (duration: 1.055304585s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:20.639147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:19.583548Z","time spent":"1.05559133s","remote":"127.0.0.1:56970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T20:28:21.1415Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083375,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:21.642383Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083375,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:21.711267Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.939175039s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T20:28:21.715485Z","caller":"traceutil/trace.go:171","msg":"trace[1498199338] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.944868153s","start":"2026-08-20T20:28:19.770488Z","end":"2026-08-20T20:28:21.715357Z","steps":["trace[1498199338] 'process raft request' (duration: 1.941771087s)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:21.715632Z","caller":"traceutil/trace.go:171","msg":"trace[1704389615] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:629; }","duration":"1.074889094s","start":"2026-08-20T20:28:20.640707Z","end":"2026-08-20T20:28:21.715596Z","steps":["trace[1704389615] 'read index received' (duration: 1.070767059s)","trace[1704389615] 'applied index is now lower than readState.Index' (duration: 4.120315ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:21.715678Z","caller":"traceutil/trace.go:171","msg":"trace[1462824349] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"439.786864ms","start":"2026-08-20T20:28:21.27586Z","end":"2026-08-20T20:28:21.715647Z","steps":["trace[1462824349] 'process raft request' (duration: 439.443867ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:21.715756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075050207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:28:21.715734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:19.770468Z","time spent":"1.945171548s","remote":"127.0.0.1:57054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:21.715899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.330985ms","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-08-20T20:28:21.715893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.492477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.188\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T20:28:21.715937Z","caller":"traceutil/trace.go:171","msg":"trace[1501154084] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"507.404516ms","start":"2026-08-20T20:28:21.208518Z","end":"2026-08-20T20:28:21.715922Z","steps":["trace[1501154084] 'agreement among raft nodes before linearized reading' (duration: 507.234813ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:21.715971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:21.2085Z","time spent":"507.463387ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-20T20:28:21.715987Z","caller":"traceutil/trace.go:171","msg":"trace[547363080] range","detail":"{range_begin:/registry/masterleases/199.19.213.188; range_end:; response_count:1; response_revision:605; }","duration":"263.615999ms","start":"2026-08-20T20:28:21.452355Z","end":"2026-08-20T20:28:21.715971Z","steps":["trace[547363080] 'agreement among raft nodes before linearized reading' (duration: 263.437706ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:21.715901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:21.275826Z","time spent":"439.932806ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:28:21.715988Z","caller":"traceutil/trace.go:171","msg":"trace[641041707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"1.075117558s","start":"2026-08-20T20:28:20.64066Z","end":"2026-08-20T20:28:21.715777Z","steps":["trace[641041707] 'agreement among raft nodes before linearized reading' (duration: 1.075051437s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:21.716097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:20.640644Z","time spent":"1.075435194s","remote":"127.0.0.1:56986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T20:28:21.716141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.808666ms","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-08-20T20:28:21.716225Z","caller":"traceutil/trace.go:171","msg":"trace[1744709390] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"375.895418ms","start":"2026-08-20T20:28:21.340303Z","end":"2026-08-20T20:28:21.716199Z","steps":["trace[1744709390] 'agreement among raft nodes before linearized reading' (duration: 375.46029ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:21.716267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:21.340293Z","time spent":"375.964209ms","remote":"127.0.0.1:57216","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-08-20T20:28:21.716409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.234612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-20T20:28:21.716507Z","caller":"traceutil/trace.go:171","msg":"trace[1652158969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:605; }","duration":"377.358724ms","start":"2026-08-20T20:28:21.339118Z","end":"2026-08-20T20:28:21.716477Z","steps":["trace[1652158969] 'agreement among raft nodes before linearized reading' (duration: 377.175451ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:21.716737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:21.339099Z","time spent":"377.614639ms","remote":"127.0.0.1:57216","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-08-20T20:28:21.716769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.936367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-20T20:28:21.716884Z","caller":"traceutil/trace.go:171","msg":"trace[135455315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"377.020279ms","start":"2026-08-20T20:28:21.339802Z","end":"2026-08-20T20:28:21.716822Z","steps":["trace[135455315] 'agreement among raft nodes before linearized reading' (duration: 375.973779ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:21.716951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:21.339771Z","time spent":"377.169311ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-20T20:28:22.316197Z","caller":"traceutil/trace.go:171","msg":"trace[1193015065] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"118.473107ms","start":"2026-08-20T20:28:22.197703Z","end":"2026-08-20T20:28:22.316176Z","steps":["trace[1193015065] 'process raft request' (duration: 117.826004ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:24.015197Z","caller":"traceutil/trace.go:171","msg":"trace[869188764] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"432.089975ms","start":"2026-08-20T20:28:23.583087Z","end":"2026-08-20T20:28:24.015177Z","steps":["trace[869188764] 'read index received' (duration: 431.978263ms)","trace[869188764] 'applied index is now lower than readState.Index' (duration: 110.972µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:24.015334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.236547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:24.015361Z","caller":"traceutil/trace.go:171","msg":"trace[18446425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"432.315909ms","start":"2026-08-20T20:28:23.583039Z","end":"2026-08-20T20:28:24.015355Z","steps":["trace[18446425] 'agreement among raft nodes before linearized reading' (duration: 432.233958ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:24.015385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:23.583015Z","time spent":"432.36482ms","remote":"127.0.0.1:56986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-20T20:28:24.01524Z","caller":"traceutil/trace.go:171","msg":"trace[1779139099] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"498.371029ms","start":"2026-08-20T20:28:23.516838Z","end":"2026-08-20T20:28:24.015209Z","steps":["trace[1779139099] 'process raft request' (duration: 498.231046ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:24.015607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:23.516813Z","time spent":"498.722944ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:24.018225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.824296ms","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-08-20T20:28:24.018303Z","caller":"traceutil/trace.go:171","msg":"trace[1761551674] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:647; }","duration":"265.935058ms","start":"2026-08-20T20:28:23.752344Z","end":"2026-08-20T20:28:24.018279Z","steps":["trace[1761551674] 'agreement among raft nodes before linearized reading' (duration: 265.720674ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:24.018572Z","caller":"traceutil/trace.go:171","msg":"trace[2093789373] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"301.481073ms","start":"2026-08-20T20:28:23.717071Z","end":"2026-08-20T20:28:24.018552Z","steps":["trace[2093789373] 'process raft request' (duration: 300.868232ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:24.018652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.732216ms","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-08-20T20:28:24.018622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.621841ms","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-08-20T20:28:24.018685Z","caller":"traceutil/trace.go:171","msg":"trace[1677641782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:647; }","duration":"264.775126ms","start":"2026-08-20T20:28:23.753903Z","end":"2026-08-20T20:28:24.018678Z","steps":["trace[1677641782] 'agreement among raft nodes before linearized reading' (duration: 264.697675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:24.018682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:23.717045Z","time spent":"301.581384ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:24.018707Z","caller":"traceutil/trace.go:171","msg":"trace[460494092] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"265.741784ms","start":"2026-08-20T20:28:23.752949Z","end":"2026-08-20T20:28:24.018691Z","steps":["trace[460494092] 'agreement among raft nodes before linearized reading' (duration: 265.51835ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:24.018821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.908717ms","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-08-20T20:28:24.019047Z","caller":"traceutil/trace.go:171","msg":"trace[721600180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"266.178682ms","start":"2026-08-20T20:28:23.752792Z","end":"2026-08-20T20:28:24.01897Z","steps":["trace[721600180] 'agreement among raft nodes before linearized reading' (duration: 265.702893ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:33.625498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.345983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T20:28:33.62556Z","caller":"traceutil/trace.go:171","msg":"trace[1794550626] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:751; }","duration":"190.458286ms","start":"2026-08-20T20:28:33.43509Z","end":"2026-08-20T20:28:33.625548Z","steps":["trace[1794550626] 'range keys from in-memory index tree' (duration: 190.205771ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:35.842786Z","caller":"traceutil/trace.go:171","msg":"trace[774697278] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"324.309002ms","start":"2026-08-20T20:28:35.518447Z","end":"2026-08-20T20:28:35.842757Z","steps":["trace[774697278] 'process raft request' (duration: 324.090899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:35.842898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.431372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:35.842991Z","caller":"traceutil/trace.go:171","msg":"trace[1217603538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:757; }","duration":"259.577845ms","start":"2026-08-20T20:28:35.583401Z","end":"2026-08-20T20:28:35.842979Z","steps":["trace[1217603538] 'agreement among raft nodes before linearized reading' (duration: 259.440783ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:35.842915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:35.51842Z","time spent":"324.432784ms","remote":"127.0.0.1:57142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:28:35.842766Z","caller":"traceutil/trace.go:171","msg":"trace[1202886759] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"259.27681ms","start":"2026-08-20T20:28:35.583449Z","end":"2026-08-20T20:28:35.842726Z","steps":["trace[1202886759] 'read index received' (duration: 258.887553ms)","trace[1202886759] 'applied index is now lower than readState.Index' (duration: 388.017µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:35.84349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.561923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T20:28:35.843565Z","caller":"traceutil/trace.go:171","msg":"trace[371962127] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:757; }","duration":"204.691885ms","start":"2026-08-20T20:28:35.638857Z","end":"2026-08-20T20:28:35.843548Z","steps":["trace[371962127] 'agreement among raft nodes before linearized reading' (duration: 204.395489ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:37.358181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.01794ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-20T20:28:37.358304Z","caller":"traceutil/trace.go:171","msg":"trace[1950268260] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:793; }","duration":"155.528912ms","start":"2026-08-20T20:28:37.202757Z","end":"2026-08-20T20:28:37.358286Z","steps":["trace[1950268260] 'read index received' (duration: 41.38442ms)","trace[1950268260] 'applied index is now lower than readState.Index' (duration: 114.143092ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:37.358426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.651254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:37.358462Z","caller":"traceutil/trace.go:171","msg":"trace[1061312915] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:763; }","duration":"155.723096ms","start":"2026-08-20T20:28:37.202728Z","end":"2026-08-20T20:28:37.358451Z","steps":["trace[1061312915] 'agreement among raft nodes before linearized reading' (duration: 155.647225ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:37.358474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.651934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:37.358645Z","caller":"traceutil/trace.go:171","msg":"trace[705708975] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:763; }","duration":"155.846738ms","start":"2026-08-20T20:28:37.202728Z","end":"2026-08-20T20:28:37.358575Z","steps":["trace[705708975] 'agreement among raft nodes before linearized reading' (duration: 155.580244ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:37.358741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.627954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:37.358782Z","caller":"traceutil/trace.go:171","msg":"trace[489057193] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:763; }","duration":"155.715906ms","start":"2026-08-20T20:28:37.203057Z","end":"2026-08-20T20:28:37.358773Z","steps":["trace[489057193] 'agreement among raft nodes before linearized reading' (duration: 155.657355ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:38.028327Z","caller":"traceutil/trace.go:171","msg":"trace[1467034771] linearizableReadLoop","detail":"{readStateIndex:796; appliedIndex:795; }","duration":"153.819571ms","start":"2026-08-20T20:28:37.87449Z","end":"2026-08-20T20:28:38.02831Z","steps":["trace[1467034771] 'read index received' (duration: 146.813369ms)","trace[1467034771] 'applied index is now lower than readState.Index' (duration: 7.005712ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:38.028496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.887803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:38.028529Z","caller":"traceutil/trace.go:171","msg":"trace[1953151216] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:764; }","duration":"153.979555ms","start":"2026-08-20T20:28:37.874544Z","end":"2026-08-20T20:28:38.028523Z","steps":["trace[1953151216] 'agreement among raft nodes before linearized reading' (duration: 153.868752ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.028564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.044356ms","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":"info","ts":"2026-08-20T20:28:38.028641Z","caller":"traceutil/trace.go:171","msg":"trace[352776893] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:764; }","duration":"154.166089ms","start":"2026-08-20T20:28:37.874459Z","end":"2026-08-20T20:28:38.028625Z","steps":["trace[352776893] 'agreement among raft nodes before linearized reading' (duration: 153.945604ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:38.028387Z","caller":"traceutil/trace.go:171","msg":"trace[75995170] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"168.872237ms","start":"2026-08-20T20:28:37.85948Z","end":"2026-08-20T20:28:38.028353Z","steps":["trace[75995170] 'process raft request' (duration: 161.733742ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.0288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.268099ms","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-08-20T20:28:38.028824Z","caller":"traceutil/trace.go:171","msg":"trace[150586246] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:764; }","duration":"121.292769ms","start":"2026-08-20T20:28:37.907525Z","end":"2026-08-20T20:28:38.028818Z","steps":["trace[150586246] 'agreement among raft nodes before linearized reading' (duration: 121.260659ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.028999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.491232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:28:38.029007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.025629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T20:28:38.029043Z","caller":"traceutil/trace.go:171","msg":"trace[1647807396] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:764; }","duration":"121.537913ms","start":"2026-08-20T20:28:37.907495Z","end":"2026-08-20T20:28:38.029033Z","steps":["trace[1647807396] 'agreement among raft nodes before linearized reading' (duration: 121.474072ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.029046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.67622ms","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-08-20T20:28:38.029064Z","caller":"traceutil/trace.go:171","msg":"trace[1942134403] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:764; }","duration":"140.10355ms","start":"2026-08-20T20:28:37.888945Z","end":"2026-08-20T20:28:38.029048Z","steps":["trace[1942134403] 'agreement among raft nodes before linearized reading' (duration: 139.874946ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:38.029113Z","caller":"traceutil/trace.go:171","msg":"trace[500103548] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:764; }","duration":"153.762362ms","start":"2026-08-20T20:28:37.875325Z","end":"2026-08-20T20:28:38.029087Z","steps":["trace[500103548] 'agreement among raft nodes before linearized reading' (duration: 153.612699ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:38.213281Z","caller":"traceutil/trace.go:171","msg":"trace[737406169] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:796; }","duration":"172.819702ms","start":"2026-08-20T20:28:38.040435Z","end":"2026-08-20T20:28:38.213255Z","steps":["trace[737406169] 'read index received' (duration: 159.269765ms)","trace[737406169] 'applied index is now lower than readState.Index' (duration: 13.549017ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:38.213402Z","caller":"traceutil/trace.go:171","msg":"trace[1320561812] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"178.98686ms","start":"2026-08-20T20:28:38.034375Z","end":"2026-08-20T20:28:38.213362Z","steps":["trace[1320561812] 'process raft request' (duration: 165.356191ms)","trace[1320561812] 'compare' (duration: 13.374565ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:38.213526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.060037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:38.213594Z","caller":"traceutil/trace.go:171","msg":"trace[1007964298] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:765; }","duration":"173.170289ms","start":"2026-08-20T20:28:38.040395Z","end":"2026-08-20T20:28:38.213565Z","steps":["trace[1007964298] 'agreement among raft nodes before linearized reading' (duration: 173.033166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.213588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.080807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:38.213684Z","caller":"traceutil/trace.go:171","msg":"trace[1915960151] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:765; }","duration":"173.21746ms","start":"2026-08-20T20:28:38.040455Z","end":"2026-08-20T20:28:38.213672Z","steps":["trace[1915960151] 'agreement among raft nodes before linearized reading' (duration: 173.070117ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.213767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.911768ms","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-08-20T20:28:38.214675Z","caller":"traceutil/trace.go:171","msg":"trace[1018851437] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:765; }","duration":"130.830554ms","start":"2026-08-20T20:28:38.083833Z","end":"2026-08-20T20:28:38.214663Z","steps":["trace[1018851437] 'agreement among raft nodes before linearized reading' (duration: 129.903348ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.213762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.855594ms","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-08-20T20:28:38.214865Z","caller":"traceutil/trace.go:171","msg":"trace[485185255] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:765; }","duration":"132.009114ms","start":"2026-08-20T20:28:38.082845Z","end":"2026-08-20T20:28:38.214854Z","steps":["trace[485185255] 'agreement among raft nodes before linearized reading' (duration: 130.800873ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.213875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.945796ms","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-08-20T20:28:38.215065Z","caller":"traceutil/trace.go:171","msg":"trace[1192539257] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:765; }","duration":"132.144566ms","start":"2026-08-20T20:28:38.082911Z","end":"2026-08-20T20:28:38.215056Z","steps":["trace[1192539257] 'agreement among raft nodes before linearized reading' (duration: 130.941456ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.213919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.834809ms","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-08-20T20:28:38.215257Z","caller":"traceutil/trace.go:171","msg":"trace[137774031] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:765; }","duration":"151.185432ms","start":"2026-08-20T20:28:38.064063Z","end":"2026-08-20T20:28:38.215248Z","steps":["trace[137774031] 'agreement among raft nodes before linearized reading' (duration: 149.835768ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.213942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.424671ms","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-08-20T20:28:38.215461Z","caller":"traceutil/trace.go:171","msg":"trace[261395943] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:765; }","duration":"150.949157ms","start":"2026-08-20T20:28:38.064503Z","end":"2026-08-20T20:28:38.215452Z","steps":["trace[261395943] 'agreement among raft nodes before linearized reading' (duration: 149.426981ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.94501ms","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-08-20T20:28:38.215669Z","caller":"traceutil/trace.go:171","msg":"trace[954457641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:765; }","duration":"151.63228ms","start":"2026-08-20T20:28:38.064027Z","end":"2026-08-20T20:28:38.215659Z","steps":["trace[954457641] 'agreement among raft nodes before linearized reading' (duration: 149.938831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:38.214082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.457263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:38.21583Z","caller":"traceutil/trace.go:171","msg":"trace[116716606] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:765; }","duration":"175.217404ms","start":"2026-08-20T20:28:38.040602Z","end":"2026-08-20T20:28:38.21582Z","steps":["trace[116716606] 'agreement among raft nodes before linearized reading' (duration: 173.436084ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:40.081574Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083742,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:40.582453Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083742,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:41.082621Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083742,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:41.581003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000250259s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-20T20:28:41.581129Z","caller":"traceutil/trace.go:171","msg":"trace[2066938376] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000460162s","start":"2026-08-20T20:28:39.580646Z","end":"2026-08-20T20:28:41.581106Z","steps":["trace[2066938376] 'agreement among raft nodes before linearized reading' (duration: 2.000260689s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.581189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:39.580627Z","time spent":"2.000551233s","remote":"127.0.0.1:56970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/20 20:28:41 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-20T20:28:41.583569Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210083742,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T20:28:41.934902Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.538959522s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T20:28:41.935326Z","caller":"traceutil/trace.go:171","msg":"trace[130522191] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"2.354623133s","start":"2026-08-20T20:28:39.580678Z","end":"2026-08-20T20:28:41.935301Z","steps":["trace[130522191] 'read index received' (duration: 2.354399449s)","trace[130522191] 'applied index is now lower than readState.Index' (duration: 222.564µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:41.935423Z","caller":"traceutil/trace.go:171","msg":"trace[1153793597] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"2.539596782s","start":"2026-08-20T20:28:39.395806Z","end":"2026-08-20T20:28:41.935402Z","steps":["trace[1153793597] 'process raft request' (duration: 2.539327918s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.935587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.71442119s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T20:28:41.935628Z","caller":"traceutil/trace.go:171","msg":"trace[778931288] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:778; }","duration":"1.714508902s","start":"2026-08-20T20:28:40.221108Z","end":"2026-08-20T20:28:41.935617Z","steps":["trace[778931288] 'agreement among raft nodes before linearized reading' (duration: 1.714295818s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.935686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:40.221089Z","time spent":"1.714574203s","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-20T20:28:41.935745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.685541323s","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-08-20T20:28:41.935792Z","caller":"traceutil/trace.go:171","msg":"trace[1415105346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:778; }","duration":"1.685621725s","start":"2026-08-20T20:28:40.250153Z","end":"2026-08-20T20:28:41.935775Z","steps":["trace[1415105346] 'agreement among raft nodes before linearized reading' (duration: 1.685462602s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.935861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:40.250136Z","time spent":"1.685710186s","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T20:28:41.935894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.701246748s","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-08-20T20:28:41.935959Z","caller":"traceutil/trace.go:171","msg":"trace[680134071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:778; }","duration":"1.701373311s","start":"2026-08-20T20:28:40.234572Z","end":"2026-08-20T20:28:41.935945Z","steps":["trace[680134071] 'agreement among raft nodes before linearized reading' (duration: 1.701197038s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.93605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:40.234555Z","time spent":"1.701471372s","remote":"127.0.0.1:57216","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-08-20T20:28:41.935992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.138119382s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:41.936153Z","caller":"traceutil/trace.go:171","msg":"trace[769184711] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:778; }","duration":"1.138329496s","start":"2026-08-20T20:28:40.797808Z","end":"2026-08-20T20:28:41.936137Z","steps":["trace[769184711] 'agreement among raft nodes before linearized reading' (duration: 1.138139053s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.936187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.427035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:28:41.936209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:40.797788Z","time spent":"1.138402987s","remote":"127.0.0.1:57042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-08-20T20:28:41.936229Z","caller":"traceutil/trace.go:171","msg":"trace[553287073] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:778; }","duration":"354.501446ms","start":"2026-08-20T20:28:41.581714Z","end":"2026-08-20T20:28:41.936216Z","steps":["trace[553287073] 'agreement among raft nodes before linearized reading' (duration: 354.440275ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.936278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:41.581697Z","time spent":"354.571007ms","remote":"127.0.0.1:56986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T20:28:41.93641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.731165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T20:28:41.936542Z","caller":"traceutil/trace.go:171","msg":"trace[2112665740] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:778; }","duration":"313.106872ms","start":"2026-08-20T20:28:41.623416Z","end":"2026-08-20T20:28:41.936522Z","steps":["trace[2112665740] 'agreement among raft nodes before linearized reading' (duration: 312.406579ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.936673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:41.623394Z","time spent":"313.254245ms","remote":"127.0.0.1:57146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-08-20T20:28:41.936458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.685648536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-20T20:28:41.936702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.049697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.188\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T20:28:41.936745Z","caller":"traceutil/trace.go:171","msg":"trace[983787640] range","detail":"{range_begin:/registry/masterleases/199.19.213.188; range_end:; response_count:1; response_revision:778; }","duration":"483.147699ms","start":"2026-08-20T20:28:41.453579Z","end":"2026-08-20T20:28:41.936726Z","steps":["trace[983787640] 'agreement among raft nodes before linearized reading' (duration: 483.043247ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:41.936734Z","caller":"traceutil/trace.go:171","msg":"trace[848071355] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:778; }","duration":"1.685936491s","start":"2026-08-20T20:28:40.250782Z","end":"2026-08-20T20:28:41.936718Z","steps":["trace[848071355] 'agreement among raft nodes before linearized reading' (duration: 1.685605974s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.936774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:41.453529Z","time spent":"483.238831ms","remote":"127.0.0.1:57000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.188\" "} {"level":"warn","ts":"2026-08-20T20:28:41.936804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:40.250772Z","time spent":"1.686016532s","remote":"127.0.0.1:57216","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-08-20T20:28:41.935576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:39.395777Z","time spent":"2.539713255s","remote":"127.0.0.1:57198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:28:41.93731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.68709195s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-20T20:28:41.937428Z","caller":"traceutil/trace.go:171","msg":"trace[1250424426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:778; }","duration":"1.687266214s","start":"2026-08-20T20:28:40.250138Z","end":"2026-08-20T20:28:41.937404Z","steps":["trace[1250424426] 'agreement among raft nodes before linearized reading' (duration: 1.686917258s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.937499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:40.250116Z","time spent":"1.687362865s","remote":"127.0.0.1:57216","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-08-20T20:28:41.939095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.743896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T20:28:41.939185Z","caller":"traceutil/trace.go:171","msg":"trace[1500431365] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:778; }","duration":"805.896419ms","start":"2026-08-20T20:28:41.133268Z","end":"2026-08-20T20:28:41.939165Z","steps":["trace[1500431365] 'agreement among raft nodes before linearized reading' (duration: 802.327987ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:41.939223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:41.133242Z","time spent":"805.971951ms","remote":"127.0.0.1:57412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-08-20T20:28:43.748986Z","caller":"traceutil/trace.go:171","msg":"trace[988838488] transaction","detail":"{read_only:false; number_of_response:1; response_revision:789; }","duration":"146.821662ms","start":"2026-08-20T20:28:43.602081Z","end":"2026-08-20T20:28:43.748903Z","steps":["trace[988838488] 'process raft request' (duration: 146.632788ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:45.436126Z","caller":"traceutil/trace.go:171","msg":"trace[707126549] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"168.242715ms","start":"2026-08-20T20:28:45.267838Z","end":"2026-08-20T20:28:45.436081Z","steps":["trace[707126549] 'process raft request' (duration: 123.271343ms)","trace[707126549] 'compare' (duration: 44.705357ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:45.436923Z","caller":"traceutil/trace.go:171","msg":"trace[1983237806] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"168.800415ms","start":"2026-08-20T20:28:45.268093Z","end":"2026-08-20T20:28:45.436894Z","steps":["trace[1983237806] 'process raft request' (duration: 168.658022ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:45.759219Z","caller":"traceutil/trace.go:171","msg":"trace[1345458527] linearizableReadLoop","detail":"{readStateIndex:841; appliedIndex:840; }","duration":"176.379576ms","start":"2026-08-20T20:28:45.582814Z","end":"2026-08-20T20:28:45.759194Z","steps":["trace[1345458527] 'read index received' (duration: 176.153142ms)","trace[1345458527] 'applied index is now lower than readState.Index' (duration: 225.344µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:45.759405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.525018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:45.759283Z","caller":"traceutil/trace.go:171","msg":"trace[154936480] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"237.167744ms","start":"2026-08-20T20:28:45.522083Z","end":"2026-08-20T20:28:45.759251Z","steps":["trace[154936480] 'process raft request' (duration: 236.93804ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:45.759499Z","caller":"traceutil/trace.go:171","msg":"trace[1370490423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:808; }","duration":"176.680822ms","start":"2026-08-20T20:28:45.58278Z","end":"2026-08-20T20:28:45.759461Z","steps":["trace[1370490423] 'agreement among raft nodes before linearized reading' (duration: 176.513329ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:46.360234Z","caller":"traceutil/trace.go:171","msg":"trace[1922912880] transaction","detail":"{read_only:false; response_revision:830; number_of_response:1; }","duration":"164.040938ms","start":"2026-08-20T20:28:46.196166Z","end":"2026-08-20T20:28:46.360207Z","steps":["trace[1922912880] 'process raft request' (duration: 162.309428ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:53.789769Z","caller":"traceutil/trace.go:171","msg":"trace[852888878] linearizableReadLoop","detail":"{readStateIndex:938; appliedIndex:937; }","duration":"205.806724ms","start":"2026-08-20T20:28:53.583937Z","end":"2026-08-20T20:28:53.789744Z","steps":["trace[852888878] 'read index received' (duration: 205.606191ms)","trace[852888878] 'applied index is now lower than readState.Index' (duration: 199.483µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:53.78996Z","caller":"traceutil/trace.go:171","msg":"trace[69402087] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"286.941506ms","start":"2026-08-20T20:28:53.502979Z","end":"2026-08-20T20:28:53.789921Z","steps":["trace[69402087] 'process raft request' (duration: 286.616871ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:53.790029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.070609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:53.790085Z","caller":"traceutil/trace.go:171","msg":"trace[1093626770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:903; }","duration":"206.17893ms","start":"2026-08-20T20:28:53.583893Z","end":"2026-08-20T20:28:53.790072Z","steps":["trace[1093626770] 'agreement among raft nodes before linearized reading' (duration: 206.069698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:54.020534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.017936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:28:54.020775Z","caller":"traceutil/trace.go:171","msg":"trace[1839570148] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:903; }","duration":"128.242001ms","start":"2026-08-20T20:28:53.892428Z","end":"2026-08-20T20:28:54.02067Z","steps":["trace[1839570148] 'range keys from in-memory index tree' (duration: 127.923835ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:54.2789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.899113ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:28:54.279024Z","caller":"traceutil/trace.go:171","msg":"trace[1541991967] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"185.283536ms","start":"2026-08-20T20:28:54.093717Z","end":"2026-08-20T20:28:54.279Z","steps":["trace[1541991967] 'process raft request' (duration: 71.210481ms)","trace[1541991967] 'compare' (duration: 113.758189ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:54.432533Z","caller":"traceutil/trace.go:171","msg":"trace[230470206] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"338.320729ms","start":"2026-08-20T20:28:54.094168Z","end":"2026-08-20T20:28:54.432489Z","steps":["trace[230470206] 'process raft request' (duration: 300.936789ms)","trace[230470206] 'compare' (duration: 37.094855ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:28:54.432827Z","caller":"traceutil/trace.go:171","msg":"trace[413681181] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"333.949573ms","start":"2026-08-20T20:28:54.098854Z","end":"2026-08-20T20:28:54.432803Z","steps":["trace[413681181] 'process raft request' (duration: 333.492086ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:54.432881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:54.094132Z","time spent":"338.507432ms","remote":"127.0.0.1:57066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1745,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T20:28:54.432983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:54.098821Z","time spent":"334.086026ms","remote":"127.0.0.1:57054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12761,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:28:54.433507Z","caller":"traceutil/trace.go:171","msg":"trace[1376879696] linearizableReadLoop","detail":"{readStateIndex:943; appliedIndex:940; }","duration":"323.2064ms","start":"2026-08-20T20:28:54.109545Z","end":"2026-08-20T20:28:54.432751Z","steps":["trace[1376879696] 'read index received' (duration: 55.495901ms)","trace[1376879696] 'applied index is now lower than readState.Index' (duration: 267.708809ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:28:54.433707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.092605ms","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-08-20T20:28:54.433765Z","caller":"traceutil/trace.go:171","msg":"trace[567362292] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:908; }","duration":"324.166706ms","start":"2026-08-20T20:28:54.109584Z","end":"2026-08-20T20:28:54.43375Z","steps":["trace[567362292] 'agreement among raft nodes before linearized reading' (duration: 324.034064ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:54.433809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:54.109579Z","time spent":"324.217527ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T20:28:54.433977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.525365ms","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-08-20T20:28:54.434055Z","caller":"traceutil/trace.go:171","msg":"trace[884153884] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:908; }","duration":"250.654197ms","start":"2026-08-20T20:28:54.183384Z","end":"2026-08-20T20:28:54.434038Z","steps":["trace[884153884] 'agreement among raft nodes before linearized reading' (duration: 250.418673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:54.433729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.125766ms","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-08-20T20:28:54.434393Z","caller":"traceutil/trace.go:171","msg":"trace[759881161] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:908; }","duration":"324.862948ms","start":"2026-08-20T20:28:54.109508Z","end":"2026-08-20T20:28:54.434371Z","steps":["trace[759881161] 'agreement among raft nodes before linearized reading' (duration: 323.889391ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:28:54.435275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:28:54.109495Z","time spent":"325.734663ms","remote":"127.0.0.1:57216","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-08-20T20:28:54.434158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.632253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-20T20:28:54.4357Z","caller":"traceutil/trace.go:171","msg":"trace[1269407378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:908; }","duration":"225.24096ms","start":"2026-08-20T20:28:54.210434Z","end":"2026-08-20T20:28:54.435674Z","steps":["trace[1269407378] 'agreement among raft nodes before linearized reading' (duration: 223.366228ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:54.591708Z","caller":"traceutil/trace.go:171","msg":"trace[21709766] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"152.680355ms","start":"2026-08-20T20:28:54.438995Z","end":"2026-08-20T20:28:54.591675Z","steps":["trace[21709766] 'process raft request' (duration: 148.059675ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:54.591851Z","caller":"traceutil/trace.go:171","msg":"trace[796222209] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"150.259374ms","start":"2026-08-20T20:28:54.441574Z","end":"2026-08-20T20:28:54.591834Z","steps":["trace[796222209] 'process raft request' (duration: 150.135102ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:54.59186Z","caller":"traceutil/trace.go:171","msg":"trace[2086266888] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"152.041434ms","start":"2026-08-20T20:28:54.439771Z","end":"2026-08-20T20:28:54.591813Z","steps":["trace[2086266888] 'process raft request' (duration: 151.873721ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:28:54.592159Z","caller":"traceutil/trace.go:171","msg":"trace[743894444] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"152.9199ms","start":"2026-08-20T20:28:54.439111Z","end":"2026-08-20T20:28:54.592031Z","steps":["trace[743894444] 'process raft request' (duration: 152.467962ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:06.627114Z","caller":"traceutil/trace.go:171","msg":"trace[1915348770] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"131.563169ms","start":"2026-08-20T20:29:06.495243Z","end":"2026-08-20T20:29:06.626806Z","steps":["trace[1915348770] 'process raft request' (duration: 131.188633ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:15.149525Z","caller":"traceutil/trace.go:171","msg":"trace[1356946380] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"131.972763ms","start":"2026-08-20T20:29:15.017532Z","end":"2026-08-20T20:29:15.149505Z","steps":["trace[1356946380] 'process raft request' (duration: 131.843401ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:31.760532Z","caller":"traceutil/trace.go:171","msg":"trace[1156022284] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"223.620244ms","start":"2026-08-20T20:29:31.536867Z","end":"2026-08-20T20:29:31.760487Z","steps":["trace[1156022284] 'process raft request' (duration: 220.892659ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:38.134726Z","caller":"traceutil/trace.go:171","msg":"trace[1529973705] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"105.353821ms","start":"2026-08-20T20:29:38.029353Z","end":"2026-08-20T20:29:38.134707Z","steps":["trace[1529973705] 'process raft request' (duration: 105.24448ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:45.218944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.020191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:29:45.219338Z","caller":"traceutil/trace.go:171","msg":"trace[57003668] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1163; }","duration":"112.973516ms","start":"2026-08-20T20:29:45.106343Z","end":"2026-08-20T20:29:45.219317Z","steps":["trace[57003668] 'read index received' (duration: 47.001µs)","trace[57003668] 'applied index is now lower than readState.Index' (duration: 112.924895ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:45.219394Z","caller":"traceutil/trace.go:171","msg":"trace[766536913] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"226.727854ms","start":"2026-08-20T20:29:44.992643Z","end":"2026-08-20T20:29:45.219371Z","steps":["trace[766536913] 'process raft request' (duration: 93.188754ms)","trace[766536913] 'compare' (duration: 132.874069ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:29:45.21943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.081418ms","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-08-20T20:29:45.219468Z","caller":"traceutil/trace.go:171","msg":"trace[1273826430] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1120; }","duration":"113.1679ms","start":"2026-08-20T20:29:45.106289Z","end":"2026-08-20T20:29:45.219457Z","steps":["trace[1273826430] 'agreement among raft nodes before linearized reading' (duration: 113.094968ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:45.219394Z","caller":"traceutil/trace.go:171","msg":"trace[1956798352] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"225.812459ms","start":"2026-08-20T20:29:44.993568Z","end":"2026-08-20T20:29:45.21938Z","steps":["trace[1956798352] 'process raft request' (duration: 225.480594ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:47.319369Z","caller":"traceutil/trace.go:171","msg":"trace[909828121] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1168; }","duration":"318.990136ms","start":"2026-08-20T20:29:47.000352Z","end":"2026-08-20T20:29:47.319342Z","steps":["trace[909828121] 'read index received' (duration: 318.682881ms)","trace[909828121] 'applied index is now lower than readState.Index' (duration: 306.105µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:47.319448Z","caller":"traceutil/trace.go:171","msg":"trace[1587551490] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"321.936123ms","start":"2026-08-20T20:29:46.9975Z","end":"2026-08-20T20:29:47.319437Z","steps":["trace[1587551490] 'process raft request' (duration: 321.627638ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:47.319542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:29:46.997488Z","time spent":"321.990325ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:29:47.319777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.418402ms","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-08-20T20:29:47.319824Z","caller":"traceutil/trace.go:171","msg":"trace[1198675088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1123; }","duration":"319.473463ms","start":"2026-08-20T20:29:47.00034Z","end":"2026-08-20T20:29:47.319813Z","steps":["trace[1198675088] 'agreement among raft nodes before linearized reading' (duration: 319.123258ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:47.319856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:29:47.00029Z","time spent":"319.558355ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-20T20:29:47.545833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.444192ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:29:47.545904Z","caller":"traceutil/trace.go:171","msg":"trace[974863720] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"222.434389ms","start":"2026-08-20T20:29:47.323458Z","end":"2026-08-20T20:29:47.545892Z","steps":["trace[974863720] 'process raft request' (duration: 119.876415ms)","trace[974863720] 'compare' (duration: 102.351481ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:47.551976Z","caller":"traceutil/trace.go:171","msg":"trace[558257801] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"228.116311ms","start":"2026-08-20T20:29:47.323847Z","end":"2026-08-20T20:29:47.551964Z","steps":["trace[558257801] 'process raft request' (duration: 227.991589ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:47.552272Z","caller":"traceutil/trace.go:171","msg":"trace[765258997] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"227.370889ms","start":"2026-08-20T20:29:47.324861Z","end":"2026-08-20T20:29:47.552232Z","steps":["trace[765258997] 'process raft request' (duration: 227.071465ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:49.612902Z","caller":"traceutil/trace.go:171","msg":"trace[1492295251] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"286.152366ms","start":"2026-08-20T20:29:49.326728Z","end":"2026-08-20T20:29:49.61288Z","steps":["trace[1492295251] 'process raft request' (duration: 285.696679ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:50.747722Z","caller":"traceutil/trace.go:171","msg":"trace[1904087752] linearizableReadLoop","detail":"{readStateIndex:1181; appliedIndex:1180; }","duration":"163.69988ms","start":"2026-08-20T20:29:50.583997Z","end":"2026-08-20T20:29:50.747697Z","steps":["trace[1904087752] 'read index received' (duration: 163.509257ms)","trace[1904087752] 'applied index is now lower than readState.Index' (duration: 189.723µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:50.747851Z","caller":"traceutil/trace.go:171","msg":"trace[42398966] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"207.085574ms","start":"2026-08-20T20:29:50.540702Z","end":"2026-08-20T20:29:50.747788Z","steps":["trace[42398966] 'process raft request' (duration: 206.85396ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:50.747928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.904773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:29:50.748261Z","caller":"traceutil/trace.go:171","msg":"trace[1303718491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1135; }","duration":"164.28122ms","start":"2026-08-20T20:29:50.583941Z","end":"2026-08-20T20:29:50.748223Z","steps":["trace[1303718491] 'agreement among raft nodes before linearized reading' (duration: 163.911804ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:51.70683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.322058ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:29:51.70696Z","caller":"traceutil/trace.go:171","msg":"trace[1804208766] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1182; }","duration":"122.846297ms","start":"2026-08-20T20:29:51.584093Z","end":"2026-08-20T20:29:51.70694Z","steps":["trace[1804208766] 'read index received' (duration: 18.385448ms)","trace[1804208766] 'applied index is now lower than readState.Index' (duration: 104.459419ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:51.706981Z","caller":"traceutil/trace.go:171","msg":"trace[1715275979] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"216.162308ms","start":"2026-08-20T20:29:51.490804Z","end":"2026-08-20T20:29:51.706966Z","steps":["trace[1715275979] 'process raft request' (duration: 111.602916ms)","trace[1715275979] 'compare' (duration: 104.183996ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:29:51.707149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.041001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:29:51.707223Z","caller":"traceutil/trace.go:171","msg":"trace[573583613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1136; }","duration":"123.156053ms","start":"2026-08-20T20:29:51.584052Z","end":"2026-08-20T20:29:51.707208Z","steps":["trace[573583613] 'agreement among raft nodes before linearized reading' (duration: 122.99895ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:52.1739Z","caller":"traceutil/trace.go:171","msg":"trace[1355367134] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"462.016795ms","start":"2026-08-20T20:29:51.711861Z","end":"2026-08-20T20:29:52.173878Z","steps":["trace[1355367134] 'process raft request' (duration: 461.950874ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:52.174021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:29:51.711832Z","time spent":"462.125566ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:29:52.17407Z","caller":"traceutil/trace.go:171","msg":"trace[1400560703] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"462.160716ms","start":"2026-08-20T20:29:51.711878Z","end":"2026-08-20T20:29:52.174039Z","steps":["trace[1400560703] 'process raft request' (duration: 420.189247ms)","trace[1400560703] 'compare' (duration: 41.608594ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:29:52.174234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:29:51.711858Z","time spent":"462.299769ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:29:52.242615Z","caller":"traceutil/trace.go:171","msg":"trace[959087497] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"530.30296ms","start":"2026-08-20T20:29:51.712293Z","end":"2026-08-20T20:29:52.242596Z","steps":["trace[959087497] 'process raft request' (duration: 530.161747ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:52.242753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:29:51.712267Z","time spent":"530.410461ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:29:52.242882Z","caller":"traceutil/trace.go:171","msg":"trace[1700179049] linearizableReadLoop","detail":"{readStateIndex:1186; appliedIndex:1183; }","duration":"530.553533ms","start":"2026-08-20T20:29:51.71232Z","end":"2026-08-20T20:29:52.242873Z","steps":["trace[1700179049] 'read index received' (duration: 419.757261ms)","trace[1700179049] 'applied index is now lower than readState.Index' (duration: 110.795502ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:29:52.243001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.678535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T20:29:52.243037Z","caller":"traceutil/trace.go:171","msg":"trace[785722443] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1140; }","duration":"530.735756ms","start":"2026-08-20T20:29:51.71229Z","end":"2026-08-20T20:29:52.243026Z","steps":["trace[785722443] 'agreement among raft nodes before linearized reading' (duration: 530.619215ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:52.243062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:29:51.71228Z","time spent":"530.775927ms","remote":"127.0.0.1:57000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-08-20T20:29:52.243211Z","caller":"traceutil/trace.go:171","msg":"trace[362759707] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"530.814448ms","start":"2026-08-20T20:29:51.71236Z","end":"2026-08-20T20:29:52.243175Z","steps":["trace[362759707] 'process raft request' (duration: 530.206288ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:52.243394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:29:51.712343Z","time spent":"530.96359ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:29:54.19594Z","caller":"traceutil/trace.go:171","msg":"trace[1136643359] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1189; }","duration":"155.653024ms","start":"2026-08-20T20:29:54.040262Z","end":"2026-08-20T20:29:54.195915Z","steps":["trace[1136643359] 'read index received' (duration: 155.44918ms)","trace[1136643359] 'applied index is now lower than readState.Index' (duration: 202.544µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:54.196323Z","caller":"traceutil/trace.go:171","msg":"trace[357482378] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"512.191316ms","start":"2026-08-20T20:29:53.683786Z","end":"2026-08-20T20:29:54.195977Z","steps":["trace[357482378] 'process raft request' (duration: 511.976172ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:54.196718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:29:53.683756Z","time spent":"512.837365ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:29:54.196998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.68449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:29:54.197163Z","caller":"traceutil/trace.go:171","msg":"trace[149800569] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1143; }","duration":"156.905134ms","start":"2026-08-20T20:29:54.040231Z","end":"2026-08-20T20:29:54.197136Z","steps":["trace[149800569] 'agreement among raft nodes before linearized reading' (duration: 155.875908ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:54.387609Z","caller":"traceutil/trace.go:171","msg":"trace[1048116068] linearizableReadLoop","detail":"{readStateIndex:1192; appliedIndex:1190; }","duration":"139.531762ms","start":"2026-08-20T20:29:54.248059Z","end":"2026-08-20T20:29:54.387591Z","steps":["trace[1048116068] 'read index received' (duration: 56.993229ms)","trace[1048116068] 'applied index is now lower than readState.Index' (duration: 82.537633ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:54.387676Z","caller":"traceutil/trace.go:171","msg":"trace[1722299062] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"185.304592ms","start":"2026-08-20T20:29:54.202357Z","end":"2026-08-20T20:29:54.387662Z","steps":["trace[1722299062] 'process raft request' (duration: 102.673448ms)","trace[1722299062] 'compare' (duration: 82.424261ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:54.387725Z","caller":"traceutil/trace.go:171","msg":"trace[1499447092] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"184.389517ms","start":"2026-08-20T20:29:54.203318Z","end":"2026-08-20T20:29:54.387707Z","steps":["trace[1499447092] 'process raft request' (duration: 184.234174ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:54.387817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.745996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T20:29:54.387835Z","caller":"traceutil/trace.go:171","msg":"trace[1177574767] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1145; }","duration":"139.813107ms","start":"2026-08-20T20:29:54.248017Z","end":"2026-08-20T20:29:54.38783Z","steps":["trace[1177574767] 'agreement among raft nodes before linearized reading' (duration: 139.732205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:54.453803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.144317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T20:29:54.453907Z","caller":"traceutil/trace.go:171","msg":"trace[699031526] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1146; }","duration":"204.287479ms","start":"2026-08-20T20:29:54.249591Z","end":"2026-08-20T20:29:54.453878Z","steps":["trace[699031526] 'agreement among raft nodes before linearized reading' (duration: 204.012785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:54.677369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.21478ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:29:54.677594Z","caller":"traceutil/trace.go:171","msg":"trace[873065097] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"284.919862ms","start":"2026-08-20T20:29:54.392623Z","end":"2026-08-20T20:29:54.677543Z","steps":["trace[873065097] 'process raft request' (duration: 153.447918ms)","trace[873065097] 'compare' (duration: 131.108268ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:29:54.677648Z","caller":"traceutil/trace.go:171","msg":"trace[1451720047] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"218.245775ms","start":"2026-08-20T20:29:54.45937Z","end":"2026-08-20T20:29:54.677616Z","steps":["trace[1451720047] 'process raft request' (duration: 218.098953ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:29:54.941777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.168172ms","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-08-20T20:29:54.941836Z","caller":"traceutil/trace.go:171","msg":"trace[1662324849] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1148; }","duration":"130.292094ms","start":"2026-08-20T20:29:54.811529Z","end":"2026-08-20T20:29:54.941821Z","steps":["trace[1662324849] 'range keys from in-memory index tree' (duration: 129.930098ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:29:59.169956Z","caller":"traceutil/trace.go:171","msg":"trace[585258734] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"114.23287ms","start":"2026-08-20T20:29:59.055699Z","end":"2026-08-20T20:29:59.169932Z","steps":["trace[585258734] 'process raft request' (duration: 114.077756ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:00.881993Z","caller":"traceutil/trace.go:171","msg":"trace[1159686300] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"175.553706ms","start":"2026-08-20T20:30:00.706412Z","end":"2026-08-20T20:30:00.881965Z","steps":["trace[1159686300] 'process raft request' (duration: 175.319342ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:00.884095Z","caller":"traceutil/trace.go:171","msg":"trace[538312295] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"173.287359ms","start":"2026-08-20T20:30:00.710785Z","end":"2026-08-20T20:30:00.884072Z","steps":["trace[538312295] 'process raft request' (duration: 173.092066ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:04.768328Z","caller":"traceutil/trace.go:171","msg":"trace[490428925] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"223.095114ms","start":"2026-08-20T20:30:04.54521Z","end":"2026-08-20T20:30:04.768305Z","steps":["trace[490428925] 'process raft request' (duration: 222.933141ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:04.769306Z","caller":"traceutil/trace.go:171","msg":"trace[1919648229] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"208.154633ms","start":"2026-08-20T20:30:04.56112Z","end":"2026-08-20T20:30:04.769275Z","steps":["trace[1919648229] 'process raft request' (duration: 207.97541ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:05.067821Z","caller":"traceutil/trace.go:171","msg":"trace[762159870] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"100.244279ms","start":"2026-08-20T20:30:04.967552Z","end":"2026-08-20T20:30:05.067796Z","steps":["trace[762159870] 'process raft request' (duration: 100.105737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:09.196222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.90073ms","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-08-20T20:30:09.196316Z","caller":"traceutil/trace.go:171","msg":"trace[1321999216] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1193; }","duration":"113.056922ms","start":"2026-08-20T20:30:09.083238Z","end":"2026-08-20T20:30:09.196295Z","steps":["trace[1321999216] 'range keys from in-memory index tree' (duration: 112.698476ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:11.591282Z","caller":"traceutil/trace.go:171","msg":"trace[1854873883] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"199.979141ms","start":"2026-08-20T20:30:11.391281Z","end":"2026-08-20T20:30:11.59126Z","steps":["trace[1854873883] 'process raft request' (duration: 199.838759ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:11.591249Z","caller":"traceutil/trace.go:171","msg":"trace[1547165879] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"132.760966ms","start":"2026-08-20T20:30:11.458471Z","end":"2026-08-20T20:30:11.591232Z","steps":["trace[1547165879] 'read index received' (duration: 132.579933ms)","trace[1547165879] 'applied index is now lower than readState.Index' (duration: 180.353µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:11.591553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.077801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.188\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T20:30:11.591655Z","caller":"traceutil/trace.go:171","msg":"trace[2095549260] range","detail":"{range_begin:/registry/masterleases/199.19.213.188; range_end:; response_count:1; response_revision:1201; }","duration":"133.168181ms","start":"2026-08-20T20:30:11.458418Z","end":"2026-08-20T20:30:11.591587Z","steps":["trace[2095549260] 'agreement among raft nodes before linearized reading' (duration: 133.018989ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:13.431781Z","caller":"traceutil/trace.go:171","msg":"trace[172052123] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"123.982544ms","start":"2026-08-20T20:30:13.307755Z","end":"2026-08-20T20:30:13.431737Z","steps":["trace[172052123] 'process raft request' (duration: 123.792571ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:13.880734Z","caller":"traceutil/trace.go:171","msg":"trace[89791919] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"137.826262ms","start":"2026-08-20T20:30:13.742879Z","end":"2026-08-20T20:30:13.880705Z","steps":["trace[89791919] 'process raft request' (duration: 137.615679ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:15.025845Z","caller":"traceutil/trace.go:171","msg":"trace[1532370165] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"219.241544ms","start":"2026-08-20T20:30:14.806561Z","end":"2026-08-20T20:30:15.025802Z","steps":["trace[1532370165] 'process raft request' (duration: 152.452367ms)","trace[1532370165] 'compare' (duration: 66.428622ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:15.510302Z","caller":"traceutil/trace.go:171","msg":"trace[1492050898] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1263; }","duration":"267.467094ms","start":"2026-08-20T20:30:15.242802Z","end":"2026-08-20T20:30:15.510269Z","steps":["trace[1492050898] 'read index received' (duration: 244.999095ms)","trace[1492050898] 'applied index is now lower than readState.Index' (duration: 22.466689ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:15.510381Z","caller":"traceutil/trace.go:171","msg":"trace[1089726468] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"412.319918ms","start":"2026-08-20T20:30:15.098044Z","end":"2026-08-20T20:30:15.510364Z","steps":["trace[1089726468] 'process raft request' (duration: 389.807399ms)","trace[1089726468] 'compare' (duration: 22.102502ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:15.510508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:15.098022Z","time spent":"412.402769ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:15.511853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.038018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050268"} {"level":"info","ts":"2026-08-20T20:30:15.511918Z","caller":"traceutil/trace.go:171","msg":"trace[1921859148] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1213; }","duration":"269.133779ms","start":"2026-08-20T20:30:15.242767Z","end":"2026-08-20T20:30:15.511901Z","steps":["trace[1921859148] 'agreement among raft nodes before linearized reading' (duration: 267.692537ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:15.730012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.980855ms","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-08-20T20:30:15.730079Z","caller":"traceutil/trace.go:171","msg":"trace[2071873621] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1214; }","duration":"108.129899ms","start":"2026-08-20T20:30:15.621935Z","end":"2026-08-20T20:30:15.730064Z","steps":["trace[2071873621] 'count revisions from in-memory index tree' (duration: 107.870034ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:16.962519Z","caller":"traceutil/trace.go:171","msg":"trace[1394927048] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"249.30266ms","start":"2026-08-20T20:30:16.713198Z","end":"2026-08-20T20:30:16.9625Z","steps":["trace[1394927048] 'read index received' (duration: 249.236729ms)","trace[1394927048] 'applied index is now lower than readState.Index' (duration: 65.171µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:16.962714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.503854ms","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-08-20T20:30:16.96277Z","caller":"traceutil/trace.go:171","msg":"trace[1626856011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"249.611895ms","start":"2026-08-20T20:30:16.713149Z","end":"2026-08-20T20:30:16.962761Z","steps":["trace[1626856011] 'agreement among raft nodes before linearized reading' (duration: 249.436703ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:16.962875Z","caller":"traceutil/trace.go:171","msg":"trace[1645671476] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"338.300552ms","start":"2026-08-20T20:30:16.624233Z","end":"2026-08-20T20:30:16.962533Z","steps":["trace[1645671476] 'process raft request' (duration: 338.145769ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:16.962965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:16.624199Z","time spent":"338.710329ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:17.213424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.949637ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-20T20:30:17.213784Z","caller":"traceutil/trace.go:171","msg":"trace[468091469] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"246.83653ms","start":"2026-08-20T20:30:16.966915Z","end":"2026-08-20T20:30:17.213752Z","steps":["trace[468091469] 'process raft request' (duration: 246.626037ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:17.288564Z","caller":"traceutil/trace.go:171","msg":"trace[376737212] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"180.244976ms","start":"2026-08-20T20:30:17.108296Z","end":"2026-08-20T20:30:17.288541Z","steps":["trace[376737212] 'read index received' (duration: 149.633197ms)","trace[376737212] 'applied index is now lower than readState.Index' (duration: 30.610739ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:17.288644Z","caller":"traceutil/trace.go:171","msg":"trace[767613546] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"257.430138ms","start":"2026-08-20T20:30:17.031189Z","end":"2026-08-20T20:30:17.288619Z","steps":["trace[767613546] 'process raft request' (duration: 226.750658ms)","trace[767613546] 'compare' (duration: 30.318845ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:17.288774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.459809ms","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-08-20T20:30:17.288816Z","caller":"traceutil/trace.go:171","msg":"trace[1844143700] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1218; }","duration":"180.554401ms","start":"2026-08-20T20:30:17.108251Z","end":"2026-08-20T20:30:17.288806Z","steps":["trace[1844143700] 'agreement among raft nodes before linearized reading' (duration: 180.414469ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:17.289755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.709355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050268"} {"level":"info","ts":"2026-08-20T20:30:17.289818Z","caller":"traceutil/trace.go:171","msg":"trace[1215687837] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1218; }","duration":"143.793866ms","start":"2026-08-20T20:30:17.146008Z","end":"2026-08-20T20:30:17.289802Z","steps":["trace[1215687837] 'agreement among raft nodes before linearized reading' (duration: 142.683987ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:18.282826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.613981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/eg\" ","response":"range_response_count:1 size:1086"} {"level":"info","ts":"2026-08-20T20:30:18.283007Z","caller":"traceutil/trace.go:171","msg":"trace[806031429] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/eg; range_end:; response_count:1; response_revision:1221; }","duration":"217.859885ms","start":"2026-08-20T20:30:18.065128Z","end":"2026-08-20T20:30:18.282988Z","steps":["trace[806031429] 'range keys from in-memory index tree' (duration: 217.446989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:24.320114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.152418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-08-20T20:30:24.320251Z","caller":"traceutil/trace.go:171","msg":"trace[145956951] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1241; }","duration":"104.337934ms","start":"2026-08-20T20:30:24.215884Z","end":"2026-08-20T20:30:24.320222Z","steps":["trace[145956951] 'range keys from in-memory index tree' (duration: 103.858996ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:31.993467Z","caller":"traceutil/trace.go:171","msg":"trace[889306234] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"152.001931ms","start":"2026-08-20T20:30:31.84144Z","end":"2026-08-20T20:30:31.993442Z","steps":["trace[889306234] 'process raft request' (duration: 151.837834ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:34.924688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.883531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:30:34.924818Z","caller":"traceutil/trace.go:171","msg":"trace[1548641747] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"335.190522ms","start":"2026-08-20T20:30:34.589601Z","end":"2026-08-20T20:30:34.924792Z","steps":["trace[1548641747] 'process raft request' (duration: 140.080202ms)","trace[1548641747] 'compare' (duration: 194.58898ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:34.924911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:34.589579Z","time spent":"335.297166ms","remote":"127.0.0.1:57040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":752,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:30:34.964339Z","caller":"traceutil/trace.go:171","msg":"trace[1033530186] linearizableReadLoop","detail":"{readStateIndex:1357; appliedIndex:1356; }","duration":"135.507388ms","start":"2026-08-20T20:30:34.828802Z","end":"2026-08-20T20:30:34.96431Z","steps":["trace[1033530186] 'read index received' (duration: 135.262949ms)","trace[1033530186] 'applied index is now lower than readState.Index' (duration: 243.239µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:34.964507Z","caller":"traceutil/trace.go:171","msg":"trace[1107340573] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"311.043508ms","start":"2026-08-20T20:30:34.653417Z","end":"2026-08-20T20:30:34.96446Z","steps":["trace[1107340573] 'process raft request' (duration: 310.733526ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:34.965228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:34.653397Z","time spent":"311.764355ms","remote":"127.0.0.1:57120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1263,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:34.964611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.791078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-733d33d0-7178-4af7-b219-f85afcff817c\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:30:34.96545Z","caller":"traceutil/trace.go:171","msg":"trace[678658360] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-733d33d0-7178-4af7-b219-f85afcff817c; range_end:; response_count:0; response_revision:1300; }","duration":"136.663921ms","start":"2026-08-20T20:30:34.828757Z","end":"2026-08-20T20:30:34.965421Z","steps":["trace[678658360] 'agreement among raft nodes before linearized reading' (duration: 135.785768ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:35.083489Z","caller":"traceutil/trace.go:171","msg":"trace[2056523225] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"112.766614ms","start":"2026-08-20T20:30:34.970693Z","end":"2026-08-20T20:30:35.083459Z","steps":["trace[2056523225] 'process raft request' (duration: 65.44074ms)","trace[2056523225] 'compare' (duration: 47.21694ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:35.69136Z","caller":"traceutil/trace.go:171","msg":"trace[57684211] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"348.883031ms","start":"2026-08-20T20:30:35.342392Z","end":"2026-08-20T20:30:35.691275Z","steps":["trace[57684211] 'process raft request' (duration: 346.864215ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:35.69175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:35.342364Z","time spent":"349.295077ms","remote":"127.0.0.1:57146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:30:35.693307Z","caller":"traceutil/trace.go:171","msg":"trace[1018412759] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1360; }","duration":"316.410714ms","start":"2026-08-20T20:30:35.376875Z","end":"2026-08-20T20:30:35.693285Z","steps":["trace[1018412759] 'read index received' (duration: 312.393661ms)","trace[1018412759] 'applied index is now lower than readState.Index' (duration: 4.016133ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:35.693469Z","caller":"traceutil/trace.go:171","msg":"trace[1366396974] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"339.905429ms","start":"2026-08-20T20:30:35.353521Z","end":"2026-08-20T20:30:35.693426Z","steps":["trace[1366396974] 'process raft request' (duration: 339.623699ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:35.693583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.658073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-20T20:30:35.693636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:35.353502Z","time spent":"340.046885ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:30:35.693661Z","caller":"traceutil/trace.go:171","msg":"trace[1311312511] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1305; }","duration":"316.81738ms","start":"2026-08-20T20:30:35.376829Z","end":"2026-08-20T20:30:35.693647Z","steps":["trace[1311312511] 'agreement among raft nodes before linearized reading' (duration: 316.663744ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:35.693675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.4039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T20:30:35.693707Z","caller":"traceutil/trace.go:171","msg":"trace[74841559] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1305; }","duration":"179.465203ms","start":"2026-08-20T20:30:35.514234Z","end":"2026-08-20T20:30:35.693699Z","steps":["trace[74841559] 'agreement among raft nodes before linearized reading' (duration: 179.349498ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:35.693733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:35.376796Z","time spent":"316.895292ms","remote":"127.0.0.1:57332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-20T20:30:35.693803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.884261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:30:35.693867Z","caller":"traceutil/trace.go:171","msg":"trace[561158261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1305; }","duration":"108.977975ms","start":"2026-08-20T20:30:35.584878Z","end":"2026-08-20T20:30:35.693856Z","steps":["trace[561158261] 'agreement among raft nodes before linearized reading' (duration: 108.896822ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:35.693826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.391509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:30:35.693961Z","caller":"traceutil/trace.go:171","msg":"trace[1456831015] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1305; }","duration":"158.559995ms","start":"2026-08-20T20:30:35.535386Z","end":"2026-08-20T20:30:35.693946Z","steps":["trace[1456831015] 'agreement among raft nodes before linearized reading' (duration: 158.393349ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:36.101257Z","caller":"traceutil/trace.go:171","msg":"trace[862954986] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1364; }","duration":"291.433586ms","start":"2026-08-20T20:30:35.809786Z","end":"2026-08-20T20:30:36.101219Z","steps":["trace[862954986] 'read index received' (duration: 256.136246ms)","trace[862954986] 'applied index is now lower than readState.Index' (duration: 35.29527ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:36.101325Z","caller":"traceutil/trace.go:171","msg":"trace[1574970677] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"332.002144ms","start":"2026-08-20T20:30:35.769286Z","end":"2026-08-20T20:30:36.101288Z","steps":["trace[1574970677] 'process raft request' (duration: 296.604429ms)","trace[1574970677] 'compare' (duration: 35.023291ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:36.101628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.81192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-08-20T20:30:36.101705Z","caller":"traceutil/trace.go:171","msg":"trace[1432657267] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1308; }","duration":"291.919414ms","start":"2026-08-20T20:30:35.809751Z","end":"2026-08-20T20:30:36.101671Z","steps":["trace[1432657267] 'agreement among raft nodes before linearized reading' (duration: 291.648714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:36.101874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:35.76922Z","time spent":"332.17646ms","remote":"127.0.0.1:57146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:36.138474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.181728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T20:30:36.138556Z","caller":"traceutil/trace.go:171","msg":"trace[155873405] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1309; }","duration":"293.301252ms","start":"2026-08-20T20:30:35.845238Z","end":"2026-08-20T20:30:36.138539Z","steps":["trace[155873405] 'agreement among raft nodes before linearized reading' (duration: 293.094504ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:36.138669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.320716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/default/default\" ","response":"range_response_count:1 size:171"} {"level":"info","ts":"2026-08-20T20:30:36.138859Z","caller":"traceutil/trace.go:171","msg":"trace[1700915994] range","detail":"{range_begin:/registry/serviceaccounts/default/default; range_end:; response_count:1; response_revision:1309; }","duration":"227.572926ms","start":"2026-08-20T20:30:35.911267Z","end":"2026-08-20T20:30:36.13884Z","steps":["trace[1700915994] 'agreement among raft nodes before linearized reading' (duration: 227.182231ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:36.976105Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1592761481210084992,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-20T20:30:37.137299Z","caller":"traceutil/trace.go:171","msg":"trace[1408065712] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"841.849207ms","start":"2026-08-20T20:30:36.295426Z","end":"2026-08-20T20:30:37.137275Z","steps":["trace[1408065712] 'process raft request' (duration: 841.712142ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:37.137651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:36.295403Z","time spent":"841.962631ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:37.571746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.711111ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-20T20:30:37.571838Z","caller":"traceutil/trace.go:171","msg":"trace[2058674913] linearizableReadLoop","detail":"{readStateIndex:1369; appliedIndex:1367; }","duration":"1.096688977s","start":"2026-08-20T20:30:36.475132Z","end":"2026-08-20T20:30:37.571821Z","steps":["trace[2058674913] 'read index received' (duration: 662.073501ms)","trace[2058674913] 'applied index is now lower than readState.Index' (duration: 434.614236ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:37.572106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096960007s","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-08-20T20:30:37.572159Z","caller":"traceutil/trace.go:171","msg":"trace[1850042860] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1311; }","duration":"1.09705372s","start":"2026-08-20T20:30:36.475094Z","end":"2026-08-20T20:30:37.572147Z","steps":["trace[1850042860] 'agreement among raft nodes before linearized reading' (duration: 1.096857423s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:37.572197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:36.475077Z","time spent":"1.097110342s","remote":"127.0.0.1:33358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-08-20T20:30:37.572275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.390096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:30:37.572427Z","caller":"traceutil/trace.go:171","msg":"trace[1839079260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1311; }","duration":"987.527431ms","start":"2026-08-20T20:30:36.584829Z","end":"2026-08-20T20:30:37.572356Z","steps":["trace[1839079260] 'agreement among raft nodes before linearized reading' (duration: 987.365525ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:37.572504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:36.584814Z","time spent":"987.675907ms","remote":"127.0.0.1:56970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T20:30:37.572571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.840375ms","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-08-20T20:30:37.572618Z","caller":"traceutil/trace.go:171","msg":"trace[331474810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1311; }","duration":"241.914588ms","start":"2026-08-20T20:30:37.330689Z","end":"2026-08-20T20:30:37.572604Z","steps":["trace[331474810] 'agreement among raft nodes before linearized reading' (duration: 241.734821ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:37.572622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.635601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T20:30:37.572658Z","caller":"traceutil/trace.go:171","msg":"trace[1465566908] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1311; }","duration":"757.708154ms","start":"2026-08-20T20:30:36.81494Z","end":"2026-08-20T20:30:37.572648Z","steps":["trace[1465566908] 'agreement among raft nodes before linearized reading' (duration: 757.634291ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:37.572642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.21293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-20T20:30:37.572687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:36.814924Z","time spent":"757.756086ms","remote":"127.0.0.1:57300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-08-20T20:30:37.572709Z","caller":"traceutil/trace.go:171","msg":"trace[987403877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1311; }","duration":"393.318724ms","start":"2026-08-20T20:30:37.179376Z","end":"2026-08-20T20:30:37.572695Z","steps":["trace[987403877] 'agreement among raft nodes before linearized reading' (duration: 393.020962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:37.572739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:37.179361Z","time spent":"393.371246ms","remote":"127.0.0.1:57216","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-08-20T20:30:37.572676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.798942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T20:30:37.572809Z","caller":"traceutil/trace.go:171","msg":"trace[1865880189] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1311; }","duration":"582.98611ms","start":"2026-08-20T20:30:36.989799Z","end":"2026-08-20T20:30:37.572785Z","steps":["trace[1865880189] 'agreement among raft nodes before linearized reading' (duration: 582.71063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:37.572866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:36.989781Z","time spent":"583.069142ms","remote":"127.0.0.1:57308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":69,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-08-20T20:30:37.805716Z","caller":"traceutil/trace.go:171","msg":"trace[766486153] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"227.614808ms","start":"2026-08-20T20:30:37.578079Z","end":"2026-08-20T20:30:37.805694Z","steps":["trace[766486153] 'process raft request' (duration: 149.722842ms)","trace[766486153] 'compare' (duration: 77.668508ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:37.805801Z","caller":"traceutil/trace.go:171","msg":"trace[2062738629] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"107.754825ms","start":"2026-08-20T20:30:37.69802Z","end":"2026-08-20T20:30:37.805775Z","steps":["trace[2062738629] 'process raft request' (duration: 107.608639ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:38.304335Z","caller":"traceutil/trace.go:171","msg":"trace[550066455] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"494.633039ms","start":"2026-08-20T20:30:37.809664Z","end":"2026-08-20T20:30:38.304298Z","steps":["trace[550066455] 'process raft request' (duration: 429.819658ms)","trace[550066455] 'compare' (duration: 64.650555ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:38.304522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:37.809644Z","time spent":"494.796786ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:30:38.376585Z","caller":"traceutil/trace.go:171","msg":"trace[2001440127] linearizableReadLoop","detail":"{readStateIndex:1375; appliedIndex:1373; }","duration":"208.92228ms","start":"2026-08-20T20:30:38.167644Z","end":"2026-08-20T20:30:38.376566Z","steps":["trace[2001440127] 'read index received' (duration: 70.784037ms)","trace[2001440127] 'applied index is now lower than readState.Index' (duration: 138.137083ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:38.376735Z","caller":"traceutil/trace.go:171","msg":"trace[1230236412] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"564.400627ms","start":"2026-08-20T20:30:37.812256Z","end":"2026-08-20T20:30:38.376657Z","steps":["trace[1230236412] 'process raft request' (duration: 564.179509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:38.376983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.329384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T20:30:38.377018Z","caller":"traceutil/trace.go:171","msg":"trace[2100492096] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1317; }","duration":"209.422208ms","start":"2026-08-20T20:30:38.167586Z","end":"2026-08-20T20:30:38.377009Z","steps":["trace[2100492096] 'agreement among raft nodes before linearized reading' (duration: 209.092596ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:38.377011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:37.812229Z","time spent":"564.609635ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1857,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T20:30:39.009376Z","caller":"traceutil/trace.go:171","msg":"trace[1340817492] linearizableReadLoop","detail":"{readStateIndex:1377; appliedIndex:1376; }","duration":"420.734736ms","start":"2026-08-20T20:30:38.588613Z","end":"2026-08-20T20:30:39.009348Z","steps":["trace[1340817492] 'read index received' (duration: 420.592631ms)","trace[1340817492] 'applied index is now lower than readState.Index' (duration: 140.745µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:39.009386Z","caller":"traceutil/trace.go:171","msg":"trace[1212859104] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"451.278956ms","start":"2026-08-20T20:30:38.558084Z","end":"2026-08-20T20:30:39.009363Z","steps":["trace[1212859104] 'process raft request' (duration: 451.060338ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:39.009565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.87837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:30:39.00957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.936774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:30:39.009686Z","caller":"traceutil/trace.go:171","msg":"trace[859460856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1319; }","duration":"421.101989ms","start":"2026-08-20T20:30:38.588558Z","end":"2026-08-20T20:30:39.00966Z","steps":["trace[859460856] 'agreement among raft nodes before linearized reading' (duration: 420.900372ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:39.009626Z","caller":"traceutil/trace.go:171","msg":"trace[12918559] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1319; }","duration":"211.987325ms","start":"2026-08-20T20:30:38.797622Z","end":"2026-08-20T20:30:39.009609Z","steps":["trace[12918559] 'agreement among raft nodes before linearized reading' (duration: 211.884071ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:39.009766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:38.588537Z","time spent":"421.212824ms","remote":"127.0.0.1:56986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T20:30:39.009952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:38.558055Z","time spent":"451.537036ms","remote":"127.0.0.1:57142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5719,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:39.413063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.993868ms","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-08-20T20:30:39.413115Z","caller":"traceutil/trace.go:171","msg":"trace[1105978823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1319; }","duration":"270.093671ms","start":"2026-08-20T20:30:39.143008Z","end":"2026-08-20T20:30:39.413101Z","steps":["trace[1105978823] 'range keys from in-memory index tree' (duration: 269.838522ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:39.609885Z","caller":"traceutil/trace.go:171","msg":"trace[1985511366] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"140.659786ms","start":"2026-08-20T20:30:39.46906Z","end":"2026-08-20T20:30:39.60972Z","steps":["trace[1985511366] 'process raft request' (duration: 112.733709ms)","trace[1985511366] 'compare' (duration: 27.682808ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:40.189202Z","caller":"traceutil/trace.go:171","msg":"trace[1451053271] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"378.531493ms","start":"2026-08-20T20:30:39.81064Z","end":"2026-08-20T20:30:40.189172Z","steps":["trace[1451053271] 'process raft request' (duration: 378.349806ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:40.189392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:39.810611Z","time spent":"378.700109ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:40.531206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.56177ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:30:40.53131Z","caller":"traceutil/trace.go:171","msg":"trace[213646789] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1382; }","duration":"222.345768ms","start":"2026-08-20T20:30:40.308948Z","end":"2026-08-20T20:30:40.531294Z","steps":["trace[213646789] 'read index received' (duration: 65.620642ms)","trace[213646789] 'applied index is now lower than readState.Index' (duration: 156.723656ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:40.531548Z","caller":"traceutil/trace.go:171","msg":"trace[1929717339] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"718.35617ms","start":"2026-08-20T20:30:39.813179Z","end":"2026-08-20T20:30:40.531535Z","steps":["trace[1929717339] 'process raft request' (duration: 561.378784ms)","trace[1929717339] 'compare' (duration: 156.322892ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:40.531623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:39.813166Z","time spent":"718.421642ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:40.531993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.980051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T20:30:40.532092Z","caller":"traceutil/trace.go:171","msg":"trace[1817987802] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1325; }","duration":"223.172488ms","start":"2026-08-20T20:30:40.308902Z","end":"2026-08-20T20:30:40.532074Z","steps":["trace[1817987802] 'agreement among raft nodes before linearized reading' (duration: 222.732432ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:40.532147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.204232ms","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-08-20T20:30:40.532246Z","caller":"traceutil/trace.go:171","msg":"trace[1256406520] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1325; }","duration":"131.346727ms","start":"2026-08-20T20:30:40.400875Z","end":"2026-08-20T20:30:40.532222Z","steps":["trace[1256406520] 'agreement among raft nodes before linearized reading' (duration: 130.720134ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:41.572792Z","caller":"traceutil/trace.go:171","msg":"trace[1735819122] linearizableReadLoop","detail":"{readStateIndex:1386; appliedIndex:1385; }","duration":"113.743374ms","start":"2026-08-20T20:30:41.459029Z","end":"2026-08-20T20:30:41.572773Z","steps":["trace[1735819122] 'read index received' (duration: 113.555597ms)","trace[1735819122] 'applied index is now lower than readState.Index' (duration: 187.057µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:41.573046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.014514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.188\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T20:30:41.573109Z","caller":"traceutil/trace.go:171","msg":"trace[1615653134] range","detail":"{range_begin:/registry/masterleases/199.19.213.188; range_end:; response_count:1; response_revision:1328; }","duration":"114.139408ms","start":"2026-08-20T20:30:41.45896Z","end":"2026-08-20T20:30:41.573099Z","steps":["trace[1615653134] 'agreement among raft nodes before linearized reading' (duration: 113.962201ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:41.573528Z","caller":"traceutil/trace.go:171","msg":"trace[342164076] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"114.672887ms","start":"2026-08-20T20:30:41.458845Z","end":"2026-08-20T20:30:41.573518Z","steps":["trace[342164076] 'process raft request' (duration: 113.794775ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:41.868071Z","caller":"traceutil/trace.go:171","msg":"trace[437996668] linearizableReadLoop","detail":"{readStateIndex:1388; appliedIndex:1387; }","duration":"202.591149ms","start":"2026-08-20T20:30:41.665451Z","end":"2026-08-20T20:30:41.868042Z","steps":["trace[437996668] 'read index received' (duration: 141.10123ms)","trace[437996668] 'applied index is now lower than readState.Index' (duration: 61.488189ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:41.868258Z","caller":"traceutil/trace.go:171","msg":"trace[536067198] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"275.44611ms","start":"2026-08-20T20:30:41.592793Z","end":"2026-08-20T20:30:41.868239Z","steps":["trace[536067198] 'process raft request' (duration: 213.816527ms)","trace[536067198] 'compare' (duration: 61.206898ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:41.868526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.045876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:30:41.868581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.513424ms","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-08-20T20:30:41.868616Z","caller":"traceutil/trace.go:171","msg":"trace[278246510] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1329; }","duration":"203.188242ms","start":"2026-08-20T20:30:41.665406Z","end":"2026-08-20T20:30:41.868595Z","steps":["trace[278246510] 'agreement among raft nodes before linearized reading' (duration: 202.941512ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:41.868684Z","caller":"traceutil/trace.go:171","msg":"trace[1503611570] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1329; }","duration":"113.635469ms","start":"2026-08-20T20:30:41.754997Z","end":"2026-08-20T20:30:41.868632Z","steps":["trace[1503611570] 'agreement among raft nodes before linearized reading' (duration: 113.512713ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:41.868837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.587389ms","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-08-20T20:30:41.868915Z","caller":"traceutil/trace.go:171","msg":"trace[1741609556] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1329; }","duration":"195.680943ms","start":"2026-08-20T20:30:41.673204Z","end":"2026-08-20T20:30:41.868885Z","steps":["trace[1741609556] 'agreement among raft nodes before linearized reading' (duration: 195.125381ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:42.877822Z","caller":"traceutil/trace.go:171","msg":"trace[1100839642] linearizableReadLoop","detail":"{readStateIndex:1391; appliedIndex:1390; }","duration":"333.048226ms","start":"2026-08-20T20:30:42.544744Z","end":"2026-08-20T20:30:42.877792Z","steps":["trace[1100839642] 'read index received' (duration: 332.877629ms)","trace[1100839642] 'applied index is now lower than readState.Index' (duration: 169.677µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:42.877903Z","caller":"traceutil/trace.go:171","msg":"trace[1435646113] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"338.047741ms","start":"2026-08-20T20:30:42.539829Z","end":"2026-08-20T20:30:42.877877Z","steps":["trace[1435646113] 'process raft request' (duration: 337.816162ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:42.878031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.971806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T20:30:42.878041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:42.539811Z","time spent":"338.144875ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:42.878055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.303425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T20:30:42.878081Z","caller":"traceutil/trace.go:171","msg":"trace[1880564333] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1332; }","duration":"301.067661ms","start":"2026-08-20T20:30:42.576998Z","end":"2026-08-20T20:30:42.878066Z","steps":["trace[1880564333] 'agreement among raft nodes before linearized reading' (duration: 300.967707ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:42.878112Z","caller":"traceutil/trace.go:171","msg":"trace[974674883] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1332; }","duration":"333.394588ms","start":"2026-08-20T20:30:42.544703Z","end":"2026-08-20T20:30:42.878097Z","steps":["trace[974674883] 'agreement among raft nodes before linearized reading' (duration: 333.219981ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:42.878127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:42.576981Z","time spent":"301.132282ms","remote":"127.0.0.1:55446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-20T20:30:42.878145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:42.544687Z","time spent":"333.45006ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T20:30:42.878179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.383013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T20:30:42.878255Z","caller":"traceutil/trace.go:171","msg":"trace[2127306962] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1332; }","duration":"246.496987ms","start":"2026-08-20T20:30:42.63174Z","end":"2026-08-20T20:30:42.878237Z","steps":["trace[2127306962] 'agreement among raft nodes before linearized reading' (duration: 246.30077ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:42.878278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.293695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:30:42.878316Z","caller":"traceutil/trace.go:171","msg":"trace[1855191815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1332; }","duration":"295.362747ms","start":"2026-08-20T20:30:42.582941Z","end":"2026-08-20T20:30:42.878304Z","steps":["trace[1855191815] 'agreement among raft nodes before linearized reading' (duration: 295.299065ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:43.077632Z","caller":"traceutil/trace.go:171","msg":"trace[510306795] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"194.934165ms","start":"2026-08-20T20:30:42.882663Z","end":"2026-08-20T20:30:43.077597Z","steps":["trace[510306795] 'process raft request' (duration: 188.490248ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:43.077682Z","caller":"traceutil/trace.go:171","msg":"trace[729524433] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"194.840921ms","start":"2026-08-20T20:30:42.882814Z","end":"2026-08-20T20:30:43.077655Z","steps":["trace[729524433] 'process raft request' (duration: 194.716906ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:44.049638Z","caller":"traceutil/trace.go:171","msg":"trace[1580131261] linearizableReadLoop","detail":"{readStateIndex:1395; appliedIndex:1394; }","duration":"115.954654ms","start":"2026-08-20T20:30:43.933667Z","end":"2026-08-20T20:30:44.049621Z","steps":["trace[1580131261] 'read index received' (duration: 115.813789ms)","trace[1580131261] 'applied index is now lower than readState.Index' (duration: 140.315µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:44.049686Z","caller":"traceutil/trace.go:171","msg":"trace[305389974] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"138.260368ms","start":"2026-08-20T20:30:43.911407Z","end":"2026-08-20T20:30:44.049667Z","steps":["trace[305389974] 'process raft request' (duration: 138.104892ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:44.049756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.073078ms","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":"info","ts":"2026-08-20T20:30:44.049774Z","caller":"traceutil/trace.go:171","msg":"trace[621552579] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1336; }","duration":"116.13605ms","start":"2026-08-20T20:30:43.933633Z","end":"2026-08-20T20:30:44.049769Z","steps":["trace[621552579] 'agreement among raft nodes before linearized reading' (duration: 116.056997ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:44.462727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T20:30:44.462828Z","caller":"traceutil/trace.go:171","msg":"trace[1156924235] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1337; }","duration":"114.376497ms","start":"2026-08-20T20:30:44.348431Z","end":"2026-08-20T20:30:44.462807Z","steps":["trace[1156924235] 'count revisions from in-memory index tree' (duration: 114.106327ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:47.07686Z","caller":"traceutil/trace.go:171","msg":"trace[402474021] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1408; }","duration":"120.690263ms","start":"2026-08-20T20:30:46.956152Z","end":"2026-08-20T20:30:47.076842Z","steps":["trace[402474021] 'read index received' (duration: 120.519297ms)","trace[402474021] 'applied index is now lower than readState.Index' (duration: 170.466µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:30:47.07709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.936412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-08-20T20:30:47.077098Z","caller":"traceutil/trace.go:171","msg":"trace[512770473] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"153.985328ms","start":"2026-08-20T20:30:46.923052Z","end":"2026-08-20T20:30:47.077037Z","steps":["trace[512770473] 'process raft request' (duration: 153.667567ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:47.077235Z","caller":"traceutil/trace.go:171","msg":"trace[1141194233] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1349; }","duration":"121.062727ms","start":"2026-08-20T20:30:46.956097Z","end":"2026-08-20T20:30:47.07716Z","steps":["trace[1141194233] 'agreement among raft nodes before linearized reading' (duration: 120.897191ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:30:51.616376Z","caller":"traceutil/trace.go:171","msg":"trace[1360469827] linearizableReadLoop","detail":"{readStateIndex:1424; appliedIndex:1423; }","duration":"425.080833ms","start":"2026-08-20T20:30:51.191271Z","end":"2026-08-20T20:30:51.616352Z","steps":["trace[1360469827] 'read index received' (duration: 424.792913ms)","trace[1360469827] 'applied index is now lower than readState.Index' (duration: 286.89µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:30:51.616457Z","caller":"traceutil/trace.go:171","msg":"trace[1700054610] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"518.996254ms","start":"2026-08-20T20:30:51.097434Z","end":"2026-08-20T20:30:51.61643Z","steps":["trace[1700054610] 'process raft request' (duration: 518.738315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:51.616577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:51.097407Z","time spent":"519.105298ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:30:51.61672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.454717ms","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-08-20T20:30:51.61675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.410163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.188\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T20:30:51.616814Z","caller":"traceutil/trace.go:171","msg":"trace[1785030829] range","detail":"{range_begin:/registry/masterleases/199.19.213.188; range_end:; response_count:1; response_revision:1364; }","duration":"157.504886ms","start":"2026-08-20T20:30:51.459296Z","end":"2026-08-20T20:30:51.616801Z","steps":["trace[1785030829] 'agreement among raft nodes before linearized reading' (duration: 157.351821ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:51.616616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.457218ms","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-08-20T20:30:51.616961Z","caller":"traceutil/trace.go:171","msg":"trace[1269135372] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1364; }","duration":"401.838361ms","start":"2026-08-20T20:30:51.215094Z","end":"2026-08-20T20:30:51.616932Z","steps":["trace[1269135372] 'agreement among raft nodes before linearized reading' (duration: 401.398425ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:51.617068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:51.215072Z","time spent":"401.986646ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-20T20:30:51.616811Z","caller":"traceutil/trace.go:171","msg":"trace[2095396286] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1364; }","duration":"425.584151ms","start":"2026-08-20T20:30:51.191212Z","end":"2026-08-20T20:30:51.616796Z","steps":["trace[2095396286] 'agreement among raft nodes before linearized reading' (duration: 425.256689ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:30:51.61723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:30:51.191189Z","time spent":"425.960295ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T20:31:03.986044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.380813ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T20:31:03.986187Z","caller":"traceutil/trace.go:171","msg":"trace[751747607] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"259.719578ms","start":"2026-08-20T20:31:03.726446Z","end":"2026-08-20T20:31:03.986166Z","steps":["trace[751747607] 'process raft request' (duration: 86.100587ms)","trace[751747607] 'compare' (duration: 173.084932ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:31:04.050898Z","caller":"traceutil/trace.go:171","msg":"trace[905517922] linearizableReadLoop","detail":"{readStateIndex:1475; appliedIndex:1472; }","duration":"303.526971ms","start":"2026-08-20T20:31:03.747354Z","end":"2026-08-20T20:31:04.050881Z","steps":["trace[905517922] 'read index received' (duration: 65.311686ms)","trace[905517922] 'applied index is now lower than readState.Index' (duration: 238.214355ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:31:04.050935Z","caller":"traceutil/trace.go:171","msg":"trace[1265892326] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"324.428546ms","start":"2026-08-20T20:31:03.726492Z","end":"2026-08-20T20:31:04.05092Z","steps":["trace[1265892326] 'process raft request' (duration: 324.273711ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:31:04.050972Z","caller":"traceutil/trace.go:171","msg":"trace[2094727951] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"324.179927ms","start":"2026-08-20T20:31:03.726785Z","end":"2026-08-20T20:31:04.050965Z","steps":["trace[2094727951] 'process raft request' (duration: 324.072544ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:31:04.051023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:31:03.726483Z","time spent":"324.482458ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T20:31:04.05104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.692807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient\" ","response":"range_response_count:1 size:706"} {"level":"info","ts":"2026-08-20T20:31:04.051056Z","caller":"traceutil/trace.go:171","msg":"trace[1007932267] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient; range_end:; response_count:1; response_revision:1411; }","duration":"303.740009ms","start":"2026-08-20T20:31:03.747311Z","end":"2026-08-20T20:31:04.051051Z","steps":["trace[1007932267] 'agreement among raft nodes before linearized reading' (duration: 303.689067ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:31:04.051077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:31:03.747294Z","time spent":"303.77789ms","remote":"127.0.0.1:57308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":729,"request content":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient\" "} {"level":"warn","ts":"2026-08-20T20:31:04.05122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.741137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient\" ","response":"range_response_count:1 size:718"} {"level":"info","ts":"2026-08-20T20:31:04.051239Z","caller":"traceutil/trace.go:171","msg":"trace[1849691449] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient; range_end:; response_count:1; response_revision:1411; }","duration":"248.803428ms","start":"2026-08-20T20:31:03.802431Z","end":"2026-08-20T20:31:04.051234Z","steps":["trace[1849691449] 'agreement among raft nodes before linearized reading' (duration: 248.773467ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:31:04.051358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T20:31:03.72677Z","time spent":"324.213639ms","remote":"127.0.0.1:57216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T20:31:21.915979Z","caller":"traceutil/trace.go:171","msg":"trace[1487611884] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"103.693051ms","start":"2026-08-20T20:31:21.812249Z","end":"2026-08-20T20:31:21.915942Z","steps":["trace[1487611884] 'process raft request' (duration: 103.466464ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:31:22.453656Z","caller":"traceutil/trace.go:171","msg":"trace[1696461126] linearizableReadLoop","detail":"{readStateIndex:1540; appliedIndex:1539; }","duration":"212.737301ms","start":"2026-08-20T20:31:22.240891Z","end":"2026-08-20T20:31:22.453629Z","steps":["trace[1696461126] 'read index received' (duration: 166.460709ms)","trace[1696461126] 'applied index is now lower than readState.Index' (duration: 46.275732ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T20:31:22.453705Z","caller":"traceutil/trace.go:171","msg":"trace[592619689] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"288.316531ms","start":"2026-08-20T20:31:22.16535Z","end":"2026-08-20T20:31:22.453667Z","steps":["trace[592619689] 'process raft request' (duration: 242.174033ms)","trace[592619689] 'compare' (duration: 45.991833ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T20:31:22.454079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.167045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:1 size:733"} {"level":"info","ts":"2026-08-20T20:31:22.454366Z","caller":"traceutil/trace.go:171","msg":"trace[1945874162] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:cloud-provider; range_end:; response_count:1; response_revision:1472; }","duration":"213.447654ms","start":"2026-08-20T20:31:22.240855Z","end":"2026-08-20T20:31:22.454302Z","steps":["trace[1945874162] 'agreement among raft nodes before linearized reading' (duration: 212.896816ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:31:22.498275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.473049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:741"} {"level":"info","ts":"2026-08-20T20:31:22.498417Z","caller":"traceutil/trace.go:171","msg":"trace[1194889033] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1473; }","duration":"255.648544ms","start":"2026-08-20T20:31:22.242737Z","end":"2026-08-20T20:31:22.498385Z","steps":["trace[1194889033] 'agreement among raft nodes before linearized reading' (duration: 255.397016ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T20:31:22.498507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.64368ms","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-08-20T20:31:22.49861Z","caller":"traceutil/trace.go:171","msg":"trace[229184923] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1473; }","duration":"193.806045ms","start":"2026-08-20T20:31:22.304777Z","end":"2026-08-20T20:31:22.498584Z","steps":["trace[229184923] 'agreement among raft nodes before linearized reading' (duration: 193.475774ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:31:30.95242Z","caller":"traceutil/trace.go:171","msg":"trace[632848047] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"102.186417ms","start":"2026-08-20T20:31:30.85021Z","end":"2026-08-20T20:31:30.952397Z","steps":["trace[632848047] 'process raft request' (duration: 102.052463ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T20:31:32.726948Z","caller":"traceutil/trace.go:171","msg":"trace[1278025487] transaction","detail":"{read_only:false; response_revision:1507; number_of_response:1; }","duration":"143.733083ms","start":"2026-08-20T20:31:32.583188Z","end":"2026-08-20T20:31:32.726921Z","steps":["trace[1278025487] 'process raft request' (duration: 143.586728ms)"],"step_count":1}