{"level":"warn","ts":"2026-04-14T10:39:35.132833Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T10:39:35.132953Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-14T10:39:35.133102Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-14T10:39:35.133121Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-04-14T10:39:35.133143Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-14T10:39:35.134001Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-04-14T10:39:35.134103Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-14T10:39:35.139268Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.86566ms"} {"level":"info","ts":"2026-04-14T10:39:35.146162Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-04-14T10:39:35.14626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T10:39:35.146289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-04-14T10:39:35.1463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T10:39:35.146317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-04-14T10:39:35.146357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-04-14T10:39:35.155846Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T10:39:35.157512Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T10:39:35.161262Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-14T10:39:35.166716Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T10:39:35.173267Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T10:39:35.173571Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T10:39:35.173589Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-14T10:39:35.173572Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T10:39:35.175639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-04-14T10:39:35.175746Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-04-14T10:39:35.176045Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-14T10:39:35.176204Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-04-14T10:39:35.176242Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-04-14T10:39:35.176467Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T10:39:35.176516Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T10:39:36.046982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T10:39:36.04706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T10:39:36.047094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-04-14T10:39:36.047255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-04-14T10:39:36.047293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-04-14T10:39:36.047405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-04-14T10:39:36.04744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-04-14T10:39:36.048552Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:39:36.049485Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T10:39:36.049515Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T10:39:36.049975Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:39:36.050207Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:39:36.05035Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:39:36.05054Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T10:39:36.050574Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T10:39:36.051184Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-04-14T10:39:36.052605Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T10:39:36.05662Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T10:39:38.581764Z","caller":"traceutil/trace.go:171","msg":"trace[1269782187] transaction","detail":"{read_only:false; response_revision:136; number_of_response:1; }","duration":"193.493577ms","start":"2026-04-14T10:39:38.388233Z","end":"2026-04-14T10:39:38.581726Z","steps":["trace[1269782187] 'process raft request' (duration: 183.431054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.311875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.275746ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:39:45.312052Z","caller":"traceutil/trace.go:171","msg":"trace[1643796087] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:351; }","duration":"499.323726ms","start":"2026-04-14T10:39:44.812706Z","end":"2026-04-14T10:39:45.31203Z","steps":["trace[1643796087] 'read index received' (duration: 21.291116ms)","trace[1643796087] 'applied index is now lower than readState.Index' (duration: 478.03105ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:39:45.312398Z","caller":"traceutil/trace.go:171","msg":"trace[6159236] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"517.148039ms","start":"2026-04-14T10:39:44.795003Z","end":"2026-04-14T10:39:45.312151Z","steps":["trace[6159236] 'process raft request' (duration: 39.104549ms)","trace[6159236] 'compare' (duration: 476.033324ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:39:45.312773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.832864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-14T10:39:45.312946Z","caller":"traceutil/trace.go:171","msg":"trace[717891203] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:343; }","duration":"451.026284ms","start":"2026-04-14T10:39:44.861848Z","end":"2026-04-14T10:39:45.312874Z","steps":["trace[717891203] 'agreement among raft nodes before linearized reading' (duration: 450.645804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.313016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.861824Z","time spent":"451.180291ms","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-04-14T10:39:45.313085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.500224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-14T10:39:45.313128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.249025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-14T10:39:45.313232Z","caller":"traceutil/trace.go:171","msg":"trace[1253439897] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:343; }","duration":"351.421714ms","start":"2026-04-14T10:39:44.961785Z","end":"2026-04-14T10:39:45.313207Z","steps":["trace[1253439897] 'agreement among raft nodes before linearized reading' (duration: 351.209373ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:45.313238Z","caller":"traceutil/trace.go:171","msg":"trace[752138138] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:343; }","duration":"500.509447ms","start":"2026-04-14T10:39:44.812666Z","end":"2026-04-14T10:39:45.313175Z","steps":["trace[752138138] 'agreement among raft nodes before linearized reading' (duration: 499.478934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.313289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.961763Z","time spent":"351.516629ms","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-04-14T10:39:45.313411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.794965Z","time spent":"517.576341ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:39:45.31359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.602814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-14T10:39:45.313646Z","caller":"traceutil/trace.go:171","msg":"trace[1233176507] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:343; }","duration":"401.665707ms","start":"2026-04-14T10:39:44.91197Z","end":"2026-04-14T10:39:45.313636Z","steps":["trace[1233176507] 'agreement among raft nodes before linearized reading' (duration: 401.576303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.313875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.911958Z","time spent":"401.907949ms","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-04-14T10:39:45.313935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.550857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-14T10:39:45.31397Z","caller":"traceutil/trace.go:171","msg":"trace[53443704] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:343; }","duration":"101.60475ms","start":"2026-04-14T10:39:45.212356Z","end":"2026-04-14T10:39:45.313961Z","steps":["trace[53443704] 'agreement among raft nodes before linearized reading' (duration: 101.548967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.313957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.812653Z","time spent":"500.916538ms","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-04-14T10:39:45.314105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.953848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-14T10:39:45.314133Z","caller":"traceutil/trace.go:171","msg":"trace[1596481108] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:343; }","duration":"151.001152ms","start":"2026-04-14T10:39:45.163124Z","end":"2026-04-14T10:39:45.314125Z","steps":["trace[1596481108] 'agreement among raft nodes before linearized reading' (duration: 150.953009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.31417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.774453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-04-14T10:39:45.314233Z","caller":"traceutil/trace.go:171","msg":"trace[1094948088] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:343; }","duration":"447.91459ms","start":"2026-04-14T10:39:44.866307Z","end":"2026-04-14T10:39:45.314222Z","steps":["trace[1094948088] 'agreement among raft nodes before linearized reading' (duration: 447.7271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.314284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.784969ms","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-04-14T10:39:45.314314Z","caller":"traceutil/trace.go:171","msg":"trace[1056555726] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:343; }","duration":"251.81208ms","start":"2026-04-14T10:39:45.062493Z","end":"2026-04-14T10:39:45.314305Z","steps":["trace[1056555726] 'agreement among raft nodes before linearized reading' (duration: 251.768358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.31429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.866277Z","time spent":"447.996935ms","remote":"127.0.0.1:53402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4345,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-04-14T10:39:45.314424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.534102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-14T10:39:45.31445Z","caller":"traceutil/trace.go:171","msg":"trace[2141368447] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:343; }","duration":"302.612727ms","start":"2026-04-14T10:39:45.01183Z","end":"2026-04-14T10:39:45.314443Z","steps":["trace[2141368447] 'agreement among raft nodes before linearized reading' (duration: 302.567804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.314469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.01181Z","time spent":"302.653809ms","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-04-14T10:39:45.314585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.335193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-04-14T10:39:45.314829Z","caller":"traceutil/trace.go:171","msg":"trace[973013110] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:343; }","duration":"448.589516ms","start":"2026-04-14T10:39:44.866231Z","end":"2026-04-14T10:39:45.314821Z","steps":["trace[973013110] 'agreement among raft nodes before linearized reading' (duration: 448.314862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.314868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.866225Z","time spent":"448.635959ms","remote":"127.0.0.1:53402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5349,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-04-14T10:39:45.314891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.165287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-04-14T10:39:45.314939Z","caller":"traceutil/trace.go:171","msg":"trace[1715081867] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:343; }","duration":"449.21606ms","start":"2026-04-14T10:39:44.865696Z","end":"2026-04-14T10:39:45.314912Z","steps":["trace[1715081867] 'agreement among raft nodes before linearized reading' (duration: 449.164527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.314946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.717353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7294"} {"level":"warn","ts":"2026-04-14T10:39:45.314964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.865682Z","time spent":"449.273383ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-04-14T10:39:45.31499Z","caller":"traceutil/trace.go:171","msg":"trace[607824913] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:343; }","duration":"448.804017ms","start":"2026-04-14T10:39:44.866173Z","end":"2026-04-14T10:39:45.314977Z","steps":["trace[607824913] 'agreement among raft nodes before linearized reading' (duration: 448.701802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.315021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.866162Z","time spent":"448.854221ms","remote":"127.0.0.1:53402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7317,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-04-14T10:39:45.315094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.150206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4660"} {"level":"warn","ts":"2026-04-14T10:39:45.315104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.875421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4196"} {"level":"info","ts":"2026-04-14T10:39:45.315124Z","caller":"traceutil/trace.go:171","msg":"trace[833090524] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:343; }","duration":"449.192368ms","start":"2026-04-14T10:39:44.865924Z","end":"2026-04-14T10:39:45.315116Z","steps":["trace[833090524] 'agreement among raft nodes before linearized reading' (duration: 449.138516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.315144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.865913Z","time spent":"449.226761ms","remote":"127.0.0.1:53402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":4683,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-04-14T10:39:45.314243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.763006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-04-14T10:39:45.315221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.391879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-04-14T10:39:45.315291Z","caller":"traceutil/trace.go:171","msg":"trace[1182611251] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:343; }","duration":"449.490304ms","start":"2026-04-14T10:39:44.865783Z","end":"2026-04-14T10:39:45.315274Z","steps":["trace[1182611251] 'agreement among raft nodes before linearized reading' (duration: 449.328175ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:45.315126Z","caller":"traceutil/trace.go:171","msg":"trace[1185911340] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:343; }","duration":"448.936854ms","start":"2026-04-14T10:39:44.86618Z","end":"2026-04-14T10:39:45.315116Z","steps":["trace[1185911340] 'agreement among raft nodes before linearized reading' (duration: 448.894432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.315325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.865777Z","time spent":"449.543627ms","remote":"127.0.0.1:53402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6984,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-04-14T10:39:45.315362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:44.866147Z","time spent":"449.177148ms","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4219,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-14T10:39:45.315238Z","caller":"traceutil/trace.go:171","msg":"trace[830725901] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:343; }","duration":"202.78765ms","start":"2026-04-14T10:39:45.11244Z","end":"2026-04-14T10:39:45.315227Z","steps":["trace[830725901] 'agreement among raft nodes before linearized reading' (duration: 201.769716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:45.824006Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102395534765337,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:39:46.390724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.818765ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:39:46.390839Z","caller":"traceutil/trace.go:171","msg":"trace[1680536795] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"1.068107511s","start":"2026-04-14T10:39:45.322708Z","end":"2026-04-14T10:39:46.390816Z","steps":["trace[1680536795] 'process raft request' (duration: 662.101157ms)","trace[1680536795] 'compare' (duration: 405.601773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:39:46.390954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.322683Z","time spent":"1.068201046s","remote":"127.0.0.1:53308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2162,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:39:46.419618Z","caller":"traceutil/trace.go:171","msg":"trace[1615996960] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"1.09570271s","start":"2026-04-14T10:39:45.323883Z","end":"2026-04-14T10:39:46.419586Z","steps":["trace[1615996960] 'process raft request' (duration: 1.095539591s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.419674Z","caller":"traceutil/trace.go:171","msg":"trace[123453546] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:352; }","duration":"1.096630028s","start":"2026-04-14T10:39:45.323023Z","end":"2026-04-14T10:39:46.419653Z","steps":["trace[123453546] 'read index received' (duration: 661.853993ms)","trace[123453546] 'applied index is now lower than readState.Index' (duration: 434.775175ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:39:46.419802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.32387Z","time spent":"1.095822076s","remote":"127.0.0.1:53714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:39:46.419926Z","caller":"traceutil/trace.go:171","msg":"trace[1423718677] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"1.09551127s","start":"2026-04-14T10:39:45.324403Z","end":"2026-04-14T10:39:46.419914Z","steps":["trace[1423718677] 'process raft request' (duration: 1.095061867s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.420022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.324392Z","time spent":"1.095577063s","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4354,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:39:46.420018Z","caller":"traceutil/trace.go:171","msg":"trace[1060678097] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"1.096819098s","start":"2026-04-14T10:39:45.323174Z","end":"2026-04-14T10:39:46.419993Z","steps":["trace[1060678097] 'process raft request' (duration: 1.096195106s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.420129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.32316Z","time spent":"1.096925804s","remote":"127.0.0.1:53286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-14T10:39:46.420214Z","caller":"traceutil/trace.go:171","msg":"trace[640029198] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"1.092437489s","start":"2026-04-14T10:39:45.327765Z","end":"2026-04-14T10:39:46.420202Z","steps":["trace[640029198] 'process raft request' (duration: 1.091853209s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.42028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.327755Z","time spent":"1.092492641s","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:39:46.420311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.097273782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-14T10:39:46.420373Z","caller":"traceutil/trace.go:171","msg":"trace[1476055908] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"1.097300133s","start":"2026-04-14T10:39:45.323057Z","end":"2026-04-14T10:39:46.420357Z","steps":["trace[1476055908] 'process raft request' (duration: 1.096198886s)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.420413Z","caller":"traceutil/trace.go:171","msg":"trace[1058572239] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:352; }","duration":"1.097383047s","start":"2026-04-14T10:39:45.32299Z","end":"2026-04-14T10:39:46.420373Z","steps":["trace[1058572239] 'agreement among raft nodes before linearized reading' (duration: 1.09725249s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.42046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.323031Z","time spent":"1.097391928s","remote":"127.0.0.1:53474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-14T10:39:46.420481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.322974Z","time spent":"1.097493893s","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-04-14T10:39:46.420137Z","caller":"traceutil/trace.go:171","msg":"trace[1633753636] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"1.093359157s","start":"2026-04-14T10:39:45.326689Z","end":"2026-04-14T10:39:46.420048Z","steps":["trace[1633753636] 'process raft request' (duration: 1.092895613s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.420718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.097555427s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7294"} {"level":"info","ts":"2026-04-14T10:39:46.420733Z","caller":"traceutil/trace.go:171","msg":"trace[425117016] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"1.09551394s","start":"2026-04-14T10:39:45.325208Z","end":"2026-04-14T10:39:46.420722Z","steps":["trace[425117016] 'process raft request' (duration: 1.094301627s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.423221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.325195Z","time spent":"1.09798362s","remote":"127.0.0.1:53462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1247,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:39:46.420808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.106684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-04-14T10:39:46.423221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.32667Z","time spent":"1.096289701s","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:39:46.423294Z","caller":"traceutil/trace.go:171","msg":"trace[1121112846] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:352; }","duration":"338.606605ms","start":"2026-04-14T10:39:46.084647Z","end":"2026-04-14T10:39:46.423253Z","steps":["trace[1121112846] 'agreement among raft nodes before linearized reading' (duration: 336.126385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.423325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:46.084622Z","time spent":"338.696481ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T10:39:46.423342Z","caller":"traceutil/trace.go:171","msg":"trace[1631217024] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:352; }","duration":"1.100009396s","start":"2026-04-14T10:39:45.323152Z","end":"2026-04-14T10:39:46.423162Z","steps":["trace[1631217024] 'agreement among raft nodes before linearized reading' (duration: 1.097510344s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.420862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.299523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-14T10:39:46.423424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.323118Z","time spent":"1.100264549s","remote":"127.0.0.1:53402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7317,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-04-14T10:39:46.423406Z","caller":"traceutil/trace.go:171","msg":"trace[1623362209] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:352; }","duration":"397.827346ms","start":"2026-04-14T10:39:46.025557Z","end":"2026-04-14T10:39:46.423384Z","steps":["trace[1623362209] 'agreement among raft nodes before linearized reading' (duration: 395.277902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.423659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:46.025471Z","time spent":"398.159503ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-14T10:39:46.421067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.333818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T10:39:46.423754Z","caller":"traceutil/trace.go:171","msg":"trace[591694044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:352; }","duration":"711.0581ms","start":"2026-04-14T10:39:45.712681Z","end":"2026-04-14T10:39:46.423739Z","steps":["trace[591694044] 'agreement among raft nodes before linearized reading' (duration: 708.356029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.423808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.712654Z","time spent":"711.142615ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:39:46.421105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008715297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-14T10:39:46.423956Z","caller":"traceutil/trace.go:171","msg":"trace[1008563733] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:352; }","duration":"1.011616699s","start":"2026-04-14T10:39:45.412327Z","end":"2026-04-14T10:39:46.423944Z","steps":["trace[1008563733] 'agreement among raft nodes before linearized reading' (duration: 1.008755319s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.423992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.412267Z","time spent":"1.011716054s","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"info","ts":"2026-04-14T10:39:46.421091Z","caller":"traceutil/trace.go:171","msg":"trace[448070399] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"1.094473045s","start":"2026-04-14T10:39:45.326599Z","end":"2026-04-14T10:39:46.421072Z","steps":["trace[448070399] 'process raft request' (duration: 1.092945745s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.424191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.326587Z","time spent":"1.097569509s","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:39:46.421164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058159991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-14T10:39:46.424359Z","caller":"traceutil/trace.go:171","msg":"trace[1291737436] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:352; }","duration":"1.061461795s","start":"2026-04-14T10:39:45.362888Z","end":"2026-04-14T10:39:46.42435Z","steps":["trace[1291737436] 'agreement among raft nodes before linearized reading' (duration: 1.058236875s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.424395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.362867Z","time spent":"1.061518968s","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-04-14T10:39:46.421203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096725924s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-04-14T10:39:46.424605Z","caller":"traceutil/trace.go:171","msg":"trace[151071201] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:352; }","duration":"1.100137263s","start":"2026-04-14T10:39:45.324458Z","end":"2026-04-14T10:39:46.424595Z","steps":["trace[151071201] 'agreement among raft nodes before linearized reading' (duration: 1.096722444s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.424641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.324452Z","time spent":"1.100177025s","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-14T10:39:46.421193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096681652s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-04-14T10:39:46.424851Z","caller":"traceutil/trace.go:171","msg":"trace[1402119111] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:352; }","duration":"1.100354154s","start":"2026-04-14T10:39:45.324486Z","end":"2026-04-14T10:39:46.424841Z","steps":["trace[1402119111] 'agreement among raft nodes before linearized reading' (duration: 1.0966523s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.424886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.324483Z","time spent":"1.100393957s","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-14T10:39:46.421248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096889892s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-04-14T10:39:46.426202Z","caller":"traceutil/trace.go:171","msg":"trace[1903273592] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:352; }","duration":"1.101862724s","start":"2026-04-14T10:39:45.324328Z","end":"2026-04-14T10:39:46.426191Z","steps":["trace[1903273592] 'agreement among raft nodes before linearized reading' (duration: 1.096890093s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.426245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.324315Z","time spent":"1.101918526s","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-14T10:39:46.421253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096463711s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-04-14T10:39:46.42646Z","caller":"traceutil/trace.go:171","msg":"trace[80957625] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:352; }","duration":"1.101691364s","start":"2026-04-14T10:39:45.324757Z","end":"2026-04-14T10:39:46.426448Z","steps":["trace[80957625] 'agreement among raft nodes before linearized reading' (duration: 1.09646768s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.426495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.324747Z","time spent":"1.101738677s","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-14T10:39:46.421301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096752506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-04-14T10:39:46.426667Z","caller":"traceutil/trace.go:171","msg":"trace[1287704598] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:352; }","duration":"1.102126668s","start":"2026-04-14T10:39:45.324531Z","end":"2026-04-14T10:39:46.426658Z","steps":["trace[1287704598] 'agreement among raft nodes before linearized reading' (duration: 1.096745005s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.426701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.324527Z","time spent":"1.10216585s","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-14T10:39:46.421343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096815149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-04-14T10:39:46.426911Z","caller":"traceutil/trace.go:171","msg":"trace[1871955475] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:352; }","duration":"1.102380792s","start":"2026-04-14T10:39:45.324521Z","end":"2026-04-14T10:39:46.426902Z","steps":["trace[1871955475] 'agreement among raft nodes before linearized reading' (duration: 1.096798238s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.426969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.324506Z","time spent":"1.102453895s","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4391,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-14T10:39:46.421009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.863787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:39:46.427151Z","caller":"traceutil/trace.go:171","msg":"trace[75392982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:352; }","duration":"614.075212ms","start":"2026-04-14T10:39:45.813066Z","end":"2026-04-14T10:39:46.427142Z","steps":["trace[75392982] 'agreement among raft nodes before linearized reading' (duration: 607.811202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:39:46.427182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:39:45.813046Z","time spent":"614.127446ms","remote":"127.0.0.1:53200","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-04-14T10:39:46.597078Z","caller":"traceutil/trace.go:171","msg":"trace[910071467] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"165.664171ms","start":"2026-04-14T10:39:46.431391Z","end":"2026-04-14T10:39:46.597055Z","steps":["trace[910071467] 'process raft request' (duration: 158.179819ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.597465Z","caller":"traceutil/trace.go:171","msg":"trace[441072432] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"161.870182ms","start":"2026-04-14T10:39:46.435573Z","end":"2026-04-14T10:39:46.597443Z","steps":["trace[441072432] 'process raft request' (duration: 161.794248ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.597482Z","caller":"traceutil/trace.go:171","msg":"trace[1830396148] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"160.483189ms","start":"2026-04-14T10:39:46.436982Z","end":"2026-04-14T10:39:46.597465Z","steps":["trace[1830396148] 'process raft request' (duration: 160.421976ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.597495Z","caller":"traceutil/trace.go:171","msg":"trace[1384501510] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"165.41778ms","start":"2026-04-14T10:39:46.432056Z","end":"2026-04-14T10:39:46.597474Z","steps":["trace[1384501510] 'process raft request' (duration: 165.281412ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.597519Z","caller":"traceutil/trace.go:171","msg":"trace[15633128] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"165.578168ms","start":"2026-04-14T10:39:46.431907Z","end":"2026-04-14T10:39:46.597485Z","steps":["trace[15633128] 'process raft request' (duration: 165.334604ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.597641Z","caller":"traceutil/trace.go:171","msg":"trace[207583225] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"161.319434ms","start":"2026-04-14T10:39:46.436315Z","end":"2026-04-14T10:39:46.597635Z","steps":["trace[207583225] 'process raft request' (duration: 161.07214ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.597723Z","caller":"traceutil/trace.go:171","msg":"trace[1568931521] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"165.871714ms","start":"2026-04-14T10:39:46.431841Z","end":"2026-04-14T10:39:46.597713Z","steps":["trace[1568931521] 'process raft request' (duration: 165.127944ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.597761Z","caller":"traceutil/trace.go:171","msg":"trace[428473251] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"165.755927ms","start":"2026-04-14T10:39:46.431985Z","end":"2026-04-14T10:39:46.597741Z","steps":["trace[428473251] 'process raft request' (duration: 165.329094ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.597897Z","caller":"traceutil/trace.go:171","msg":"trace[1886991069] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"160.549773ms","start":"2026-04-14T10:39:46.437314Z","end":"2026-04-14T10:39:46.597864Z","steps":["trace[1886991069] 'process raft request' (duration: 160.10971ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.598046Z","caller":"traceutil/trace.go:171","msg":"trace[71671655] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:361; }","duration":"161.726615ms","start":"2026-04-14T10:39:46.436305Z","end":"2026-04-14T10:39:46.598032Z","steps":["trace[71671655] 'read index received' (duration: 153.337205ms)","trace[71671655] 'applied index is now lower than readState.Index' (duration: 8.38856ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:39:46.598149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.81955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:39:46.598171Z","caller":"traceutil/trace.go:171","msg":"trace[815756485] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"160.059027ms","start":"2026-04-14T10:39:46.438098Z","end":"2026-04-14T10:39:46.598157Z","steps":["trace[815756485] 'process raft request' (duration: 159.690728ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.598186Z","caller":"traceutil/trace.go:171","msg":"trace[1540986929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:363; }","duration":"161.902704ms","start":"2026-04-14T10:39:46.436273Z","end":"2026-04-14T10:39:46.598176Z","steps":["trace[1540986929] 'agreement among raft nodes before linearized reading' (duration: 161.804429ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:39:46.598333Z","caller":"traceutil/trace.go:171","msg":"trace[1569643425] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"160.086308ms","start":"2026-04-14T10:39:46.438238Z","end":"2026-04-14T10:39:46.598325Z","steps":["trace[1569643425] 'process raft request' (duration: 159.698878ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:08.405245Z","caller":"traceutil/trace.go:171","msg":"trace[1281566816] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"116.231474ms","start":"2026-04-14T10:40:08.288986Z","end":"2026-04-14T10:40:08.405218Z","steps":["trace[1281566816] 'process raft request' (duration: 116.005292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:10.536932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.423903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:65214"} {"level":"info","ts":"2026-04-14T10:40:10.537054Z","caller":"traceutil/trace.go:171","msg":"trace[1740066001] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:591; }","duration":"204.600646ms","start":"2026-04-14T10:40:10.332423Z","end":"2026-04-14T10:40:10.537024Z","steps":["trace[1740066001] 'range keys from in-memory index tree' (duration: 204.0769ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:10.537173Z","caller":"traceutil/trace.go:171","msg":"trace[556733555] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"185.968103ms","start":"2026-04-14T10:40:10.351155Z","end":"2026-04-14T10:40:10.537123Z","steps":["trace[556733555] 'process raft request' (duration: 185.638239ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:13.197348Z","caller":"traceutil/trace.go:171","msg":"trace[893439937] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"195.140271ms","start":"2026-04-14T10:40:13.002176Z","end":"2026-04-14T10:40:13.197317Z","steps":["trace[893439937] 'read index received' (duration: 192.325136ms)","trace[893439937] 'applied index is now lower than readState.Index' (duration: 2.813875ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:40:13.19809Z","caller":"traceutil/trace.go:171","msg":"trace[747030880] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"205.447706ms","start":"2026-04-14T10:40:12.992231Z","end":"2026-04-14T10:40:13.197679Z","steps":["trace[747030880] 'process raft request' (duration: 203.370959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:13.215749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.559604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:13.215812Z","caller":"traceutil/trace.go:171","msg":"trace[349302368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:606; }","duration":"213.673025ms","start":"2026-04-14T10:40:13.002123Z","end":"2026-04-14T10:40:13.215796Z","steps":["trace[349302368] 'agreement among raft nodes before linearized reading' (duration: 195.643048ms)","trace[349302368] 'range keys from in-memory index tree' (duration: 17.711923ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:40:15.062177Z","caller":"traceutil/trace.go:171","msg":"trace[414048983] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"162.069368ms","start":"2026-04-14T10:40:14.900006Z","end":"2026-04-14T10:40:15.062075Z","steps":["trace[414048983] 'process raft request' (duration: 136.976323ms)","trace[414048983] 'compare' (duration: 23.030347ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:40:15.06266Z","caller":"traceutil/trace.go:171","msg":"trace[563658659] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"155.927199ms","start":"2026-04-14T10:40:14.906678Z","end":"2026-04-14T10:40:15.062605Z","steps":["trace[563658659] 'read index received' (duration: 130.462879ms)","trace[563658659] 'applied index is now lower than readState.Index' (duration: 25.46193ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:40:15.063004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.306964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.063046Z","caller":"traceutil/trace.go:171","msg":"trace[1421575212] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:621; }","duration":"156.392734ms","start":"2026-04-14T10:40:14.906631Z","end":"2026-04-14T10:40:15.063024Z","steps":["trace[1421575212] 'agreement among raft nodes before linearized reading' (duration: 156.236652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.063764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.895152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.063884Z","caller":"traceutil/trace.go:171","msg":"trace[78000939] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:621; }","duration":"157.040363ms","start":"2026-04-14T10:40:14.906801Z","end":"2026-04-14T10:40:15.063842Z","steps":["trace[78000939] 'agreement among raft nodes before linearized reading' (duration: 156.380104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.065826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.295664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.065902Z","caller":"traceutil/trace.go:171","msg":"trace[248832759] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:621; }","duration":"118.382585ms","start":"2026-04-14T10:40:14.947482Z","end":"2026-04-14T10:40:15.065864Z","steps":["trace[248832759] 'agreement among raft nodes before linearized reading' (duration: 118.281953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.066328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.131336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.066404Z","caller":"traceutil/trace.go:171","msg":"trace[1544340474] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:621; }","duration":"119.227257ms","start":"2026-04-14T10:40:14.947145Z","end":"2026-04-14T10:40:15.066373Z","steps":["trace[1544340474] 'agreement among raft nodes before linearized reading' (duration: 119.095916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.066552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.480691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.066601Z","caller":"traceutil/trace.go:171","msg":"trace[1340146013] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:621; }","duration":"119.540631ms","start":"2026-04-14T10:40:14.947032Z","end":"2026-04-14T10:40:15.066572Z","steps":["trace[1340146013] 'agreement among raft nodes before linearized reading' (duration: 119.48627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.06661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.77419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.066659Z","caller":"traceutil/trace.go:171","msg":"trace[1482838363] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:621; }","duration":"143.874521ms","start":"2026-04-14T10:40:14.922765Z","end":"2026-04-14T10:40:15.06664Z","steps":["trace[1482838363] 'agreement among raft nodes before linearized reading' (duration: 143.79569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.457168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.627378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:40:15.457195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.710154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.457244Z","caller":"traceutil/trace.go:171","msg":"trace[1172769822] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"166.74186ms","start":"2026-04-14T10:40:15.290486Z","end":"2026-04-14T10:40:15.457228Z","steps":["trace[1172769822] 'range keys from in-memory index tree' (duration: 166.566357ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:15.457265Z","caller":"traceutil/trace.go:171","msg":"trace[568746648] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"256.802436ms","start":"2026-04-14T10:40:15.200441Z","end":"2026-04-14T10:40:15.457243Z","steps":["trace[568746648] 'range keys from in-memory index tree' (duration: 256.652844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.457429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.537185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:40:15.457512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.048874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.45754Z","caller":"traceutil/trace.go:171","msg":"trace[173560143] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"282.125444ms","start":"2026-04-14T10:40:15.175408Z","end":"2026-04-14T10:40:15.457533Z","steps":["trace[173560143] 'range keys from in-memory index tree' (duration: 281.908752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.457774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.880905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:40:15.457796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.679659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:40:15.457845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.851106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.457849Z","caller":"traceutil/trace.go:171","msg":"trace[870192380] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"257.740719ms","start":"2026-04-14T10:40:15.200099Z","end":"2026-04-14T10:40:15.457839Z","steps":["trace[870192380] 'count revisions from in-memory index tree' (duration: 257.650509ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:15.457865Z","caller":"traceutil/trace.go:171","msg":"trace[1802312818] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"167.891466ms","start":"2026-04-14T10:40:15.289969Z","end":"2026-04-14T10:40:15.457861Z","steps":["trace[1802312818] 'count revisions from in-memory index tree' (duration: 167.807204ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:15.457801Z","caller":"traceutil/trace.go:171","msg":"trace[617640240] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"167.927906ms","start":"2026-04-14T10:40:15.289867Z","end":"2026-04-14T10:40:15.457795Z","steps":["trace[617640240] 'range keys from in-memory index tree' (duration: 167.760104ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:15.457458Z","caller":"traceutil/trace.go:171","msg":"trace[968017920] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"208.632595ms","start":"2026-04-14T10:40:15.248818Z","end":"2026-04-14T10:40:15.457451Z","steps":["trace[968017920] 'count revisions from in-memory index tree' (duration: 208.426413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.457845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.377239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:40:15.457788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.056034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.458185Z","caller":"traceutil/trace.go:171","msg":"trace[1807802576] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"282.648392ms","start":"2026-04-14T10:40:15.175429Z","end":"2026-04-14T10:40:15.458078Z","steps":["trace[1807802576] 'count revisions from in-memory index tree' (duration: 282.233586ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:15.458269Z","caller":"traceutil/trace.go:171","msg":"trace[218688411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:621; }","duration":"258.49986ms","start":"2026-04-14T10:40:15.199664Z","end":"2026-04-14T10:40:15.458164Z","steps":["trace[218688411] 'range keys from in-memory index tree' (duration: 257.983093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.457822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.95056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.458346Z","caller":"traceutil/trace.go:171","msg":"trace[185064391] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"209.519127ms","start":"2026-04-14T10:40:15.248818Z","end":"2026-04-14T10:40:15.458337Z","steps":["trace[185064391] 'range keys from in-memory index tree' (duration: 208.831558ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:15.772169Z","caller":"traceutil/trace.go:171","msg":"trace[775420560] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"449.720726ms","start":"2026-04-14T10:40:15.322412Z","end":"2026-04-14T10:40:15.772132Z","steps":["trace[775420560] 'read index received' (duration: 448.506249ms)","trace[775420560] 'applied index is now lower than readState.Index' (duration: 1.213257ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:40:15.772342Z","caller":"traceutil/trace.go:171","msg":"trace[1495518127] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"465.395241ms","start":"2026-04-14T10:40:15.306891Z","end":"2026-04-14T10:40:15.772286Z","steps":["trace[1495518127] 'process raft request' (duration: 464.419528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.772992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.564782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:40:15.773146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.169577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.773209Z","caller":"traceutil/trace.go:171","msg":"trace[160755539] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"114.299439ms","start":"2026-04-14T10:40:15.658892Z","end":"2026-04-14T10:40:15.773191Z","steps":["trace[160755539] 'agreement among raft nodes before linearized reading' (duration: 114.173038ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:15.773227Z","caller":"traceutil/trace.go:171","msg":"trace[1731247834] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"253.780644ms","start":"2026-04-14T10:40:15.51938Z","end":"2026-04-14T10:40:15.773161Z","steps":["trace[1731247834] 'agreement among raft nodes before linearized reading' (duration: 253.563721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.773401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.154681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.773438Z","caller":"traceutil/trace.go:171","msg":"trace[1747134750] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"115.236803ms","start":"2026-04-14T10:40:15.658191Z","end":"2026-04-14T10:40:15.773428Z","steps":["trace[1747134750] 'agreement among raft nodes before linearized reading' (duration: 115.170472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.773381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.945566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.773623Z","caller":"traceutil/trace.go:171","msg":"trace[323020151] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"254.227951ms","start":"2026-04-14T10:40:15.519358Z","end":"2026-04-14T10:40:15.773586Z","steps":["trace[323020151] 'agreement among raft nodes before linearized reading' (duration: 253.747384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.773931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.854111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.773984Z","caller":"traceutil/trace.go:171","msg":"trace[85188184] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:622; }","duration":"450.909822ms","start":"2026-04-14T10:40:15.323059Z","end":"2026-04-14T10:40:15.773969Z","steps":["trace[85188184] 'agreement among raft nodes before linearized reading' (duration: 450.837311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.774016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:15.323039Z","time spent":"450.968732ms","remote":"127.0.0.1:57634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-14T10:40:15.774072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.376928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-14T10:40:15.774164Z","caller":"traceutil/trace.go:171","msg":"trace[707172023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"255.507489ms","start":"2026-04-14T10:40:15.518634Z","end":"2026-04-14T10:40:15.774141Z","steps":["trace[707172023] 'agreement among raft nodes before linearized reading' (duration: 255.286956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.772417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.966019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:40:15.772479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.705936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.774478Z","caller":"traceutil/trace.go:171","msg":"trace[91017866] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:622; }","duration":"451.795695ms","start":"2026-04-14T10:40:15.32267Z","end":"2026-04-14T10:40:15.774466Z","steps":["trace[91017866] 'agreement among raft nodes before linearized reading' (duration: 449.658445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.774524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:15.322655Z","time spent":"451.853396ms","remote":"127.0.0.1:57634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-14T10:40:15.772848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:15.30685Z","time spent":"465.767026ms","remote":"127.0.0.1:53296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:40:15.775211Z","caller":"traceutil/trace.go:171","msg":"trace[379891276] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:622; }","duration":"451.816875ms","start":"2026-04-14T10:40:15.322399Z","end":"2026-04-14T10:40:15.774216Z","steps":["trace[379891276] 'agreement among raft nodes before linearized reading' (duration: 449.897378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.773768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.578427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:15.776308Z","caller":"traceutil/trace.go:171","msg":"trace[1097227478] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"118.045641ms","start":"2026-04-14T10:40:15.658176Z","end":"2026-04-14T10:40:15.776221Z","steps":["trace[1097227478] 'agreement among raft nodes before linearized reading' (duration: 115.547607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:15.776269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:15.322345Z","time spent":"453.749881ms","remote":"127.0.0.1:57634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-14T10:40:17.177045Z","caller":"traceutil/trace.go:171","msg":"trace[2692553] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"386.304508ms","start":"2026-04-14T10:40:16.790721Z","end":"2026-04-14T10:40:17.177026Z","steps":["trace[2692553] 'read index received' (duration: 385.522427ms)","trace[2692553] 'applied index is now lower than readState.Index' (duration: 781.371µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:40:17.177147Z","caller":"traceutil/trace.go:171","msg":"trace[2050755661] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"920.83617ms","start":"2026-04-14T10:40:16.256282Z","end":"2026-04-14T10:40:17.177118Z","steps":["trace[2050755661] 'process raft request' (duration: 920.228531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:17.177196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.854162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T10:40:17.177241Z","caller":"traceutil/trace.go:171","msg":"trace[545368838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"385.949513ms","start":"2026-04-14T10:40:16.791279Z","end":"2026-04-14T10:40:17.177229Z","steps":["trace[545368838] 'agreement among raft nodes before linearized reading' (duration: 385.859412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:17.177277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:16.791255Z","time spent":"386.014455ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:40:17.177301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.931713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-14T10:40:17.177294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:16.25624Z","time spent":"920.975652ms","remote":"127.0.0.1:53296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:40:17.177332Z","caller":"traceutil/trace.go:171","msg":"trace[2033520996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"359.980903ms","start":"2026-04-14T10:40:16.817341Z","end":"2026-04-14T10:40:17.177322Z","steps":["trace[2033520996] 'agreement among raft nodes before linearized reading' (duration: 359.925593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:17.177358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:16.817327Z","time spent":"360.026564ms","remote":"127.0.0.1:53466","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-04-14T10:40:17.177446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.374014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:40:17.177233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.518981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-14T10:40:17.177562Z","caller":"traceutil/trace.go:171","msg":"trace[1493459881] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"386.884608ms","start":"2026-04-14T10:40:16.790665Z","end":"2026-04-14T10:40:17.17755Z","steps":["trace[1493459881] 'agreement among raft nodes before linearized reading' (duration: 386.455881ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:17.177594Z","caller":"traceutil/trace.go:171","msg":"trace[718775375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"174.580887ms","start":"2026-04-14T10:40:17.002949Z","end":"2026-04-14T10:40:17.177529Z","steps":["trace[718775375] 'agreement among raft nodes before linearized reading' (duration: 174.273592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:17.177593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:16.790636Z","time spent":"386.948579ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T10:40:17.314124Z","caller":"traceutil/trace.go:171","msg":"trace[935971985] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"130.30273ms","start":"2026-04-14T10:40:17.183762Z","end":"2026-04-14T10:40:17.314065Z","steps":["trace[935971985] 'process raft request' (duration: 48.60179ms)","trace[935971985] 'compare' (duration: 81.357485ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:40:17.314186Z","caller":"traceutil/trace.go:171","msg":"trace[1964085248] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"130.35381ms","start":"2026-04-14T10:40:17.183801Z","end":"2026-04-14T10:40:17.314155Z","steps":["trace[1964085248] 'process raft request' (duration: 130.057766ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:17.314378Z","caller":"traceutil/trace.go:171","msg":"trace[1393397021] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"130.36545ms","start":"2026-04-14T10:40:17.183996Z","end":"2026-04-14T10:40:17.314361Z","steps":["trace[1393397021] 'process raft request' (duration: 129.915264ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:23.47581Z","caller":"traceutil/trace.go:171","msg":"trace[612810504] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"132.306642ms","start":"2026-04-14T10:40:23.343477Z","end":"2026-04-14T10:40:23.475784Z","steps":["trace[612810504] 'process raft request' (duration: 132.142109ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:23.478074Z","caller":"traceutil/trace.go:171","msg":"trace[745807717] linearizableReadLoop","detail":"{readStateIndex:742; appliedIndex:740; }","duration":"129.289339ms","start":"2026-04-14T10:40:23.348749Z","end":"2026-04-14T10:40:23.478039Z","steps":["trace[745807717] 'read index received' (duration: 127.399195ms)","trace[745807717] 'applied index is now lower than readState.Index' (duration: 1.888183ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:40:23.47822Z","caller":"traceutil/trace.go:171","msg":"trace[261819726] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"131.61941ms","start":"2026-04-14T10:40:23.346562Z","end":"2026-04-14T10:40:23.478182Z","steps":["trace[261819726] 'process raft request' (duration: 131.420717ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:23.478218Z","caller":"traceutil/trace.go:171","msg":"trace[606114415] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"131.755302ms","start":"2026-04-14T10:40:23.346393Z","end":"2026-04-14T10:40:23.478148Z","steps":["trace[606114415] 'process raft request' (duration: 131.409406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:23.479011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.229935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-04-14T10:40:23.479085Z","caller":"traceutil/trace.go:171","msg":"trace[668245097] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:720; }","duration":"130.351456ms","start":"2026-04-14T10:40:23.348713Z","end":"2026-04-14T10:40:23.479064Z","steps":["trace[668245097] 'agreement among raft nodes before linearized reading' (duration: 129.545112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:28.502791Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102395534766125,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-14T10:40:28.773549Z","caller":"traceutil/trace.go:171","msg":"trace[715675366] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:779; }","duration":"770.919918ms","start":"2026-04-14T10:40:28.002599Z","end":"2026-04-14T10:40:28.773519Z","steps":["trace[715675366] 'read index received' (duration: 770.703873ms)","trace[715675366] 'applied index is now lower than readState.Index' (duration: 214.055µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:40:28.773844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.188443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:28.773913Z","caller":"traceutil/trace.go:171","msg":"trace[1180273497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"771.348296ms","start":"2026-04-14T10:40:28.002543Z","end":"2026-04-14T10:40:28.773891Z","steps":["trace[1180273497] 'agreement among raft nodes before linearized reading' (duration: 771.146762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:28.773988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:28.002517Z","time spent":"771.437508ms","remote":"127.0.0.1:53194","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-04-14T10:40:28.774005Z","caller":"traceutil/trace.go:171","msg":"trace[519196083] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"884.168452ms","start":"2026-04-14T10:40:27.889804Z","end":"2026-04-14T10:40:28.773973Z","steps":["trace[519196083] 'process raft request' (duration: 883.502818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:28.774162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:27.889787Z","time spent":"884.294105ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:40:31.152917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.176908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T10:40:31.15305Z","caller":"traceutil/trace.go:171","msg":"trace[1404838049] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:775; }","duration":"264.414483ms","start":"2026-04-14T10:40:30.88861Z","end":"2026-04-14T10:40:31.153024Z","steps":["trace[1404838049] 'range keys from in-memory index tree' (duration: 263.912393ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:40:33.967293Z","caller":"traceutil/trace.go:171","msg":"trace[578338305] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:816; }","duration":"373.133293ms","start":"2026-04-14T10:40:33.594134Z","end":"2026-04-14T10:40:33.967268Z","steps":["trace[578338305] 'read index received' (duration: 372.975959ms)","trace[578338305] 'applied index is now lower than readState.Index' (duration: 156.504µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:40:33.967404Z","caller":"traceutil/trace.go:171","msg":"trace[639569752] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"378.188496ms","start":"2026-04-14T10:40:33.589207Z","end":"2026-04-14T10:40:33.967396Z","steps":["trace[639569752] 'process raft request' (duration: 377.93169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:33.9675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:33.589155Z","time spent":"378.275057ms","remote":"127.0.0.1:53466","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-04-14T10:40:33.967554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.992687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T10:40:33.967583Z","caller":"traceutil/trace.go:171","msg":"trace[595263769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"368.045279ms","start":"2026-04-14T10:40:33.599531Z","end":"2026-04-14T10:40:33.967576Z","steps":["trace[595263769] 'agreement among raft nodes before linearized reading' (duration: 367.946836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:33.967601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:33.599517Z","time spent":"368.080099ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:40:33.967727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.604323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-14T10:40:33.967744Z","caller":"traceutil/trace.go:171","msg":"trace[2059503179] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:792; }","duration":"373.657724ms","start":"2026-04-14T10:40:33.594082Z","end":"2026-04-14T10:40:33.967739Z","steps":["trace[2059503179] 'agreement among raft nodes before linearized reading' (duration: 373.610153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:33.967758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:33.594061Z","time spent":"373.693804ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-14T10:40:34.45447Z","caller":"traceutil/trace.go:171","msg":"trace[1401644154] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"482.390076ms","start":"2026-04-14T10:40:33.972046Z","end":"2026-04-14T10:40:34.454436Z","steps":["trace[1401644154] 'process raft request' (duration: 481.003174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:34.454677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:33.972028Z","time spent":"482.54908ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:40:34.464502Z","caller":"traceutil/trace.go:171","msg":"trace[1306180706] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:817; }","duration":"458.987168ms","start":"2026-04-14T10:40:34.005483Z","end":"2026-04-14T10:40:34.46447Z","steps":["trace[1306180706] 'read index received' (duration: 447.68995ms)","trace[1306180706] 'applied index is now lower than readState.Index' (duration: 11.294288ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:40:34.464541Z","caller":"traceutil/trace.go:171","msg":"trace[976893865] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"441.608123ms","start":"2026-04-14T10:40:34.022916Z","end":"2026-04-14T10:40:34.464525Z","steps":["trace[976893865] 'process raft request' (duration: 441.282865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:34.464652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.149111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:40:34.464799Z","caller":"traceutil/trace.go:171","msg":"trace[1708054813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:795; }","duration":"459.255934ms","start":"2026-04-14T10:40:34.005432Z","end":"2026-04-14T10:40:34.464688Z","steps":["trace[1708054813] 'agreement among raft nodes before linearized reading' (duration: 459.153032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:34.465023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:34.005415Z","time spent":"459.589771ms","remote":"127.0.0.1:53194","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-04-14T10:40:34.4651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:34.022881Z","time spent":"441.738415ms","remote":"127.0.0.1:53452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:40:34.464385Z","caller":"traceutil/trace.go:171","msg":"trace[1865077712] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"491.255659ms","start":"2026-04-14T10:40:33.973078Z","end":"2026-04-14T10:40:34.464333Z","steps":["trace[1865077712] 'process raft request' (duration: 490.87158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:40:34.465527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:40:33.973071Z","time spent":"492.364515ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-14T10:41:02.89803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.498198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:41:02.898134Z","caller":"traceutil/trace.go:171","msg":"trace[66365238] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1012; }","duration":"684.658774ms","start":"2026-04-14T10:41:02.213458Z","end":"2026-04-14T10:41:02.898117Z","steps":["trace[66365238] 'count revisions from in-memory index tree' (duration: 684.354754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:02.89817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:41:02.213439Z","time spent":"684.721455ms","remote":"127.0.0.1:53504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-04-14T10:41:02.898967Z","caller":"traceutil/trace.go:171","msg":"trace[1641414360] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"635.905676ms","start":"2026-04-14T10:41:02.262982Z","end":"2026-04-14T10:41:02.898888Z","steps":["trace[1641414360] 'process raft request' (duration: 634.214612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:02.899175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:41:02.262912Z","time spent":"636.153434ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:41:16.21702Z","caller":"traceutil/trace.go:171","msg":"trace[1230160807] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1095; }","duration":"311.502225ms","start":"2026-04-14T10:41:15.905485Z","end":"2026-04-14T10:41:16.216987Z","steps":["trace[1230160807] 'read index received' (duration: 311.320429ms)","trace[1230160807] 'applied index is now lower than readState.Index' (duration: 180.686µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:41:16.217141Z","caller":"traceutil/trace.go:171","msg":"trace[270026748] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"312.77568ms","start":"2026-04-14T10:41:15.904326Z","end":"2026-04-14T10:41:16.217102Z","steps":["trace[270026748] 'process raft request' (duration: 312.457129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:16.217222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.124289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:41:16.217268Z","caller":"traceutil/trace.go:171","msg":"trace[205871100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1061; }","duration":"213.224512ms","start":"2026-04-14T10:41:16.004027Z","end":"2026-04-14T10:41:16.217252Z","steps":["trace[205871100] 'agreement among raft nodes before linearized reading' (duration: 213.130969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:16.217299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.783585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-14T10:41:16.21733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:41:15.904309Z","time spent":"312.922736ms","remote":"127.0.0.1:53466","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-04-14T10:41:16.217385Z","caller":"traceutil/trace.go:171","msg":"trace[324533318] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1061; }","duration":"311.910089ms","start":"2026-04-14T10:41:15.905456Z","end":"2026-04-14T10:41:16.217366Z","steps":["trace[324533318] 'agreement among raft nodes before linearized reading' (duration: 311.689932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:16.217425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:41:15.90544Z","time spent":"311.977531ms","remote":"127.0.0.1:53466","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":"info","ts":"2026-04-14T10:41:17.086009Z","caller":"traceutil/trace.go:171","msg":"trace[654645408] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"106.670816ms","start":"2026-04-14T10:41:16.979305Z","end":"2026-04-14T10:41:17.085976Z","steps":["trace[654645408] 'process raft request' (duration: 74.64109ms)","trace[654645408] 'compare' (duration: 31.777767ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:41:39.61593Z","caller":"traceutil/trace.go:171","msg":"trace[1958717352] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"181.785042ms","start":"2026-04-14T10:41:39.434013Z","end":"2026-04-14T10:41:39.615798Z","steps":["trace[1958717352] 'process raft request' (duration: 98.244859ms)","trace[1958717352] 'compare' (duration: 83.398627ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:41:40.486566Z","caller":"traceutil/trace.go:171","msg":"trace[1233652859] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"104.707379ms","start":"2026-04-14T10:41:40.381816Z","end":"2026-04-14T10:41:40.486524Z","steps":["trace[1233652859] 'process raft request' (duration: 104.422597ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:41:42.606512Z","caller":"traceutil/trace.go:171","msg":"trace[1469331691] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"114.438865ms","start":"2026-04-14T10:41:42.49204Z","end":"2026-04-14T10:41:42.606479Z","steps":["trace[1469331691] 'process raft request' (duration: 113.985287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:42.767431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.924769ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:41:42.767644Z","caller":"traceutil/trace.go:171","msg":"trace[1654007353] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"156.323449ms","start":"2026-04-14T10:41:42.611301Z","end":"2026-04-14T10:41:42.767624Z","steps":["trace[1654007353] 'process raft request' (duration: 156.261157ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:41:42.767735Z","caller":"traceutil/trace.go:171","msg":"trace[527262181] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"156.393502ms","start":"2026-04-14T10:41:42.611271Z","end":"2026-04-14T10:41:42.767665Z","steps":["trace[527262181] 'process raft request' (duration: 55.11716ms)","trace[527262181] 'compare' (duration: 100.756081ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:41:43.873516Z","caller":"traceutil/trace.go:171","msg":"trace[904218358] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"174.846707ms","start":"2026-04-14T10:41:43.698619Z","end":"2026-04-14T10:41:43.873466Z","steps":["trace[904218358] 'process raft request' (duration: 153.881312ms)","trace[904218358] 'compare' (duration: 20.759107ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:41:45.066709Z","caller":"traceutil/trace.go:171","msg":"trace[1237051418] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"287.36779ms","start":"2026-04-14T10:41:44.779296Z","end":"2026-04-14T10:41:45.066664Z","steps":["trace[1237051418] 'process raft request' (duration: 190.940327ms)","trace[1237051418] 'compare' (duration: 96.023427ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:41:47.683174Z","caller":"traceutil/trace.go:171","msg":"trace[1321376296] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"116.740805ms","start":"2026-04-14T10:41:47.56638Z","end":"2026-04-14T10:41:47.683121Z","steps":["trace[1321376296] 'process raft request' (duration: 101.250909ms)","trace[1321376296] 'compare' (duration: 15.07448ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:41:51.770711Z","caller":"traceutil/trace.go:171","msg":"trace[862373065] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"186.37406ms","start":"2026-04-14T10:41:51.584303Z","end":"2026-04-14T10:41:51.770677Z","steps":["trace[862373065] 'process raft request' (duration: 185.464263ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:41:52.954993Z","caller":"traceutil/trace.go:171","msg":"trace[15259965] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"266.0797ms","start":"2026-04-14T10:41:52.688876Z","end":"2026-04-14T10:41:52.954955Z","steps":["trace[15259965] 'process raft request' (duration: 265.559559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:53.284609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.906702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-14T10:41:53.284697Z","caller":"traceutil/trace.go:171","msg":"trace[1199434091] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1181; }","duration":"166.042408ms","start":"2026-04-14T10:41:53.118635Z","end":"2026-04-14T10:41:53.284678Z","steps":["trace[1199434091] 'range keys from in-memory index tree' (duration: 165.713155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:54.490536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.84003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5547"} {"level":"info","ts":"2026-04-14T10:41:54.490679Z","caller":"traceutil/trace.go:171","msg":"trace[1304540534] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1185; }","duration":"552.995396ms","start":"2026-04-14T10:41:53.937639Z","end":"2026-04-14T10:41:54.490635Z","steps":["trace[1304540534] 'range keys from in-memory index tree' (duration: 552.658503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:54.490736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:41:53.937617Z","time spent":"553.105301ms","remote":"127.0.0.1:53388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5570,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-14T10:41:54.490767Z","caller":"traceutil/trace.go:171","msg":"trace[717568705] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"469.890118ms","start":"2026-04-14T10:41:54.020861Z","end":"2026-04-14T10:41:54.490751Z","steps":["trace[717568705] 'process raft request' (duration: 465.192334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:41:54.490869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:41:54.020833Z","time spent":"469.973181ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:42:06.110964Z","caller":"traceutil/trace.go:171","msg":"trace[505314425] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1268; }","duration":"128.536571ms","start":"2026-04-14T10:42:05.982365Z","end":"2026-04-14T10:42:06.110902Z","steps":["trace[505314425] 'read index received' (duration: 51.531948ms)","trace[505314425] 'applied index is now lower than readState.Index' (duration: 77.003643ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:42:06.11104Z","caller":"traceutil/trace.go:171","msg":"trace[735005428] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"134.473333ms","start":"2026-04-14T10:42:05.976514Z","end":"2026-04-14T10:42:06.110987Z","steps":["trace[735005428] 'process raft request' (duration: 134.335987ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:42:06.111039Z","caller":"traceutil/trace.go:171","msg":"trace[868425045] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"134.741734ms","start":"2026-04-14T10:42:05.976235Z","end":"2026-04-14T10:42:06.110977Z","steps":["trace[868425045] 'process raft request' (duration: 57.645747ms)","trace[868425045] 'compare' (duration: 76.818095ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:42:06.111398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.033924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:42:06.111458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.057272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329960"} {"level":"info","ts":"2026-04-14T10:42:06.111516Z","caller":"traceutil/trace.go:171","msg":"trace[493257558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1225; }","duration":"109.18354ms","start":"2026-04-14T10:42:06.00231Z","end":"2026-04-14T10:42:06.111494Z","steps":["trace[493257558] 'agreement among raft nodes before linearized reading' (duration: 108.985712ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:42:06.111532Z","caller":"traceutil/trace.go:171","msg":"trace[1215042583] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1225; }","duration":"129.180538ms","start":"2026-04-14T10:42:05.98233Z","end":"2026-04-14T10:42:06.111511Z","steps":["trace[1215042583] 'agreement among raft nodes before linearized reading' (duration: 128.798421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:42:06.435458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.569107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329960"} {"level":"info","ts":"2026-04-14T10:42:06.435604Z","caller":"traceutil/trace.go:171","msg":"trace[1815866098] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1225; }","duration":"217.755495ms","start":"2026-04-14T10:42:06.217787Z","end":"2026-04-14T10:42:06.435543Z","steps":["trace[1815866098] 'range keys from in-memory index tree' (duration: 216.804514ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:42:07.259054Z","caller":"traceutil/trace.go:171","msg":"trace[1188404964] linearizableReadLoop","detail":"{readStateIndex:1271; appliedIndex:1270; }","duration":"192.022109ms","start":"2026-04-14T10:42:07.067008Z","end":"2026-04-14T10:42:07.25903Z","steps":["trace[1188404964] 'read index received' (duration: 191.688895ms)","trace[1188404964] 'applied index is now lower than readState.Index' (duration: 332.254µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:42:07.259136Z","caller":"traceutil/trace.go:171","msg":"trace[442251034] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"199.284278ms","start":"2026-04-14T10:42:07.059806Z","end":"2026-04-14T10:42:07.25909Z","steps":["trace[442251034] 'process raft request' (duration: 198.959275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:42:07.259367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.319621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-14T10:42:07.259502Z","caller":"traceutil/trace.go:171","msg":"trace[227834950] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1226; }","duration":"192.487799ms","start":"2026-04-14T10:42:07.066968Z","end":"2026-04-14T10:42:07.259456Z","steps":["trace[227834950] 'agreement among raft nodes before linearized reading' (duration: 192.171156ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:42:07.399656Z","caller":"traceutil/trace.go:171","msg":"trace[1475861524] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"135.604285ms","start":"2026-04-14T10:42:07.264014Z","end":"2026-04-14T10:42:07.399618Z","steps":["trace[1475861524] 'process raft request' (duration: 133.812108ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:42:14.362794Z","caller":"traceutil/trace.go:171","msg":"trace[714579895] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"145.138103ms","start":"2026-04-14T10:42:14.217623Z","end":"2026-04-14T10:42:14.362761Z","steps":["trace[714579895] 'process raft request' (duration: 133.28047ms)","trace[714579895] 'compare' (duration: 11.704186ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:43:14.426081Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102395534768962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:43:15.079484Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102395534768962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:43:15.58033Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102395534768962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-14T10:43:15.808452Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.967637708s","expected-duration":"1s"} {"level":"info","ts":"2026-04-14T10:43:15.808947Z","caller":"traceutil/trace.go:171","msg":"trace[260987798] transaction","detail":"{read_only:false; response_revision:1489; number_of_response:1; }","duration":"1.968262297s","start":"2026-04-14T10:43:13.840656Z","end":"2026-04-14T10:43:15.808918Z","steps":["trace[260987798] 'process raft request' (duration: 1.968017726s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:15.809137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:13.84061Z","time spent":"1.968421844s","remote":"127.0.0.1:53466","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-04-14T10:43:15.817613Z","caller":"traceutil/trace.go:171","msg":"trace[1498558981] linearizableReadLoop","detail":"{readStateIndex:1550; appliedIndex:1548; }","duration":"1.892483849s","start":"2026-04-14T10:43:13.925096Z","end":"2026-04-14T10:43:15.81758Z","steps":["trace[1498558981] 'read index received' (duration: 1.883650028s)","trace[1498558981] 'applied index is now lower than readState.Index' (duration: 8.832731ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:43:15.817647Z","caller":"traceutil/trace.go:171","msg":"trace[1493388413] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"119.687916ms","start":"2026-04-14T10:43:15.697927Z","end":"2026-04-14T10:43:15.817615Z","steps":["trace[1493388413] 'process raft request' (duration: 119.514238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:15.81786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.892751001s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-14T10:43:15.817903Z","caller":"traceutil/trace.go:171","msg":"trace[1760976783] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1490; }","duration":"1.892855657s","start":"2026-04-14T10:43:13.925028Z","end":"2026-04-14T10:43:15.817884Z","steps":["trace[1760976783] 'agreement among raft nodes before linearized reading' (duration: 1.892705469s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:15.817933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.213134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-14T10:43:15.817945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:13.924999Z","time spent":"1.89293965s","remote":"127.0.0.1:53466","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":"info","ts":"2026-04-14T10:43:15.817974Z","caller":"traceutil/trace.go:171","msg":"trace[1850230090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1490; }","duration":"729.311758ms","start":"2026-04-14T10:43:15.08865Z","end":"2026-04-14T10:43:15.817962Z","steps":["trace[1850230090] 'agreement among raft nodes before linearized reading' (duration: 729.159371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:15.817998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.76589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:43:15.818004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:15.088606Z","time spent":"729.390652ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-14T10:43:15.818033Z","caller":"traceutil/trace.go:171","msg":"trace[1586289100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1490; }","duration":"726.822852ms","start":"2026-04-14T10:43:15.091201Z","end":"2026-04-14T10:43:15.818024Z","steps":["trace[1586289100] 'agreement among raft nodes before linearized reading' (duration: 726.76562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:15.818058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:15.091189Z","time spent":"726.864345ms","remote":"127.0.0.1:53194","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-04-14T10:43:15.818016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.612978069s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:43:15.818175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.573847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:43:15.818207Z","caller":"traceutil/trace.go:171","msg":"trace[1956574743] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1490; }","duration":"730.639959ms","start":"2026-04-14T10:43:15.087557Z","end":"2026-04-14T10:43:15.818197Z","steps":["trace[1956574743] 'agreement among raft nodes before linearized reading' (duration: 730.593767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:15.818196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.009978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-14T10:43:15.818278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.215600206s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-14T10:43:15.81829Z","caller":"traceutil/trace.go:171","msg":"trace[797847569] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1490; }","duration":"308.25793ms","start":"2026-04-14T10:43:15.510014Z","end":"2026-04-14T10:43:15.818271Z","steps":["trace[797847569] 'agreement among raft nodes before linearized reading' (duration: 307.921434ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:43:15.818308Z","caller":"traceutil/trace.go:171","msg":"trace[1592679798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1490; }","duration":"1.215662119s","start":"2026-04-14T10:43:14.60264Z","end":"2026-04-14T10:43:15.818302Z","steps":["trace[1592679798] 'agreement among raft nodes before linearized reading' (duration: 1.215592566s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:15.818332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:14.602621Z","time spent":"1.215706501s","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-14T10:43:15.818234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:15.086992Z","time spent":"731.236417ms","remote":"127.0.0.1:53462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-04-14T10:43:15.818246Z","caller":"traceutil/trace.go:171","msg":"trace[1066590407] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1490; }","duration":"1.613292943s","start":"2026-04-14T10:43:14.204884Z","end":"2026-04-14T10:43:15.818177Z","steps":["trace[1066590407] 'agreement among raft nodes before linearized reading' (duration: 1.612923646s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:15.818134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176415654s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-14T10:43:15.818449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:14.204862Z","time spent":"1.613571436s","remote":"127.0.0.1:57502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-14T10:43:15.818348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:15.509993Z","time spent":"308.343213ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-04-14T10:43:15.818429Z","caller":"traceutil/trace.go:171","msg":"trace[1159564616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1490; }","duration":"1.176715478s","start":"2026-04-14T10:43:14.641698Z","end":"2026-04-14T10:43:15.818414Z","steps":["trace[1159564616] 'agreement among raft nodes before linearized reading' (duration: 1.176369122s)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:15.818652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:14.641691Z","time spent":"1.176953079s","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-14T10:43:16.754345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.818373ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:43:16.754491Z","caller":"traceutil/trace.go:171","msg":"trace[110773717] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1494; }","duration":"138.9741ms","start":"2026-04-14T10:43:16.615492Z","end":"2026-04-14T10:43:16.754466Z","steps":["trace[110773717] 'range keys from in-memory index tree' (duration: 138.798722ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:43:16.754871Z","caller":"traceutil/trace.go:171","msg":"trace[1698395612] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"615.24742ms","start":"2026-04-14T10:43:16.139592Z","end":"2026-04-14T10:43:16.75484Z","steps":["trace[1698395612] 'process raft request' (duration: 610.776132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:43:16.75518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:43:16.13956Z","time spent":"615.411548ms","remote":"127.0.0.1:53466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}