{"level":"warn","ts":"2026-05-28T21:38:15.92661Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T21:38:15.926691Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65: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-05-28T21:38:15.92675Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T21:38:15.926761Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-05-28T21:38:15.92678Z","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-05-28T21:38:15.927476Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-05-28T21:38:15.927554Z","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.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65: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-05-28T21:38:15.941105Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"11.619332ms"} {"level":"info","ts":"2026-05-28T21:38:15.958392Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-05-28T21:38:15.958508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-05-28T21:38:15.958537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-05-28T21:38:15.958572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-28T21:38:15.958595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-05-28T21:38:15.95868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-05-28T21:38:15.970303Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-28T21:38:15.972368Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-28T21:38:15.973381Z","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-05-28T21:38:15.97577Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-28T21:38:15.981289Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-28T21:38:15.981543Z","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-05-28T21:38:15.981624Z","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-05-28T21:38:15.981638Z","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-05-28T21:38:15.983502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-05-28T21:38:15.983786Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-05-28T21:38:15.984131Z","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-05-28T21:38:15.984363Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-28T21:38:15.984409Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-28T21:38:15.984461Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-05-28T21:38:15.984493Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-05-28T21:38:16.758888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-05-28T21:38:16.758964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-28T21:38:16.759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-05-28T21:38:16.759019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-05-28T21:38:16.75903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-05-28T21:38:16.759096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-05-28T21:38:16.759116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-05-28T21:38:16.760279Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:38:16.761263Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T21:38:16.761255Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-05-28T21:38:16.761443Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T21:38:16.761745Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-28T21:38:16.761771Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-28T21:38:16.76381Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"info","ts":"2026-05-28T21:38:16.764105Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:38:16.764223Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:38:16.764269Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:38:16.766037Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-28T21:38:19.823308Z","caller":"traceutil/trace.go:171","msg":"trace[1856390503] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"106.254548ms","start":"2026-05-28T21:38:19.716996Z","end":"2026-05-28T21:38:19.82325Z","steps":["trace[1856390503] 'process raft request' (duration: 45.044839ms)","trace[1856390503] 'compare' (duration: 61.01934ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:38:40.932764Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620626842863606263,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-28T21:38:41.229855Z","caller":"traceutil/trace.go:171","msg":"trace[1704149085] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"797.318123ms","start":"2026-05-28T21:38:40.432509Z","end":"2026-05-28T21:38:41.229827Z","steps":["trace[1704149085] 'read index received' (duration: 797.004376ms)","trace[1704149085] 'applied index is now lower than readState.Index' (duration: 312.247µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:38:41.229956Z","caller":"traceutil/trace.go:171","msg":"trace[572657293] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"852.193768ms","start":"2026-05-28T21:38:40.377715Z","end":"2026-05-28T21:38:41.229909Z","steps":["trace[572657293] 'process raft request' (duration: 851.891611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:41.230032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.499428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-28T21:38:41.230113Z","caller":"traceutil/trace.go:171","msg":"trace[1042519727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:464; }","duration":"797.641651ms","start":"2026-05-28T21:38:40.432459Z","end":"2026-05-28T21:38:41.2301Z","steps":["trace[1042519727] 'agreement among raft nodes before linearized reading' (duration: 797.497237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:41.230156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:40.432437Z","time spent":"797.706103ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-28T21:38:41.230575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:40.377702Z","time spent":"852.325042ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:41.419141Z","caller":"traceutil/trace.go:171","msg":"trace[1327478297] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"183.354087ms","start":"2026-05-28T21:38:41.235758Z","end":"2026-05-28T21:38:41.419112Z","steps":["trace[1327478297] 'process raft request' (duration: 182.025126ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:49.30266Z","caller":"traceutil/trace.go:171","msg":"trace[1550459975] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"294.764957ms","start":"2026-05-28T21:38:49.0078Z","end":"2026-05-28T21:38:49.302565Z","steps":["trace[1550459975] 'process raft request' (duration: 294.594422ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:51.402765Z","caller":"traceutil/trace.go:171","msg":"trace[1588406454] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"202.758587ms","start":"2026-05-28T21:38:51.199971Z","end":"2026-05-28T21:38:51.40273Z","steps":["trace[1588406454] 'process raft request' (duration: 202.333696ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:51.40312Z","caller":"traceutil/trace.go:171","msg":"trace[561577351] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"201.120045ms","start":"2026-05-28T21:38:51.201958Z","end":"2026-05-28T21:38:51.403078Z","steps":["trace[561577351] 'process raft request' (duration: 200.698035ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:51.409701Z","caller":"traceutil/trace.go:171","msg":"trace[1975542470] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"205.922339ms","start":"2026-05-28T21:38:51.203758Z","end":"2026-05-28T21:38:51.40968Z","steps":["trace[1975542470] 'process raft request' (duration: 205.626632ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:51.410345Z","caller":"traceutil/trace.go:171","msg":"trace[79558028] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:533; }","duration":"183.83501ms","start":"2026-05-28T21:38:51.226482Z","end":"2026-05-28T21:38:51.410317Z","steps":["trace[79558028] 'read index received' (duration: 175.912286ms)","trace[79558028] 'applied index is now lower than readState.Index' (duration: 7.921464ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:38:51.411121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.61432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:51.411168Z","caller":"traceutil/trace.go:171","msg":"trace[317670072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"184.733302ms","start":"2026-05-28T21:38:51.22642Z","end":"2026-05-28T21:38:51.411153Z","steps":["trace[317670072] 'agreement among raft nodes before linearized reading' (duration: 184.622679ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:51.411435Z","caller":"traceutil/trace.go:171","msg":"trace[1655050784] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"178.81318ms","start":"2026-05-28T21:38:51.232613Z","end":"2026-05-28T21:38:51.411426Z","steps":["trace[1655050784] 'process raft request' (duration: 177.105626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:51.411802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.979123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-28T21:38:51.411875Z","caller":"traceutil/trace.go:171","msg":"trace[1846962261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"101.182178ms","start":"2026-05-28T21:38:51.310673Z","end":"2026-05-28T21:38:51.411855Z","steps":["trace[1846962261] 'agreement among raft nodes before linearized reading' (duration: 100.974993ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:53.602194Z","caller":"traceutil/trace.go:171","msg":"trace[911302293] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"601.56265ms","start":"2026-05-28T21:38:53.000609Z","end":"2026-05-28T21:38:53.602172Z","steps":["trace[911302293] 'process raft request' (duration: 601.439697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:53.602337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.000591Z","time spent":"601.680914ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T21:38:53.610171Z","caller":"traceutil/trace.go:171","msg":"trace[616625490] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"603.595385ms","start":"2026-05-28T21:38:53.006539Z","end":"2026-05-28T21:38:53.610135Z","steps":["trace[616625490] 'process raft request' (duration: 603.40695ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:53.610333Z","caller":"traceutil/trace.go:171","msg":"trace[1700093448] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"583.356373ms","start":"2026-05-28T21:38:53.026941Z","end":"2026-05-28T21:38:53.610297Z","steps":["trace[1700093448] 'process raft request' (duration: 583.165748ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:53.610405Z","caller":"traceutil/trace.go:171","msg":"trace[1866049308] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:546; }","duration":"380.858694ms","start":"2026-05-28T21:38:53.22953Z","end":"2026-05-28T21:38:53.610388Z","steps":["trace[1866049308] 'read index received' (duration: 372.525874ms)","trace[1866049308] 'applied index is now lower than readState.Index' (duration: 8.33191ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:38:53.610479Z","caller":"traceutil/trace.go:171","msg":"trace[119873203] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"582.800308ms","start":"2026-05-28T21:38:53.027673Z","end":"2026-05-28T21:38:53.610473Z","steps":["trace[119873203] 'process raft request' (duration: 582.471349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:53.610486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.02693Z","time spent":"583.488757ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:53.610505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.006522Z","time spent":"603.800071ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:53.610548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.027661Z","time spent":"582.84118ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T21:38:53.610612Z","caller":"traceutil/trace.go:171","msg":"trace[1521444674] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"602.951378ms","start":"2026-05-28T21:38:53.007648Z","end":"2026-05-28T21:38:53.610599Z","steps":["trace[1521444674] 'process raft request' (duration: 602.376293ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:53.610636Z","caller":"traceutil/trace.go:171","msg":"trace[1633526626] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"578.120905ms","start":"2026-05-28T21:38:53.032509Z","end":"2026-05-28T21:38:53.61063Z","steps":["trace[1633526626] 'process raft request' (duration: 577.684704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:53.610669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.032494Z","time spent":"578.158946ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T21:38:53.610679Z","caller":"traceutil/trace.go:171","msg":"trace[354390404] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"540.099815ms","start":"2026-05-28T21:38:53.07056Z","end":"2026-05-28T21:38:53.61066Z","steps":["trace[354390404] 'process raft request' (duration: 539.740406ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:53.610702Z","caller":"traceutil/trace.go:171","msg":"trace[382626123] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"597.374712ms","start":"2026-05-28T21:38:53.013318Z","end":"2026-05-28T21:38:53.610693Z","steps":["trace[382626123] 'process raft request' (duration: 596.734135ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:53.610739Z","caller":"traceutil/trace.go:171","msg":"trace[745671317] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"436.768555ms","start":"2026-05-28T21:38:53.173965Z","end":"2026-05-28T21:38:53.610734Z","steps":["trace[745671317] 'process raft request' (duration: 436.382975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:53.61075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.013288Z","time spent":"597.443904ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T21:38:53.610766Z","caller":"traceutil/trace.go:171","msg":"trace[1451880771] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"557.240426ms","start":"2026-05-28T21:38:53.053518Z","end":"2026-05-28T21:38:53.610758Z","steps":["trace[1451880771] 'process raft request' (duration: 556.706702ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:53.610776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.173935Z","time spent":"436.827907ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:53.610806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.053501Z","time spent":"557.287277ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T21:38:53.610836Z","caller":"traceutil/trace.go:171","msg":"trace[281749581] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"584.40565ms","start":"2026-05-28T21:38:53.026423Z","end":"2026-05-28T21:38:53.610828Z","steps":["trace[281749581] 'process raft request' (duration: 583.654781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:53.610863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.331106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:53.610891Z","caller":"traceutil/trace.go:171","msg":"trace[1762912304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"381.393568ms","start":"2026-05-28T21:38:53.229491Z","end":"2026-05-28T21:38:53.610885Z","steps":["trace[1762912304] 'agreement among raft nodes before linearized reading' (duration: 381.333196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:53.610887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.0264Z","time spent":"584.466482ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T21:38:53.610889Z","caller":"traceutil/trace.go:171","msg":"trace[262181773] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"549.965535ms","start":"2026-05-28T21:38:53.060912Z","end":"2026-05-28T21:38:53.610878Z","steps":["trace[262181773] 'process raft request' (duration: 549.352189ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:53.610915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.229474Z","time spent":"381.43724ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-28T21:38:53.610664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.007642Z","time spent":"603.00116ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:53.610948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.060885Z","time spent":"550.039136ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:53.610731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.070538Z","time spent":"540.170736ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:53.613407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.002917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-28T21:38:53.613494Z","caller":"traceutil/trace.go:171","msg":"trace[498174277] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:538; }","duration":"131.118191ms","start":"2026-05-28T21:38:53.482353Z","end":"2026-05-28T21:38:53.613471Z","steps":["trace[498174277] 'agreement among raft nodes before linearized reading' (duration: 130.951336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:53.613708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.089192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-28T21:38:53.613734Z","caller":"traceutil/trace.go:171","msg":"trace[1398110919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:538; }","duration":"193.152103ms","start":"2026-05-28T21:38:53.420575Z","end":"2026-05-28T21:38:53.613728Z","steps":["trace[1398110919] 'agreement among raft nodes before linearized reading' (duration: 193.03854ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:54.21024Z","caller":"traceutil/trace.go:171","msg":"trace[1390551639] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"510.009517ms","start":"2026-05-28T21:38:53.700196Z","end":"2026-05-28T21:38:54.210206Z","steps":["trace[1390551639] 'process raft request' (duration: 478.563841ms)","trace[1390551639] 'compare' (duration: 30.642614ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:38:54.210295Z","caller":"traceutil/trace.go:171","msg":"trace[1185209564] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"506.046342ms","start":"2026-05-28T21:38:53.704226Z","end":"2026-05-28T21:38:54.210272Z","steps":["trace[1185209564] 'process raft request' (duration: 505.918709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:54.210389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.70018Z","time spent":"510.129779ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:38:54.210424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.704222Z","time spent":"506.130294ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:54.210511Z","caller":"traceutil/trace.go:171","msg":"trace[1069920636] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"506.3582ms","start":"2026-05-28T21:38:53.704144Z","end":"2026-05-28T21:38:54.210502Z","steps":["trace[1069920636] 'process raft request' (duration: 505.826546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:54.210555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.704127Z","time spent":"506.405781ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:54.210797Z","caller":"traceutil/trace.go:171","msg":"trace[2135959913] transaction","detail":"{read_only:false; number_of_response:1; response_revision:555; }","duration":"504.921702ms","start":"2026-05-28T21:38:53.705837Z","end":"2026-05-28T21:38:54.210759Z","steps":["trace[2135959913] 'process raft request' (duration: 504.399028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:54.210999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.705822Z","time spent":"505.068917ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7734,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:54.211075Z","caller":"traceutil/trace.go:171","msg":"trace[1154177860] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:576; }","duration":"331.352984ms","start":"2026-05-28T21:38:53.879702Z","end":"2026-05-28T21:38:54.211055Z","steps":["trace[1154177860] 'read index received' (duration: 299.054596ms)","trace[1154177860] 'applied index is now lower than readState.Index' (duration: 32.297398ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:38:54.21119Z","caller":"traceutil/trace.go:171","msg":"trace[1904849884] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"499.072998ms","start":"2026-05-28T21:38:53.712106Z","end":"2026-05-28T21:38:54.211179Z","steps":["trace[1904849884] 'process raft request' (duration: 498.444682ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:54.211232Z","caller":"traceutil/trace.go:171","msg":"trace[175413884] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"496.948123ms","start":"2026-05-28T21:38:53.714276Z","end":"2026-05-28T21:38:54.211224Z","steps":["trace[175413884] 'process raft request' (duration: 496.527361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:54.211282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.714258Z","time spent":"497.000675ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:54.211203Z","caller":"traceutil/trace.go:171","msg":"trace[1493241748] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"434.761156ms","start":"2026-05-28T21:38:53.776433Z","end":"2026-05-28T21:38:54.211195Z","steps":["trace[1493241748] 'process raft request' (duration: 434.562601ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:54.211341Z","caller":"traceutil/trace.go:171","msg":"trace[1581168344] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"464.781327ms","start":"2026-05-28T21:38:53.746554Z","end":"2026-05-28T21:38:54.211335Z","steps":["trace[1581168344] 'process raft request' (duration: 464.329115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:54.211379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.74653Z","time spent":"464.830577ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:38:54.211274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.712094Z","time spent":"499.136721ms","remote":"127.0.0.1:54704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:54.211333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.776411Z","time spent":"434.90082ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:54.211406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.699033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-28T21:38:54.211571Z","caller":"traceutil/trace.go:171","msg":"trace[1202155145] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:559; }","duration":"331.896809ms","start":"2026-05-28T21:38:53.879666Z","end":"2026-05-28T21:38:54.211563Z","steps":["trace[1202155145] 'agreement among raft nodes before linearized reading' (duration: 331.696243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:54.211601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:53.879615Z","time spent":"331.979041ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-28T21:38:57.287824Z","caller":"traceutil/trace.go:171","msg":"trace[1207768824] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"101.411562ms","start":"2026-05-28T21:38:57.186394Z","end":"2026-05-28T21:38:57.287806Z","steps":["trace[1207768824] 'read index received' (duration: 100.933359ms)","trace[1207768824] 'applied index is now lower than readState.Index' (duration: 477.403µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:38:57.288555Z","caller":"traceutil/trace.go:171","msg":"trace[1579146086] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"131.876585ms","start":"2026-05-28T21:38:57.156669Z","end":"2026-05-28T21:38:57.288545Z","steps":["trace[1579146086] 'process raft request' (duration: 130.894498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.288795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.382109ms","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-05-28T21:38:57.288827Z","caller":"traceutil/trace.go:171","msg":"trace[1804073773] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:612; }","duration":"102.463401ms","start":"2026-05-28T21:38:57.186356Z","end":"2026-05-28T21:38:57.288819Z","steps":["trace[1804073773] 'agreement among raft nodes before linearized reading' (duration: 102.380539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.289005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.571864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:57.289031Z","caller":"traceutil/trace.go:171","msg":"trace[1593780654] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:612; }","duration":"102.628766ms","start":"2026-05-28T21:38:57.186396Z","end":"2026-05-28T21:38:57.289025Z","steps":["trace[1593780654] 'agreement among raft nodes before linearized reading' (duration: 102.588194ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.289643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.813661ms","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-05-28T21:38:57.289671Z","caller":"traceutil/trace.go:171","msg":"trace[974380474] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:612; }","duration":"102.863692ms","start":"2026-05-28T21:38:57.186801Z","end":"2026-05-28T21:38:57.289664Z","steps":["trace[974380474] 'agreement among raft nodes before linearized reading' (duration: 102.826281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.546365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.011817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:57.546439Z","caller":"traceutil/trace.go:171","msg":"trace[737898950] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:612; }","duration":"163.076469ms","start":"2026-05-28T21:38:57.383342Z","end":"2026-05-28T21:38:57.546419Z","steps":["trace[737898950] 'range keys from in-memory index tree' (duration: 162.946515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.546645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.736649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T21:38:57.546752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.245799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:57.546815Z","caller":"traceutil/trace.go:171","msg":"trace[747748753] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"116.350491ms","start":"2026-05-28T21:38:57.430447Z","end":"2026-05-28T21:38:57.546798Z","steps":["trace[747748753] 'range keys from in-memory index tree' (duration: 116.160597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.546818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.98437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:57.54689Z","caller":"traceutil/trace.go:171","msg":"trace[660932498] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:612; }","duration":"139.092943ms","start":"2026-05-28T21:38:57.407776Z","end":"2026-05-28T21:38:57.546869Z","steps":["trace[660932498] 'count revisions from in-memory index tree' (duration: 138.889698ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.546924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.320269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T21:38:57.546919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.416168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:57.546976Z","caller":"traceutil/trace.go:171","msg":"trace[1040343983] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:612; }","duration":"139.397321ms","start":"2026-05-28T21:38:57.407565Z","end":"2026-05-28T21:38:57.546963Z","steps":["trace[1040343983] 'range keys from in-memory index tree' (duration: 139.270728ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:57.546761Z","caller":"traceutil/trace.go:171","msg":"trace[1483450264] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:612; }","duration":"162.895274ms","start":"2026-05-28T21:38:57.383844Z","end":"2026-05-28T21:38:57.546739Z","steps":["trace[1483450264] 'range keys from in-memory index tree' (duration: 162.664948ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:57.54703Z","caller":"traceutil/trace.go:171","msg":"trace[1593420565] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:612; }","duration":"163.569302ms","start":"2026-05-28T21:38:57.383437Z","end":"2026-05-28T21:38:57.547006Z","steps":["trace[1593420565] 'count revisions from in-memory index tree' (duration: 163.299835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.547052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.326161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:57.54715Z","caller":"traceutil/trace.go:171","msg":"trace[128762111] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:612; }","duration":"116.444544ms","start":"2026-05-28T21:38:57.430692Z","end":"2026-05-28T21:38:57.547137Z","steps":["trace[128762111] 'count revisions from in-memory index tree' (duration: 116.27828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.546342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.043108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:57.547237Z","caller":"traceutil/trace.go:171","msg":"trace[702296214] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:612; }","duration":"178.934802ms","start":"2026-05-28T21:38:57.368292Z","end":"2026-05-28T21:38:57.547226Z","steps":["trace[702296214] 'range keys from in-memory index tree' (duration: 177.666328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:57.546296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.745787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:57.547305Z","caller":"traceutil/trace.go:171","msg":"trace[677096622] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:612; }","duration":"138.814786ms","start":"2026-05-28T21:38:57.408474Z","end":"2026-05-28T21:38:57.547289Z","steps":["trace[677096622] 'range keys from in-memory index tree' (duration: 137.657834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:00.539239Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620626842863606633,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-28T21:39:00.697603Z","caller":"traceutil/trace.go:171","msg":"trace[1637742957] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"789.484745ms","start":"2026-05-28T21:38:59.908087Z","end":"2026-05-28T21:39:00.697572Z","steps":["trace[1637742957] 'process raft request' (duration: 789.260649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:00.69781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:59.908064Z","time spent":"789.623738ms","remote":"127.0.0.1:54348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:39:02.151545Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.452414306s","expected-duration":"1s"} {"level":"info","ts":"2026-05-28T21:39:02.152411Z","caller":"traceutil/trace.go:171","msg":"trace[1849498449] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:656; }","duration":"2.113704707s","start":"2026-05-28T21:39:00.038684Z","end":"2026-05-28T21:39:02.152389Z","steps":["trace[1849498449] 'read index received' (duration: 658.78195ms)","trace[1849498449] 'applied index is now lower than readState.Index' (duration: 1.454921607s)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:39:02.152505Z","caller":"traceutil/trace.go:171","msg":"trace[1974354217] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"2.199983916s","start":"2026-05-28T21:38:59.952509Z","end":"2026-05-28T21:39:02.152493Z","steps":["trace[1974354217] 'process raft request' (duration: 2.199406729s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:02.152611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:59.952479Z","time spent":"2.200058098s","remote":"127.0.0.1:46942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:39:02.15276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.697582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-28T21:39:02.152838Z","caller":"traceutil/trace.go:171","msg":"trace[1438744972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"460.810275ms","start":"2026-05-28T21:39:01.692009Z","end":"2026-05-28T21:39:02.152819Z","steps":["trace[1438744972] 'agreement among raft nodes before linearized reading' (duration: 460.616659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:02.152875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:01.69199Z","time spent":"460.876576ms","remote":"127.0.0.1:54420","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":"warn","ts":"2026-05-28T21:39:02.152933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.894926666s","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-05-28T21:39:02.152994Z","caller":"traceutil/trace.go:171","msg":"trace[1846625087] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"1.894986267s","start":"2026-05-28T21:39:00.257982Z","end":"2026-05-28T21:39:02.152969Z","steps":["trace[1846625087] 'agreement among raft nodes before linearized reading' (duration: 1.894832963s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:02.152737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.9246723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T21:39:02.153018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.562473ms","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-05-28T21:39:02.153038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:00.257978Z","time spent":"1.8950519s","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-28T21:39:02.153052Z","caller":"traceutil/trace.go:171","msg":"trace[1059468136] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"457.640525ms","start":"2026-05-28T21:39:01.695401Z","end":"2026-05-28T21:39:02.153042Z","steps":["trace[1059468136] 'agreement among raft nodes before linearized reading' (duration: 457.541272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:02.153044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.900697728s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-28T21:39:02.153135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.114440297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.65\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-28T21:39:02.153051Z","caller":"traceutil/trace.go:171","msg":"trace[1638571353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"1.925038751s","start":"2026-05-28T21:39:00.228001Z","end":"2026-05-28T21:39:02.15304Z","steps":["trace[1638571353] 'agreement among raft nodes before linearized reading' (duration: 1.924628839s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:02.153202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:00.227972Z","time spent":"1.925218706s","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-28T21:39:02.153128Z","caller":"traceutil/trace.go:171","msg":"trace[1119844605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"1.900815621s","start":"2026-05-28T21:39:00.252292Z","end":"2026-05-28T21:39:02.153108Z","steps":["trace[1119844605] 'agreement among raft nodes before linearized reading' (duration: 1.900540313s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:02.153346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:00.252281Z","time spent":"1.901040828s","remote":"127.0.0.1:54420","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":"info","ts":"2026-05-28T21:39:02.153162Z","caller":"traceutil/trace.go:171","msg":"trace[1064895783] range","detail":"{range_begin:/registry/masterleases/199.204.45.65; range_end:; response_count:1; response_revision:632; }","duration":"2.114502249s","start":"2026-05-28T21:39:00.038653Z","end":"2026-05-28T21:39:02.153155Z","steps":["trace[1064895783] 'agreement among raft nodes before linearized reading' (duration: 2.114447948s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:02.153483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:00.038638Z","time spent":"2.114835288s","remote":"127.0.0.1:46886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.65\" "} {"level":"warn","ts":"2026-05-28T21:39:02.153082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:01.695373Z","time spent":"457.702217ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-28T21:39:02.730348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.003874ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-05-28T21:39:02.730433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:02.155089Z","time spent":"575.339573ms","remote":"127.0.0.1:46886","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-28T21:39:04.165214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000252747s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-28T21:39:04.165342Z","caller":"traceutil/trace.go:171","msg":"trace[1572752149] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000425393s","start":"2026-05-28T21:39:02.164896Z","end":"2026-05-28T21:39:04.165321Z","steps":["trace[1572752149] 'agreement among raft nodes before linearized reading' (duration: 2.000275808s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:04.16539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:02.164878Z","time spent":"2.000502344s","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/28 21:39:04 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-28T21:39:04.274824Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.415277828s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-28T21:39:05.174724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.315275478s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T21:39:05.174989Z","caller":"traceutil/trace.go:171","msg":"trace[1847464338] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"3.016837293s","start":"2026-05-28T21:39:02.158101Z","end":"2026-05-28T21:39:05.174938Z","steps":["trace[1847464338] 'process raft request' (duration: 701.266667ms)","trace[1847464338] 'compare' (duration: 2.314868606s)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:39:05.175144Z","caller":"traceutil/trace.go:171","msg":"trace[1294536201] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"2.442982692s","start":"2026-05-28T21:39:02.73214Z","end":"2026-05-28T21:39:05.175123Z","steps":["trace[1294536201] 'process raft request' (duration: 2.44293s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:05.175221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:02.732113Z","time spent":"2.443073625s","remote":"127.0.0.1:46886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:39:05.175314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:02.158077Z","time spent":"3.017008058s","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:39:05.175503Z","caller":"traceutil/trace.go:171","msg":"trace[1696782876] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"2.974615318s","start":"2026-05-28T21:39:02.200874Z","end":"2026-05-28T21:39:05.175489Z","steps":["trace[1696782876] 'process raft request' (duration: 2.974116744s)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:05.17572Z","caller":"traceutil/trace.go:171","msg":"trace[621802810] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:658; }","duration":"3.010589995s","start":"2026-05-28T21:39:02.164928Z","end":"2026-05-28T21:39:05.175518Z","steps":["trace[621802810] 'read index received' (duration: 126.226082ms)","trace[621802810] 'applied index is now lower than readState.Index' (duration: 2.884362613s)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:39:05.175764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:02.200857Z","time spent":"2.974873937s","remote":"127.0.0.1:54510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T21:39:05.175798Z","caller":"traceutil/trace.go:171","msg":"trace[979757895] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"2.54315667s","start":"2026-05-28T21:39:02.632633Z","end":"2026-05-28T21:39:05.17579Z","steps":["trace[979757895] 'process raft request' (duration: 2.542404108s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:05.175847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:02.632605Z","time spent":"2.543214252s","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:39:05.175979Z","caller":"traceutil/trace.go:171","msg":"trace[468240502] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"3.017720059s","start":"2026-05-28T21:39:02.158245Z","end":"2026-05-28T21:39:05.175965Z","steps":["trace[468240502] 'process raft request' (duration: 3.016583226s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:05.176048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:02.158237Z","time spent":"3.017771491s","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:39:05.176061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010322108s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:39:05.176092Z","caller":"traceutil/trace.go:171","msg":"trace[55670784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"1.01038959s","start":"2026-05-28T21:39:04.165692Z","end":"2026-05-28T21:39:05.176082Z","steps":["trace[55670784] 'agreement among raft nodes before linearized reading' (duration: 1.010340828s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:05.176118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:04.16567Z","time spent":"1.010443071s","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-28T21:39:05.176639Z","caller":"traceutil/trace.go:171","msg":"trace[755145515] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"3.01564635s","start":"2026-05-28T21:39:02.160548Z","end":"2026-05-28T21:39:05.176195Z","steps":["trace[755145515] 'process raft request' (duration: 3.014351572s)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:05.176643Z","caller":"traceutil/trace.go:171","msg":"trace[870078412] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"3.016016301s","start":"2026-05-28T21:39:02.160606Z","end":"2026-05-28T21:39:05.176623Z","steps":["trace[870078412] 'process raft request' (duration: 3.014327741s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:05.176727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:02.160601Z","time spent":"3.016084612s","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:39:05.17673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:02.160535Z","time spent":"3.016145824s","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:39:06.356542Z","caller":"traceutil/trace.go:171","msg":"trace[1200682215] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"126.716987ms","start":"2026-05-28T21:39:06.229793Z","end":"2026-05-28T21:39:06.35651Z","steps":["trace[1200682215] 'read index received' (duration: 125.925224ms)","trace[1200682215] 'applied index is now lower than readState.Index' (duration: 790.393µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:39:06.356653Z","caller":"traceutil/trace.go:171","msg":"trace[573837951] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"230.371487ms","start":"2026-05-28T21:39:06.126258Z","end":"2026-05-28T21:39:06.356629Z","steps":["trace[573837951] 'process raft request' (duration: 229.716948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:06.356683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.874173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:39:06.356736Z","caller":"traceutil/trace.go:171","msg":"trace[938260540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"126.991906ms","start":"2026-05-28T21:39:06.229728Z","end":"2026-05-28T21:39:06.35672Z","steps":["trace[938260540] 'agreement among raft nodes before linearized reading' (duration: 126.893153ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:07.336071Z","caller":"traceutil/trace.go:171","msg":"trace[1550638053] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"281.676206ms","start":"2026-05-28T21:39:07.054375Z","end":"2026-05-28T21:39:07.336051Z","steps":["trace[1550638053] 'process raft request' (duration: 184.540648ms)","trace[1550638053] 'compare' (duration: 96.984183ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:39:07.336071Z","caller":"traceutil/trace.go:171","msg":"trace[308665125] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:706; }","duration":"153.167349ms","start":"2026-05-28T21:39:07.182877Z","end":"2026-05-28T21:39:07.336045Z","steps":["trace[308665125] 'read index received' (duration: 55.978029ms)","trace[308665125] 'applied index is now lower than readState.Index' (duration: 97.18844ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:39:07.336232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.335684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-28T21:39:07.33631Z","caller":"traceutil/trace.go:171","msg":"trace[2011555538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:678; }","duration":"153.449107ms","start":"2026-05-28T21:39:07.182835Z","end":"2026-05-28T21:39:07.336284Z","steps":["trace[2011555538] 'agreement among raft nodes before linearized reading' (duration: 153.240521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:07.339667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.681922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-28T21:39:07.33973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.477697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-28T21:39:07.339792Z","caller":"traceutil/trace.go:171","msg":"trace[1814270489] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:679; }","duration":"156.551288ms","start":"2026-05-28T21:39:07.18322Z","end":"2026-05-28T21:39:07.339771Z","steps":["trace[1814270489] 'agreement among raft nodes before linearized reading' (duration: 156.421174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:07.339946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.732094ms","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-05-28T21:39:07.339751Z","caller":"traceutil/trace.go:171","msg":"trace[2049711693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:679; }","duration":"156.765325ms","start":"2026-05-28T21:39:07.182963Z","end":"2026-05-28T21:39:07.339729Z","steps":["trace[2049711693] 'agreement among raft nodes before linearized reading' (duration: 156.567249ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:07.339998Z","caller":"traceutil/trace.go:171","msg":"trace[1905077134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:679; }","duration":"156.802196ms","start":"2026-05-28T21:39:07.183181Z","end":"2026-05-28T21:39:07.339984Z","steps":["trace[1905077134] 'agreement among raft nodes before linearized reading' (duration: 156.648732ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:10.387376Z","caller":"traceutil/trace.go:171","msg":"trace[1808759718] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:748; }","duration":"135.632883ms","start":"2026-05-28T21:39:10.251725Z","end":"2026-05-28T21:39:10.387358Z","steps":["trace[1808759718] 'read index received' (duration: 135.419377ms)","trace[1808759718] 'applied index is now lower than readState.Index' (duration: 212.836µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:39:10.387447Z","caller":"traceutil/trace.go:171","msg":"trace[555866862] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"303.879912ms","start":"2026-05-28T21:39:10.08354Z","end":"2026-05-28T21:39:10.38742Z","steps":["trace[555866862] 'process raft request' (duration: 303.687246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:10.387575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:10.083522Z","time spent":"303.990226ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:39:10.387659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.919712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-05-28T21:39:10.387716Z","caller":"traceutil/trace.go:171","msg":"trace[103764020] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:719; }","duration":"136.028285ms","start":"2026-05-28T21:39:10.251679Z","end":"2026-05-28T21:39:10.387707Z","steps":["trace[103764020] 'agreement among raft nodes before linearized reading' (duration: 135.753906ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:21.729033Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620626842863606969,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-28T21:39:21.894958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.579483ms","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-05-28T21:39:21.894967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.570197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T21:39:21.895032Z","caller":"traceutil/trace.go:171","msg":"trace[877392229] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"974.701506ms","start":"2026-05-28T21:39:20.920314Z","end":"2026-05-28T21:39:21.895016Z","steps":["trace[877392229] 'range keys from in-memory index tree' (duration: 974.389727ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:21.895044Z","caller":"traceutil/trace.go:171","msg":"trace[744211901] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:798; }","duration":"882.69641ms","start":"2026-05-28T21:39:21.012327Z","end":"2026-05-28T21:39:21.895024Z","steps":["trace[744211901] 'count revisions from in-memory index tree' (duration: 882.432472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:21.89507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:20.920294Z","time spent":"974.768239ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-28T21:39:21.895112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.012304Z","time spent":"882.770903ms","remote":"127.0.0.1:54644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-05-28T21:39:21.947874Z","caller":"traceutil/trace.go:171","msg":"trace[541466140] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"931.58955ms","start":"2026-05-28T21:39:21.016248Z","end":"2026-05-28T21:39:21.947838Z","steps":["trace[541466140] 'process raft request' (duration: 931.398164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:21.94801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.554303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:39:21.948065Z","caller":"traceutil/trace.go:171","msg":"trace[1186483974] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:799; }","duration":"719.664777ms","start":"2026-05-28T21:39:21.22839Z","end":"2026-05-28T21:39:21.948055Z","steps":["trace[1186483974] 'agreement among raft nodes before linearized reading' (duration: 719.530693ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:21.948112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.228366Z","time spent":"719.737739ms","remote":"127.0.0.1:46836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-28T21:39:21.948187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.01623Z","time spent":"931.758345ms","remote":"127.0.0.1:54392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:39:21.947875Z","caller":"traceutil/trace.go:171","msg":"trace[1496031335] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"719.367977ms","start":"2026-05-28T21:39:21.228442Z","end":"2026-05-28T21:39:21.94781Z","steps":["trace[1496031335] 'read index received' (duration: 719.272964ms)","trace[1496031335] 'applied index is now lower than readState.Index' (duration: 93.813µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:39:22.270249Z","caller":"traceutil/trace.go:171","msg":"trace[1808100639] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"368.457312ms","start":"2026-05-28T21:39:21.901766Z","end":"2026-05-28T21:39:22.270223Z","steps":["trace[1808100639] 'process raft request' (duration: 366.227379ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:22.270426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.901743Z","time spent":"368.604106ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:39:22.270432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.523782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-28T21:39:22.270437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.555268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T21:39:22.270245Z","caller":"traceutil/trace.go:171","msg":"trace[28963784] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"321.679861ms","start":"2026-05-28T21:39:21.948536Z","end":"2026-05-28T21:39:22.270216Z","steps":["trace[28963784] 'read index received' (duration: 319.46998ms)","trace[28963784] 'applied index is now lower than readState.Index' (duration: 2.207911ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:39:22.270395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.091414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-28T21:39:22.27049Z","caller":"traceutil/trace.go:171","msg":"trace[181928356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:800; }","duration":"861.621395ms","start":"2026-05-28T21:39:21.408857Z","end":"2026-05-28T21:39:22.270479Z","steps":["trace[181928356] 'agreement among raft nodes before linearized reading' (duration: 861.48269ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:22.270511Z","caller":"traceutil/trace.go:171","msg":"trace[418159803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:800; }","duration":"855.236159ms","start":"2026-05-28T21:39:21.415265Z","end":"2026-05-28T21:39:22.270501Z","steps":["trace[418159803] 'agreement among raft nodes before linearized reading' (duration: 854.988031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:22.270531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.408839Z","time spent":"861.684326ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-28T21:39:22.270536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.415257Z","time spent":"855.27147ms","remote":"127.0.0.1:54420","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":"warn","ts":"2026-05-28T21:39:22.270558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.431384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T21:39:22.270428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.81258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-28T21:39:22.270608Z","caller":"traceutil/trace.go:171","msg":"trace[1394642314] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:800; }","duration":"857.016306ms","start":"2026-05-28T21:39:21.41358Z","end":"2026-05-28T21:39:22.270596Z","steps":["trace[1394642314] 'agreement among raft nodes before linearized reading' (duration: 856.745297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:22.270571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.873766ms","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-05-28T21:39:22.270646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.41357Z","time spent":"857.066518ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-28T21:39:22.270669Z","caller":"traceutil/trace.go:171","msg":"trace[685683288] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"859.029611ms","start":"2026-05-28T21:39:21.411622Z","end":"2026-05-28T21:39:22.270652Z","steps":["trace[685683288] 'agreement among raft nodes before linearized reading' (duration: 858.766422ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:22.2707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.089831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T21:39:22.270728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.411599Z","time spent":"859.120034ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-28T21:39:22.270733Z","caller":"traceutil/trace.go:171","msg":"trace[701440233] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:800; }","duration":"281.153343ms","start":"2026-05-28T21:39:21.989569Z","end":"2026-05-28T21:39:22.270722Z","steps":["trace[701440233] 'agreement among raft nodes before linearized reading' (duration: 281.104311ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:22.270494Z","caller":"traceutil/trace.go:171","msg":"trace[89332670] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:800; }","duration":"658.653401ms","start":"2026-05-28T21:39:21.61183Z","end":"2026-05-28T21:39:22.270484Z","steps":["trace[89332670] 'agreement among raft nodes before linearized reading' (duration: 658.511897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:22.270806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.61181Z","time spent":"658.984792ms","remote":"127.0.0.1:46932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":94,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-05-28T21:39:22.271419Z","caller":"traceutil/trace.go:171","msg":"trace[331281653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"317.489526ms","start":"2026-05-28T21:39:21.953089Z","end":"2026-05-28T21:39:22.270578Z","steps":["trace[331281653] 'agreement among raft nodes before linearized reading' (duration: 317.447875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:22.27148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:39:21.953072Z","time spent":"318.394095ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-28T21:40:10.741879Z","caller":"traceutil/trace.go:171","msg":"trace[2003734994] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"110.862192ms","start":"2026-05-28T21:40:10.630998Z","end":"2026-05-28T21:40:10.74186Z","steps":["trace[2003734994] 'process raft request' (duration: 110.409985ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:10.741318Z","caller":"traceutil/trace.go:171","msg":"trace[2131551937] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"110.55249ms","start":"2026-05-28T21:40:10.630735Z","end":"2026-05-28T21:40:10.741288Z","steps":["trace[2131551937] 'process raft request' (duration: 58.351432ms)","trace[2131551937] 'compare' (duration: 52.071593ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:40:21.18641Z","caller":"traceutil/trace.go:171","msg":"trace[1906029520] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"178.78554ms","start":"2026-05-28T21:40:21.007598Z","end":"2026-05-28T21:40:21.186384Z","steps":["trace[1906029520] 'process raft request' (duration: 178.624343ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:33.037465Z","caller":"traceutil/trace.go:171","msg":"trace[1287348744] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"116.53189ms","start":"2026-05-28T21:40:32.920891Z","end":"2026-05-28T21:40:33.037422Z","steps":["trace[1287348744] 'process raft request' (duration: 116.342853ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:33.037423Z","caller":"traceutil/trace.go:171","msg":"trace[563022775] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"119.415893ms","start":"2026-05-28T21:40:32.917966Z","end":"2026-05-28T21:40:33.037382Z","steps":["trace[563022775] 'process raft request' (duration: 81.335866ms)","trace[563022775] 'compare' (duration: 37.751024ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:40:33.037608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.513535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:40:33.037682Z","caller":"traceutil/trace.go:171","msg":"trace[1921999479] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1170; }","duration":"103.658091ms","start":"2026-05-28T21:40:32.934007Z","end":"2026-05-28T21:40:33.037665Z","steps":["trace[1921999479] 'agreement among raft nodes before linearized reading' (duration: 103.522725ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:33.038215Z","caller":"traceutil/trace.go:171","msg":"trace[1440253701] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1217; }","duration":"103.245035ms","start":"2026-05-28T21:40:32.93409Z","end":"2026-05-28T21:40:33.037335Z","steps":["trace[1440253701] 'read index received' (duration: 65.24804ms)","trace[1440253701] 'applied index is now lower than readState.Index' (duration: 37.995495ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:40:53.529441Z","caller":"traceutil/trace.go:171","msg":"trace[1548262041] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"164.84916ms","start":"2026-05-28T21:40:53.364545Z","end":"2026-05-28T21:40:53.529394Z","steps":["trace[1548262041] 'process raft request' (duration: 164.59737ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:53.547345Z","caller":"traceutil/trace.go:171","msg":"trace[1554347981] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"182.441363ms","start":"2026-05-28T21:40:53.36487Z","end":"2026-05-28T21:40:53.547311Z","steps":["trace[1554347981] 'process raft request' (duration: 182.239435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:02.854673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.447915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-dc4a9223-3570-4d55-8bd2-e0ec127c47ed\" ","response":"range_response_count:1 size:3578"} {"level":"info","ts":"2026-05-28T21:41:02.854869Z","caller":"traceutil/trace.go:171","msg":"trace[1113514551] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-dc4a9223-3570-4d55-8bd2-e0ec127c47ed; range_end:; response_count:1; response_revision:1279; }","duration":"135.734067ms","start":"2026-05-28T21:41:02.71911Z","end":"2026-05-28T21:41:02.854844Z","steps":["trace[1113514551] 'range keys from in-memory index tree' (duration: 135.207705ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:41:03.795206Z","caller":"traceutil/trace.go:171","msg":"trace[378459709] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"125.91946ms","start":"2026-05-28T21:41:03.669247Z","end":"2026-05-28T21:41:03.795167Z","steps":["trace[378459709] 'process raft request' (duration: 125.535924ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:41:03.798183Z","caller":"traceutil/trace.go:171","msg":"trace[1737336295] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"128.785097ms","start":"2026-05-28T21:41:03.669321Z","end":"2026-05-28T21:41:03.798106Z","steps":["trace[1737336295] 'process raft request' (duration: 128.536727ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:41:10.880359Z","caller":"traceutil/trace.go:171","msg":"trace[23340701] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"101.775655ms","start":"2026-05-28T21:41:10.778553Z","end":"2026-05-28T21:41:10.880329Z","steps":["trace[23340701] 'process raft request' (duration: 101.602768ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:41:27.062381Z","caller":"traceutil/trace.go:171","msg":"trace[1873191794] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"113.970917ms","start":"2026-05-28T21:41:26.948378Z","end":"2026-05-28T21:41:27.062349Z","steps":["trace[1873191794] 'process raft request' (duration: 113.477647ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:41:37.705338Z","caller":"traceutil/trace.go:171","msg":"trace[1896396889] linearizableReadLoop","detail":"{readStateIndex:1486; appliedIndex:1485; }","duration":"158.799487ms","start":"2026-05-28T21:41:37.546509Z","end":"2026-05-28T21:41:37.705308Z","steps":["trace[1896396889] 'read index received' (duration: 102.754995ms)","trace[1896396889] 'applied index is now lower than readState.Index' (duration: 56.043672ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:41:37.705504Z","caller":"traceutil/trace.go:171","msg":"trace[126609165] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"167.917348ms","start":"2026-05-28T21:41:37.537549Z","end":"2026-05-28T21:41:37.705466Z","steps":["trace[126609165] 'process raft request' (duration: 111.677927ms)","trace[126609165] 'compare' (duration: 55.950869ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:41:37.705601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.777132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller\" ","response":"range_response_count:1 size:807"} {"level":"warn","ts":"2026-05-28T21:41:37.705592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.046218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslice-controller\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-05-28T21:41:37.705662Z","caller":"traceutil/trace.go:171","msg":"trace[1040965659] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1422; }","duration":"100.896697ms","start":"2026-05-28T21:41:37.604745Z","end":"2026-05-28T21:41:37.705641Z","steps":["trace[1040965659] 'agreement among raft nodes before linearized reading' (duration: 100.768332ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:41:37.705716Z","caller":"traceutil/trace.go:171","msg":"trace[233812705] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslice-controller; range_end:; response_count:1; response_revision:1422; }","duration":"159.189164ms","start":"2026-05-28T21:41:37.546482Z","end":"2026-05-28T21:41:37.705672Z","steps":["trace[233812705] 'agreement among raft nodes before linearized reading' (duration: 158.975285ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:41:46.046324Z","caller":"traceutil/trace.go:171","msg":"trace[1096652939] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"147.715308ms","start":"2026-05-28T21:41:45.898587Z","end":"2026-05-28T21:41:46.046303Z","steps":["trace[1096652939] 'process raft request' (duration: 147.554401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:46.523277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.280735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:912"} {"level":"info","ts":"2026-05-28T21:41:46.523352Z","caller":"traceutil/trace.go:171","msg":"trace[81354820] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1452; }","duration":"109.38522ms","start":"2026-05-28T21:41:46.413949Z","end":"2026-05-28T21:41:46.523334Z","steps":["trace[81354820] 'range keys from in-memory index tree' (duration: 109.179441ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:41:51.838965Z","caller":"traceutil/trace.go:171","msg":"trace[827238955] linearizableReadLoop","detail":"{readStateIndex:1535; appliedIndex:1534; }","duration":"136.387095ms","start":"2026-05-28T21:41:51.702552Z","end":"2026-05-28T21:41:51.838939Z","steps":["trace[827238955] 'read index received' (duration: 136.216658ms)","trace[827238955] 'applied index is now lower than readState.Index' (duration: 169.097µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:41:51.839038Z","caller":"traceutil/trace.go:171","msg":"trace[1983992035] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"176.144377ms","start":"2026-05-28T21:41:51.662855Z","end":"2026-05-28T21:41:51.838999Z","steps":["trace[1983992035] 'process raft request' (duration: 175.884566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:51.839176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.591127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kube-proxy\" ","response":"range_response_count:1 size:450"} {"level":"info","ts":"2026-05-28T21:41:51.839224Z","caller":"traceutil/trace.go:171","msg":"trace[1807552849] range","detail":"{range_begin:/registry/rolebindings/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1468; }","duration":"113.68316ms","start":"2026-05-28T21:41:51.725528Z","end":"2026-05-28T21:41:51.839211Z","steps":["trace[1807552849] 'agreement among raft nodes before linearized reading' (duration: 113.574756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:51.839301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.717308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/cilium-config-agent\" ","response":"range_response_count:1 size:790"} {"level":"info","ts":"2026-05-28T21:41:51.839414Z","caller":"traceutil/trace.go:171","msg":"trace[486370781] range","detail":"{range_begin:/registry/rolebindings/kube-system/cilium-config-agent; range_end:; response_count:1; response_revision:1468; }","duration":"136.897336ms","start":"2026-05-28T21:41:51.702485Z","end":"2026-05-28T21:41:51.839382Z","steps":["trace[486370781] 'agreement among raft nodes before linearized reading' (duration: 136.610094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:52.062854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.530963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-05-28T21:41:52.063139Z","caller":"traceutil/trace.go:171","msg":"trace[2092966657] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:1469; }","duration":"132.894839ms","start":"2026-05-28T21:41:51.930228Z","end":"2026-05-28T21:41:52.063123Z","steps":["trace[2092966657] 'range keys from in-memory index tree' (duration: 132.399658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:53.77538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620626842863609409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-28T21:41:54.275916Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620626842863609409,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-28T21:41:54.699348Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.4426048s","expected-duration":"1s"} {"level":"info","ts":"2026-05-28T21:41:54.699796Z","caller":"traceutil/trace.go:171","msg":"trace[3285879] linearizableReadLoop","detail":"{readStateIndex:1541; appliedIndex:1540; }","duration":"1.425341043s","start":"2026-05-28T21:41:53.274422Z","end":"2026-05-28T21:41:54.699763Z","steps":["trace[3285879] 'read index received' (duration: 1.425142325s)","trace[3285879] 'applied index is now lower than readState.Index' (duration: 197.078µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:41:54.700051Z","caller":"traceutil/trace.go:171","msg":"trace[2129388025] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"1.443309739s","start":"2026-05-28T21:41:53.256636Z","end":"2026-05-28T21:41:54.699946Z","steps":["trace[2129388025] 'process raft request' (duration: 1.442913892s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:54.700137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.241253ms","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-05-28T21:41:54.700214Z","caller":"traceutil/trace.go:171","msg":"trace[959681068] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1474; }","duration":"796.370999ms","start":"2026-05-28T21:41:53.903823Z","end":"2026-05-28T21:41:54.700194Z","steps":["trace[959681068] 'agreement among raft nodes before linearized reading' (duration: 796.250904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:54.700286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:41:53.903808Z","time spent":"796.458142ms","remote":"127.0.0.1:42476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-28T21:41:54.700481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:41:53.256615Z","time spent":"1.443696376s","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:41:54.700548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.426121786s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kubeadm:kubeadm-certs\" ","response":"range_response_count:1 size:339"} {"level":"info","ts":"2026-05-28T21:41:54.70061Z","caller":"traceutil/trace.go:171","msg":"trace[901170926] range","detail":"{range_begin:/registry/roles/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:1474; }","duration":"1.426227131s","start":"2026-05-28T21:41:53.274371Z","end":"2026-05-28T21:41:54.700598Z","steps":["trace[901170926] 'agreement among raft nodes before linearized reading' (duration: 1.425570493s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:54.700655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:41:53.27435Z","time spent":"1.426296604s","remote":"127.0.0.1:54480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":363,"request content":"key:\"/registry/roles/kube-system/kubeadm:kubeadm-certs\" "} {"level":"warn","ts":"2026-05-28T21:41:54.700732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.373006052s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kubeadm:kubelet-config\" ","response":"range_response_count:1 size:345"} {"level":"info","ts":"2026-05-28T21:41:54.700805Z","caller":"traceutil/trace.go:171","msg":"trace[816072921] range","detail":"{range_begin:/registry/roles/kube-system/kubeadm:kubelet-config; range_end:; response_count:1; response_revision:1474; }","duration":"1.373122206s","start":"2026-05-28T21:41:53.327667Z","end":"2026-05-28T21:41:54.700789Z","steps":["trace[816072921] 'agreement among raft nodes before linearized reading' (duration: 1.372388135s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:54.70086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:41:53.327645Z","time spent":"1.373202239s","remote":"127.0.0.1:54480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":369,"request content":"key:\"/registry/roles/kube-system/kubeadm:kubelet-config\" "} {"level":"warn","ts":"2026-05-28T21:41:54.700869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.907098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-28T21:41:54.700921Z","caller":"traceutil/trace.go:171","msg":"trace[1031204269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1474; }","duration":"603.991072ms","start":"2026-05-28T21:41:54.096917Z","end":"2026-05-28T21:41:54.700908Z","steps":["trace[1031204269] 'agreement among raft nodes before linearized reading' (duration: 603.165087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:54.700715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.745303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-28T21:41:54.700914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.564402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-28T21:41:54.700979Z","caller":"traceutil/trace.go:171","msg":"trace[1050844063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1474; }","duration":"346.091608ms","start":"2026-05-28T21:41:54.354875Z","end":"2026-05-28T21:41:54.700966Z","steps":["trace[1050844063] 'agreement among raft nodes before linearized reading' (duration: 345.262393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:54.701023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:41:54.354837Z","time spent":"346.175561ms","remote":"127.0.0.1:54420","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":"warn","ts":"2026-05-28T21:41:54.70103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.675812ms","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-05-28T21:41:54.701067Z","caller":"traceutil/trace.go:171","msg":"trace[1408651982] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1474; }","duration":"365.744775ms","start":"2026-05-28T21:41:54.335313Z","end":"2026-05-28T21:41:54.701058Z","steps":["trace[1408651982] 'agreement among raft nodes before linearized reading' (duration: 364.839037ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:54.7011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:41:54.335284Z","time spent":"365.809488ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-28T21:41:54.701098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.098307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-28T21:41:54.701016Z","caller":"traceutil/trace.go:171","msg":"trace[1587138082] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1474; }","duration":"856.727148ms","start":"2026-05-28T21:41:53.844266Z","end":"2026-05-28T21:41:54.700994Z","steps":["trace[1587138082] 'agreement among raft nodes before linearized reading' (duration: 855.902234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:54.701229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:41:53.844237Z","time spent":"856.972358ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-28T21:41:54.700964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:41:54.096904Z","time spent":"604.051855ms","remote":"127.0.0.1:54420","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":"info","ts":"2026-05-28T21:41:54.701135Z","caller":"traceutil/trace.go:171","msg":"trace[1639176308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1474; }","duration":"820.1798ms","start":"2026-05-28T21:41:53.880947Z","end":"2026-05-28T21:41:54.701127Z","steps":["trace[1639176308] 'agreement among raft nodes before linearized reading' (duration: 819.189048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:41:54.701462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:41:53.880924Z","time spent":"820.524064ms","remote":"127.0.0.1:54420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-28T21:41:58.882572Z","caller":"traceutil/trace.go:171","msg":"trace[1689285342] transaction","detail":"{read_only:false; response_revision:1486; number_of_response:1; }","duration":"113.221772ms","start":"2026-05-28T21:41:58.769326Z","end":"2026-05-28T21:41:58.882548Z","steps":["trace[1689285342] 'process raft request' (duration: 113.044635ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:42:00.286827Z","caller":"traceutil/trace.go:171","msg":"trace[347173545] transaction","detail":"{read_only:false; response_revision:1493; number_of_response:1; }","duration":"160.05397ms","start":"2026-05-28T21:42:00.126743Z","end":"2026-05-28T21:42:00.286797Z","steps":["trace[347173545] 'process raft request' (duration: 82.917137ms)","trace[347173545] 'compare' (duration: 76.934845ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:42:01.125572Z","caller":"traceutil/trace.go:171","msg":"trace[269052180] transaction","detail":"{read_only:false; response_revision:1497; number_of_response:1; }","duration":"136.896896ms","start":"2026-05-28T21:42:00.988653Z","end":"2026-05-28T21:42:01.12555Z","steps":["trace[269052180] 'process raft request' (duration: 136.810282ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:42:01.125798Z","caller":"traceutil/trace.go:171","msg":"trace[2031407981] transaction","detail":"{read_only:false; response_revision:1498; number_of_response:1; }","duration":"137.135786ms","start":"2026-05-28T21:42:00.988654Z","end":"2026-05-28T21:42:01.12579Z","steps":["trace[2031407981] 'process raft request' (duration: 136.870615ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:42:01.125923Z","caller":"traceutil/trace.go:171","msg":"trace[1434118842] transaction","detail":"{read_only:false; response_revision:1499; number_of_response:1; }","duration":"136.768601ms","start":"2026-05-28T21:42:00.989131Z","end":"2026-05-28T21:42:01.125899Z","steps":["trace[1434118842] 'process raft request' (duration: 136.579693ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:42:01.125609Z","caller":"traceutil/trace.go:171","msg":"trace[1416811821] transaction","detail":"{read_only:false; response_revision:1496; number_of_response:1; }","duration":"137.122555ms","start":"2026-05-28T21:42:00.988444Z","end":"2026-05-28T21:42:01.125566Z","steps":["trace[1416811821] 'process raft request' (duration: 136.187146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:42:01.342068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.024808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:42:01.342219Z","caller":"traceutil/trace.go:171","msg":"trace[1979437844] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1499; }","duration":"113.277949ms","start":"2026-05-28T21:42:01.228907Z","end":"2026-05-28T21:42:01.342185Z","steps":["trace[1979437844] 'range keys from in-memory index tree' (duration: 112.892693ms)"],"step_count":1}