{"level":"warn","ts":"2026-07-31T21:19:07.306612Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-31T21:19:07.306708Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-07-31T21:19:07.306776Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-31T21:19:07.30679Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-07-31T21:19:07.306808Z","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-07-31T21:19:07.307493Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-07-31T21:19:07.307603Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-07-31T21:19:07.334521Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"26.692139ms"} {"level":"info","ts":"2026-07-31T21:19:07.373828Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-07-31T21:19:07.373937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-07-31T21:19:07.373969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-07-31T21:19:07.373993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-31T21:19:07.374007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-07-31T21:19:07.374073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-07-31T21:19:07.425265Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-31T21:19:07.46113Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-31T21:19:07.526188Z","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-07-31T21:19:07.539176Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-31T21:19:07.539428Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-31T21:19:07.539698Z","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-07-31T21:19:07.540601Z","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-07-31T21:19:07.540625Z","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-07-31T21:19:07.548497Z","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-07-31T21:19:07.548673Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-07-31T21:19:07.548713Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-07-31T21:19:07.548801Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-31T21:19:07.548854Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-31T21:19:07.549051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-07-31T21:19:07.549197Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-07-31T21:19:08.075162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-07-31T21:19:08.075235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-31T21:19:08.075253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-07-31T21:19:08.075266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-07-31T21:19:08.075273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-07-31T21:19:08.075283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-07-31T21:19:08.075291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-07-31T21:19:08.308641Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-07-31T21:19:08.308708Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-31T21:19:08.30866Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-31T21:19:08.308732Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-31T21:19:08.308997Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-31T21:19:08.309186Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-31T21:19:08.312131Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-07-31T21:19:08.313538Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-31T21:19:08.41933Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-07-31T21:19:08.419469Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-31T21:19:08.419532Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-31T21:19:10.041759Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790427763,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-31T21:19:10.234147Z","caller":"traceutil/trace.go:171","msg":"trace[376339945] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"696.233469ms","start":"2026-07-31T21:19:09.537889Z","end":"2026-07-31T21:19:10.234123Z","steps":["trace[376339945] 'process raft request' (duration: 696.026574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:10.234674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.537879Z","time spent":"696.342111ms","remote":"127.0.0.1:53116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:19:12.701357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999791932s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-31T21:19:12.701482Z","caller":"traceutil/trace.go:171","msg":"trace[892150059] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999985726s","start":"2026-07-31T21:19:10.701477Z","end":"2026-07-31T21:19:12.701463Z","steps":["trace[892150059] 'agreement among raft nodes before linearized reading' (duration: 1.999828122s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:12.70153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:10.701449Z","time spent":"2.000071648s","remote":"127.0.0.1:53054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T21:19:12.979213Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.745173283s","expected-duration":"1s"} {"level":"info","ts":"2026-07-31T21:19:13.033018Z","caller":"traceutil/trace.go:171","msg":"trace[873914263] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"3.494905706s","start":"2026-07-31T21:19:09.538073Z","end":"2026-07-31T21:19:13.032978Z","steps":["trace[873914263] 'process raft request' (duration: 3.44136441s)","trace[873914263] 'compare' (duration: 53.29626ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:19:13.033212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.538068Z","time spent":"3.495034658s","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:19:13.03326Z","caller":"traceutil/trace.go:171","msg":"trace[1790962956] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:4; }","duration":"3.492423277s","start":"2026-07-31T21:19:09.540815Z","end":"2026-07-31T21:19:13.033239Z","steps":["trace[1790962956] 'read index received' (duration: 693.153416ms)","trace[1790962956] 'applied index is now lower than readState.Index' (duration: 2.799268621s)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:13.033322Z","caller":"traceutil/trace.go:171","msg":"trace[1828387308] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"3.414515324s","start":"2026-07-31T21:19:09.618771Z","end":"2026-07-31T21:19:13.033286Z","steps":["trace[1828387308] 'process raft request' (duration: 3.414167216s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.033424Z","caller":"traceutil/trace.go:171","msg":"trace[1816968453] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"3.414288898s","start":"2026-07-31T21:19:09.619119Z","end":"2026-07-31T21:19:13.033408Z","steps":["trace[1816968453] 'process raft request' (duration: 3.413887179s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.033477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.618749Z","time spent":"3.414671668s","remote":"127.0.0.1:53492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.033565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.619105Z","time spent":"3.41438013s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:13.033604Z","caller":"traceutil/trace.go:171","msg":"trace[1814667746] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"3.493572022s","start":"2026-07-31T21:19:09.540015Z","end":"2026-07-31T21:19:13.033587Z","steps":["trace[1814667746] 'process raft request' (duration: 3.492861796s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.033664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.540007Z","time spent":"3.493630865s","remote":"127.0.0.1:53310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:13.03373Z","caller":"traceutil/trace.go:171","msg":"trace[45792074] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"3.414512773s","start":"2026-07-31T21:19:09.619203Z","end":"2026-07-31T21:19:13.033716Z","steps":["trace[45792074] 'process raft request' (duration: 3.413824558s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.033808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.619192Z","time spent":"3.414574935s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:13.033913Z","caller":"traceutil/trace.go:171","msg":"trace[1419995711] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"3.400764505s","start":"2026-07-31T21:19:09.633131Z","end":"2026-07-31T21:19:13.033895Z","steps":["trace[1419995711] 'process raft request' (duration: 3.400064019s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.034039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.633115Z","time spent":"3.400875598s","remote":"127.0.0.1:53220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.034105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.493272886s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-07-31T21:19:13.034159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.510219504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-31T21:19:13.034109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.417177867s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-31T21:19:13.034208Z","caller":"traceutil/trace.go:171","msg":"trace[1519809321] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"2.510282526s","start":"2026-07-31T21:19:10.523914Z","end":"2026-07-31T21:19:13.034196Z","steps":["trace[1519809321] 'agreement among raft nodes before linearized reading' (duration: 2.510225655s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.034218Z","caller":"traceutil/trace.go:171","msg":"trace[30884918] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:0; response_revision:11; }","duration":"3.417313781s","start":"2026-07-31T21:19:09.616892Z","end":"2026-07-31T21:19:13.034206Z","steps":["trace[30884918] 'agreement among raft nodes before linearized reading' (duration: 3.417100346s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.034247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:10.523903Z","time spent":"2.510336267s","remote":"127.0.0.1:53398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-07-31T21:19:13.034263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.616873Z","time spent":"3.417375402s","remote":"127.0.0.1:53086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-07-31T21:19:13.034287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.354915568s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-31T21:19:13.03434Z","caller":"traceutil/trace.go:171","msg":"trace[513839880] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"3.35499909s","start":"2026-07-31T21:19:09.679329Z","end":"2026-07-31T21:19:13.034328Z","steps":["trace[513839880] 'agreement among raft nodes before linearized reading' (duration: 3.354915818s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.034377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.679317Z","time spent":"3.355053741s","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-07-31T21:19:13.034398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.363282558s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-31T21:19:13.034428Z","caller":"traceutil/trace.go:171","msg":"trace[1313414959] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"3.363339189s","start":"2026-07-31T21:19:09.67108Z","end":"2026-07-31T21:19:13.034419Z","steps":["trace[1313414959] 'agreement among raft nodes before linearized reading' (duration: 3.363293558s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.034464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.671062Z","time spent":"3.36339603s","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-31T21:19:13.034518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.517292672s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-31T21:19:13.034554Z","caller":"traceutil/trace.go:171","msg":"trace[1971096922] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"2.517355473s","start":"2026-07-31T21:19:10.517189Z","end":"2026-07-31T21:19:13.034545Z","steps":["trace[1971096922] 'agreement among raft nodes before linearized reading' (duration: 2.517307072s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.03458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:10.51717Z","time spent":"2.517404174s","remote":"127.0.0.1:53410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-07-31T21:19:13.034603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.415177868s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-31T21:19:13.034627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.349068488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-31T21:19:13.03464Z","caller":"traceutil/trace.go:171","msg":"trace[1412924407] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"3.415230899s","start":"2026-07-31T21:19:09.619399Z","end":"2026-07-31T21:19:13.03463Z","steps":["trace[1412924407] 'agreement among raft nodes before linearized reading' (duration: 3.415181328s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.034674Z","caller":"traceutil/trace.go:171","msg":"trace[992270669] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"3.34914017s","start":"2026-07-31T21:19:09.68552Z","end":"2026-07-31T21:19:13.034661Z","steps":["trace[992270669] 'agreement among raft nodes before linearized reading' (duration: 3.349068968s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.034688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.619392Z","time spent":"3.415288581s","remote":"127.0.0.1:53128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-07-31T21:19:13.034712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.685507Z","time spent":"3.349195721s","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-31T21:19:13.034775Z","caller":"traceutil/trace.go:171","msg":"trace[783140167] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"3.415518316s","start":"2026-07-31T21:19:09.619206Z","end":"2026-07-31T21:19:13.034724Z","steps":["trace[783140167] 'process raft request' (duration: 3.413844318s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.034167Z","caller":"traceutil/trace.go:171","msg":"trace[826054593] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"3.493359307s","start":"2026-07-31T21:19:09.540793Z","end":"2026-07-31T21:19:13.034152Z","steps":["trace[826054593] 'agreement among raft nodes before linearized reading' (duration: 3.493125692s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.034898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.540785Z","time spent":"3.494094444s","remote":"127.0.0.1:53220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-31T21:19:13.034962Z","caller":"traceutil/trace.go:171","msg":"trace[481001640] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"3.415487196s","start":"2026-07-31T21:19:09.619464Z","end":"2026-07-31T21:19:13.034951Z","steps":["trace[481001640] 'process raft request' (duration: 3.413640374s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.035035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.619458Z","time spent":"3.415549768s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:13.033309Z","caller":"traceutil/trace.go:171","msg":"trace[250456483] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"3.414253518s","start":"2026-07-31T21:19:09.618959Z","end":"2026-07-31T21:19:13.033213Z","steps":["trace[250456483] 'process raft request' (duration: 3.414015563s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.035169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.619182Z","time spent":"3.415955678s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.035223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.618912Z","time spent":"3.416270935s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.034827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.416371997s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-31T21:19:13.035362Z","caller":"traceutil/trace.go:171","msg":"trace[1286265296] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"3.416877619s","start":"2026-07-31T21:19:09.618411Z","end":"2026-07-31T21:19:13.035288Z","steps":["trace[1286265296] 'agreement among raft nodes before linearized reading' (duration: 3.416383257s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.035417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:09.618385Z","time spent":"3.417016912s","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-31T21:19:13.394602Z","caller":"traceutil/trace.go:171","msg":"trace[1844313434] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"354.255354ms","start":"2026-07-31T21:19:13.040317Z","end":"2026-07-31T21:19:13.394572Z","steps":["trace[1844313434] 'read index received' (duration: 341.58472ms)","trace[1844313434] 'applied index is now lower than readState.Index' (duration: 12.669474ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:13.3947Z","caller":"traceutil/trace.go:171","msg":"trace[148617854] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"354.769256ms","start":"2026-07-31T21:19:13.039897Z","end":"2026-07-31T21:19:13.394666Z","steps":["trace[148617854] 'process raft request' (duration: 342.01591ms)","trace[148617854] 'compare' (duration: 12.536181ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:19:13.394833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.039875Z","time spent":"354.894879ms","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.394939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.567172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-31T21:19:13.395067Z","caller":"traceutil/trace.go:171","msg":"trace[1143857844] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"354.759595ms","start":"2026-07-31T21:19:13.040287Z","end":"2026-07-31T21:19:13.395047Z","steps":["trace[1143857844] 'agreement among raft nodes before linearized reading' (duration: 354.400657ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.395149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.040277Z","time spent":"354.857458ms","remote":"127.0.0.1:53054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-31T21:19:13.397975Z","caller":"traceutil/trace.go:171","msg":"trace[444011069] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"355.852431ms","start":"2026-07-31T21:19:13.042103Z","end":"2026-07-31T21:19:13.397955Z","steps":["trace[444011069] 'process raft request' (duration: 355.678737ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.398025Z","caller":"traceutil/trace.go:171","msg":"trace[310897425] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"355.663577ms","start":"2026-07-31T21:19:13.042348Z","end":"2026-07-31T21:19:13.398012Z","steps":["trace[310897425] 'process raft request' (duration: 355.558915ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.398084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.042082Z","time spent":"355.946563ms","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:13.398087Z","caller":"traceutil/trace.go:171","msg":"trace[942095065] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"355.264638ms","start":"2026-07-31T21:19:13.042778Z","end":"2026-07-31T21:19:13.398042Z","steps":["trace[942095065] 'process raft request' (duration: 355.153835ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.398146Z","caller":"traceutil/trace.go:171","msg":"trace[2066508537] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"355.190266ms","start":"2026-07-31T21:19:13.042946Z","end":"2026-07-31T21:19:13.398136Z","steps":["trace[2066508537] 'process raft request' (duration: 355.028402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.39809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.042341Z","time spent":"355.718928ms","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:13.398176Z","caller":"traceutil/trace.go:171","msg":"trace[930176320] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"355.075763ms","start":"2026-07-31T21:19:13.043064Z","end":"2026-07-31T21:19:13.39814Z","steps":["trace[930176320] 'process raft request' (duration: 354.95238ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.398232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.042941Z","time spent":"355.268008ms","remote":"127.0.0.1:53448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.398235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.042772Z","time spent":"355.38575ms","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:13.398294Z","caller":"traceutil/trace.go:171","msg":"trace[789725350] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"353.776482ms","start":"2026-07-31T21:19:13.0445Z","end":"2026-07-31T21:19:13.398277Z","steps":["trace[789725350] 'process raft request' (duration: 353.613068ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.398351Z","caller":"traceutil/trace.go:171","msg":"trace[1955641823] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"354.669203ms","start":"2026-07-31T21:19:13.04363Z","end":"2026-07-31T21:19:13.398299Z","steps":["trace[1955641823] 'process raft request' (duration: 354.434807ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.398367Z","caller":"traceutil/trace.go:171","msg":"trace[686093025] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"354.889958ms","start":"2026-07-31T21:19:13.043466Z","end":"2026-07-31T21:19:13.398356Z","steps":["trace[686093025] 'process raft request' (duration: 354.575751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.398371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.04304Z","time spent":"355.241497ms","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.398428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.043611Z","time spent":"354.782946ms","remote":"127.0.0.1:53410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.398445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.043458Z","time spent":"354.936439ms","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.398435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.044489Z","time spent":"353.855825ms","remote":"127.0.0.1:53492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:13.398523Z","caller":"traceutil/trace.go:171","msg":"trace[1326537952] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"354.452248ms","start":"2026-07-31T21:19:13.044063Z","end":"2026-07-31T21:19:13.398515Z","steps":["trace[1326537952] 'process raft request' (duration: 354.027958ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.398562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.432031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-7r5s5\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-07-31T21:19:13.398502Z","caller":"traceutil/trace.go:171","msg":"trace[1750107183] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"350.470836ms","start":"2026-07-31T21:19:13.048011Z","end":"2026-07-31T21:19:13.398482Z","steps":["trace[1750107183] 'process raft request' (duration: 350.140298ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.398621Z","caller":"traceutil/trace.go:171","msg":"trace[1427058088] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-7r5s5; range_end:; response_count:1; response_revision:21; }","duration":"355.500853ms","start":"2026-07-31T21:19:13.043105Z","end":"2026-07-31T21:19:13.398606Z","steps":["trace[1427058088] 'agreement among raft nodes before linearized reading' (duration: 355.39937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.398636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.048003Z","time spent":"350.606079ms","remote":"127.0.0.1:53220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:19:13.398665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.04309Z","time spent":"355.563495ms","remote":"127.0.0.1:53310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":880,"request content":"key:\"/registry/certificatesigningrequests/csr-7r5s5\" "} {"level":"warn","ts":"2026-07-31T21:19:13.398702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.126403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-31T21:19:13.398735Z","caller":"traceutil/trace.go:171","msg":"trace[1301770254] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"298.192673ms","start":"2026-07-31T21:19:13.100532Z","end":"2026-07-31T21:19:13.398725Z","steps":["trace[1301770254] 'agreement among raft nodes before linearized reading' (duration: 298.138692ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.398582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.044039Z","time spent":"354.51643ms","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:13.398747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.00601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-31T21:19:13.39879Z","caller":"traceutil/trace.go:171","msg":"trace[1001236074] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:21; }","duration":"154.095833ms","start":"2026-07-31T21:19:13.244681Z","end":"2026-07-31T21:19:13.398777Z","steps":["trace[1001236074] 'agreement among raft nodes before linearized reading' (duration: 154.020481ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.398786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.553121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-31T21:19:13.398573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.056206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-31T21:19:13.398865Z","caller":"traceutil/trace.go:171","msg":"trace[1043218458] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:21; }","duration":"356.371863ms","start":"2026-07-31T21:19:13.042482Z","end":"2026-07-31T21:19:13.398853Z","steps":["trace[1043218458] 'agreement among raft nodes before linearized reading' (duration: 356.053406ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:13.398865Z","caller":"traceutil/trace.go:171","msg":"trace[1978170916] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:21; }","duration":"304.633403ms","start":"2026-07-31T21:19:13.094201Z","end":"2026-07-31T21:19:13.398834Z","steps":["trace[1978170916] 'agreement among raft nodes before linearized reading' (duration: 304.540491ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:13.3989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.042475Z","time spent":"356.414534ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-07-31T21:19:13.398921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:13.09419Z","time spent":"304.717535ms","remote":"127.0.0.1:53150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-07-31T21:19:16.451336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.37618ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-31T21:19:16.451804Z","caller":"traceutil/trace.go:171","msg":"trace[897009194] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"140.510006ms","start":"2026-07-31T21:19:16.311269Z","end":"2026-07-31T21:19:16.451779Z","steps":["trace[897009194] 'process raft request' (duration: 19.42855ms)","trace[897009194] 'compare' (duration: 120.159236ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:16.459169Z","caller":"traceutil/trace.go:171","msg":"trace[2031457049] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"144.094448ms","start":"2026-07-31T21:19:16.315051Z","end":"2026-07-31T21:19:16.459145Z","steps":["trace[2031457049] 'process raft request' (duration: 143.955035ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:16.754987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.735708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:19:16.755074Z","caller":"traceutil/trace.go:171","msg":"trace[2034121646] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:0; response_revision:254; }","duration":"202.893101ms","start":"2026-07-31T21:19:16.552159Z","end":"2026-07-31T21:19:16.755052Z","steps":["trace[2034121646] 'range keys from in-memory index tree' (duration: 202.648156ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:17.003665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.094464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:19:17.003765Z","caller":"traceutil/trace.go:171","msg":"trace[1899142382] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:0; response_revision:256; }","duration":"146.259357ms","start":"2026-07-31T21:19:16.857487Z","end":"2026-07-31T21:19:17.003746Z","steps":["trace[1899142382] 'range keys from in-memory index tree' (duration: 145.984291ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:17.16751Z","caller":"traceutil/trace.go:171","msg":"trace[800531502] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"157.003025ms","start":"2026-07-31T21:19:17.010462Z","end":"2026-07-31T21:19:17.167465Z","steps":["trace[800531502] 'process raft request' (duration: 156.38946ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:17.176584Z","caller":"traceutil/trace.go:171","msg":"trace[1067628155] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"165.715161ms","start":"2026-07-31T21:19:17.010847Z","end":"2026-07-31T21:19:17.176563Z","steps":["trace[1067628155] 'process raft request' (duration: 165.540317ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:17.370884Z","caller":"traceutil/trace.go:171","msg":"trace[2056217143] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"182.292804ms","start":"2026-07-31T21:19:17.188569Z","end":"2026-07-31T21:19:17.370861Z","steps":["trace[2056217143] 'process raft request' (duration: 182.238913ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:17.371171Z","caller":"traceutil/trace.go:171","msg":"trace[1948165253] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"190.625432ms","start":"2026-07-31T21:19:17.180494Z","end":"2026-07-31T21:19:17.371119Z","steps":["trace[1948165253] 'process raft request' (duration: 102.832865ms)","trace[1948165253] 'compare' (duration: 87.312706ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:17.371243Z","caller":"traceutil/trace.go:171","msg":"trace[246717807] linearizableReadLoop","detail":"{readStateIndex:265; appliedIndex:264; }","duration":"190.064579ms","start":"2026-07-31T21:19:17.18115Z","end":"2026-07-31T21:19:17.371215Z","steps":["trace[246717807] 'read index received' (duration: 102.144189ms)","trace[246717807] 'applied index is now lower than readState.Index' (duration: 87.91726ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:19:17.3714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.233672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-31T21:19:17.371452Z","caller":"traceutil/trace.go:171","msg":"trace[236923802] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:260; }","duration":"190.308144ms","start":"2026-07-31T21:19:17.18113Z","end":"2026-07-31T21:19:17.371438Z","steps":["trace[236923802] 'agreement among raft nodes before linearized reading' (duration: 190.186041ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:18.424131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.51534ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-31T21:19:18.424313Z","caller":"traceutil/trace.go:171","msg":"trace[1741121112] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"163.399333ms","start":"2026-07-31T21:19:18.260886Z","end":"2026-07-31T21:19:18.424285Z","steps":["trace[1741121112] 'process raft request' (duration: 35.670998ms)","trace[1741121112] 'compare' (duration: 127.376677ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:18.424369Z","caller":"traceutil/trace.go:171","msg":"trace[267571849] linearizableReadLoop","detail":"{readStateIndex:299; appliedIndex:298; }","duration":"149.118193ms","start":"2026-07-31T21:19:18.275179Z","end":"2026-07-31T21:19:18.424297Z","steps":["trace[267571849] 'read index received' (duration: 21.366688ms)","trace[267571849] 'applied index is now lower than readState.Index' (duration: 127.744635ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:19:18.424615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.41688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-07-31T21:19:18.424738Z","caller":"traceutil/trace.go:171","msg":"trace[1170299862] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:294; }","duration":"149.564263ms","start":"2026-07-31T21:19:18.275128Z","end":"2026-07-31T21:19:18.424692Z","steps":["trace[1170299862] 'agreement among raft nodes before linearized reading' (duration: 149.300167ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:18.567067Z","caller":"traceutil/trace.go:171","msg":"trace[295363638] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"132.917191ms","start":"2026-07-31T21:19:18.434119Z","end":"2026-07-31T21:19:18.567036Z","steps":["trace[295363638] 'process raft request' (duration: 105.925468ms)","trace[295363638] 'compare' (duration: 26.696456ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:18.567136Z","caller":"traceutil/trace.go:171","msg":"trace[1271038200] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"119.135773ms","start":"2026-07-31T21:19:18.447995Z","end":"2026-07-31T21:19:18.567131Z","steps":["trace[1271038200] 'process raft request' (duration: 118.97603ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:18.567105Z","caller":"traceutil/trace.go:171","msg":"trace[1323067777] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"117.973297ms","start":"2026-07-31T21:19:18.449121Z","end":"2026-07-31T21:19:18.567094Z","steps":["trace[1323067777] 'process raft request' (duration: 117.892585ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:18.567283Z","caller":"traceutil/trace.go:171","msg":"trace[1863913526] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"117.516347ms","start":"2026-07-31T21:19:18.44976Z","end":"2026-07-31T21:19:18.567277Z","steps":["trace[1863913526] 'process raft request' (duration: 117.348884ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:18.567256Z","caller":"traceutil/trace.go:171","msg":"trace[1267988101] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"117.955036ms","start":"2026-07-31T21:19:18.449273Z","end":"2026-07-31T21:19:18.567228Z","steps":["trace[1267988101] 'process raft request' (duration: 117.805153ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:18.567297Z","caller":"traceutil/trace.go:171","msg":"trace[535217612] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"118.012098ms","start":"2026-07-31T21:19:18.449259Z","end":"2026-07-31T21:19:18.567271Z","steps":["trace[535217612] 'process raft request' (duration: 117.778783ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:23.781148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.416572ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-31T21:19:23.781264Z","caller":"traceutil/trace.go:171","msg":"trace[1531758644] linearizableReadLoop","detail":"{readStateIndex:413; appliedIndex:412; }","duration":"141.138198ms","start":"2026-07-31T21:19:23.640106Z","end":"2026-07-31T21:19:23.781244Z","steps":["trace[1531758644] 'read index received' (duration: 19.490662ms)","trace[1531758644] 'applied index is now lower than readState.Index' (duration: 121.646586ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:23.781304Z","caller":"traceutil/trace.go:171","msg":"trace[1475418954] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"146.126195ms","start":"2026-07-31T21:19:23.635151Z","end":"2026-07-31T21:19:23.781278Z","steps":["trace[1475418954] 'process raft request' (duration: 24.494ms)","trace[1475418954] 'compare' (duration: 121.226326ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:19:23.781461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.787491ms","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-07-31T21:19:23.781548Z","caller":"traceutil/trace.go:171","msg":"trace[245575408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:397; }","duration":"116.902924ms","start":"2026-07-31T21:19:23.664623Z","end":"2026-07-31T21:19:23.781526Z","steps":["trace[245575408] 'agreement among raft nodes before linearized reading' (duration: 116.755191ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:23.781797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.690529ms","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-07-31T21:19:23.78185Z","caller":"traceutil/trace.go:171","msg":"trace[1170750844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:397; }","duration":"141.77412ms","start":"2026-07-31T21:19:23.640062Z","end":"2026-07-31T21:19:23.781836Z","steps":["trace[1170750844] 'agreement among raft nodes before linearized reading' (duration: 141.28051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:26.088202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.732389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-31T21:19:26.088336Z","caller":"traceutil/trace.go:171","msg":"trace[449370785] linearizableReadLoop","detail":"{readStateIndex:420; appliedIndex:419; }","duration":"252.118847ms","start":"2026-07-31T21:19:25.836196Z","end":"2026-07-31T21:19:26.088315Z","steps":["trace[449370785] 'read index received' (duration: 38.115922ms)","trace[449370785] 'applied index is now lower than readState.Index' (duration: 214.001305ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:26.088437Z","caller":"traceutil/trace.go:171","msg":"trace[2137077616] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"259.35688ms","start":"2026-07-31T21:19:25.829041Z","end":"2026-07-31T21:19:26.088397Z","steps":["trace[2137077616] 'process raft request' (duration: 45.329945ms)","trace[2137077616] 'compare' (duration: 213.588556ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:19:26.088503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.28987ms","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-07-31T21:19:26.08858Z","caller":"traceutil/trace.go:171","msg":"trace[1069451652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:404; }","duration":"252.398373ms","start":"2026-07-31T21:19:25.836162Z","end":"2026-07-31T21:19:26.08856Z","steps":["trace[1069451652] 'agreement among raft nodes before linearized reading' (duration: 252.25228ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:26.304757Z","caller":"traceutil/trace.go:171","msg":"trace[1573475558] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"212.013874ms","start":"2026-07-31T21:19:26.092718Z","end":"2026-07-31T21:19:26.304732Z","steps":["trace[1573475558] 'process raft request' (duration: 157.926551ms)","trace[1573475558] 'compare' (duration: 53.965961ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:26.392443Z","caller":"traceutil/trace.go:171","msg":"trace[1627236548] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"299.611938ms","start":"2026-07-31T21:19:26.092812Z","end":"2026-07-31T21:19:26.392424Z","steps":["trace[1627236548] 'process raft request' (duration: 299.473995ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:26.392634Z","caller":"traceutil/trace.go:171","msg":"trace[1543875500] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"293.775094ms","start":"2026-07-31T21:19:26.098837Z","end":"2026-07-31T21:19:26.392612Z","steps":["trace[1543875500] 'process raft request' (duration: 293.548569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:26.392735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.716264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-31T21:19:26.392851Z","caller":"traceutil/trace.go:171","msg":"trace[2100440879] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:407; }","duration":"285.841306ms","start":"2026-07-31T21:19:26.106973Z","end":"2026-07-31T21:19:26.392814Z","steps":["trace[2100440879] 'agreement among raft nodes before linearized reading' (duration: 285.685113ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:26.393217Z","caller":"traceutil/trace.go:171","msg":"trace[1466107599] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:420; }","duration":"285.55603ms","start":"2026-07-31T21:19:26.107024Z","end":"2026-07-31T21:19:26.39258Z","steps":["trace[1466107599] 'read index received' (duration: 143.633528ms)","trace[1466107599] 'applied index is now lower than readState.Index' (duration: 141.921052ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:26.701037Z","caller":"traceutil/trace.go:171","msg":"trace[1188868459] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"218.179706ms","start":"2026-07-31T21:19:26.482817Z","end":"2026-07-31T21:19:26.700996Z","steps":["trace[1188868459] 'process raft request' (duration: 125.579967ms)","trace[1188868459] 'compare' (duration: 92.439325ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:44.333555Z","caller":"traceutil/trace.go:171","msg":"trace[778374988] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"119.043185ms","start":"2026-07-31T21:19:44.214486Z","end":"2026-07-31T21:19:44.33353Z","steps":["trace[778374988] 'process raft request' (duration: 118.884102ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:44.338892Z","caller":"traceutil/trace.go:171","msg":"trace[1061476367] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"115.0713ms","start":"2026-07-31T21:19:44.223795Z","end":"2026-07-31T21:19:44.338866Z","steps":["trace[1061476367] 'process raft request' (duration: 114.927077ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:52.596238Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790428814,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T21:19:53.191836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.749944Z","time spent":"441.88699ms","remote":"127.0.0.1:38602","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-31T21:19:53.192247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.783468ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-31T21:19:53.192393Z","caller":"traceutil/trace.go:171","msg":"trace[1302301504] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.147507062s","start":"2026-07-31T21:19:52.044862Z","end":"2026-07-31T21:19:53.192369Z","steps":["trace[1302301504] 'process raft request' (duration: 926.45244ms)","trace[1302301504] 'compare' (duration: 220.450741ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:19:53.192493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.044844Z","time spent":"1.147598643s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:19:53.212928Z","caller":"traceutil/trace.go:171","msg":"trace[851023513] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.166781341s","start":"2026-07-31T21:19:52.046115Z","end":"2026-07-31T21:19:53.212896Z","steps":["trace[851023513] 'process raft request' (duration: 1.166589178s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:53.212966Z","caller":"traceutil/trace.go:171","msg":"trace[238641720] transaction","detail":"{read_only:false; number_of_response:1; response_revision:540; }","duration":"1.161976793s","start":"2026-07-31T21:19:52.050965Z","end":"2026-07-31T21:19:53.212942Z","steps":["trace[238641720] 'process raft request' (duration: 1.161844861s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.213077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.046088Z","time spent":"1.166921283s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:53.213083Z","caller":"traceutil/trace.go:171","msg":"trace[99199352] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"1.154380035s","start":"2026-07-31T21:19:52.058683Z","end":"2026-07-31T21:19:53.213063Z","steps":["trace[99199352] 'process raft request' (duration: 1.154234672s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:53.213013Z","caller":"traceutil/trace.go:171","msg":"trace[1091871824] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.157310939s","start":"2026-07-31T21:19:52.055681Z","end":"2026-07-31T21:19:53.212992Z","steps":["trace[1091871824] 'process raft request' (duration: 1.157186687s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:53.213212Z","caller":"traceutil/trace.go:171","msg":"trace[1730137960] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"1.154248983s","start":"2026-07-31T21:19:52.058931Z","end":"2026-07-31T21:19:53.21318Z","steps":["trace[1730137960] 'process raft request' (duration: 1.154024649s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.213181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.058663Z","time spent":"1.154472027s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:53.213256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.050956Z","time spent":"1.162143357s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:19:53.213318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.058923Z","time spent":"1.154345705s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:53.213439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.055662Z","time spent":"1.157567043s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:53.213684Z","caller":"traceutil/trace.go:171","msg":"trace[101797848] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.153389498s","start":"2026-07-31T21:19:52.060276Z","end":"2026-07-31T21:19:53.213666Z","steps":["trace[101797848] 'process raft request' (duration: 1.1529611s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.21376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.060264Z","time spent":"1.153463429s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:53.214115Z","caller":"traceutil/trace.go:171","msg":"trace[871566167] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.153682942s","start":"2026-07-31T21:19:52.060416Z","end":"2026-07-31T21:19:53.214099Z","steps":["trace[871566167] 'process raft request' (duration: 1.153118092s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.214167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.060406Z","time spent":"1.153738534s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:53.214231Z","caller":"traceutil/trace.go:171","msg":"trace[1738904074] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.15300897s","start":"2026-07-31T21:19:52.061216Z","end":"2026-07-31T21:19:53.214225Z","steps":["trace[1738904074] 'process raft request' (duration: 1.152812466s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.214262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.061205Z","time spent":"1.15304399s","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:53.214419Z","caller":"traceutil/trace.go:171","msg":"trace[2108632253] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"1.146442321s","start":"2026-07-31T21:19:52.06797Z","end":"2026-07-31T21:19:53.214412Z","steps":["trace[2108632253] 'process raft request' (duration: 1.146202717s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.214472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.067952Z","time spent":"1.146489001s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:19:53.214529Z","caller":"traceutil/trace.go:171","msg":"trace[782057600] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.14641132s","start":"2026-07-31T21:19:52.068109Z","end":"2026-07-31T21:19:53.214521Z","steps":["trace[782057600] 'process raft request' (duration: 1.146185346s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:53.214565Z","caller":"traceutil/trace.go:171","msg":"trace[164343858] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.143538608s","start":"2026-07-31T21:19:52.071011Z","end":"2026-07-31T21:19:53.214549Z","steps":["trace[164343858] 'process raft request' (duration: 1.143329995s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.21458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.068096Z","time spent":"1.146457201s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:19:53.214655Z","caller":"traceutil/trace.go:171","msg":"trace[2086909907] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.146604894s","start":"2026-07-31T21:19:52.068041Z","end":"2026-07-31T21:19:53.214646Z","steps":["trace[2086909907] 'process raft request' (duration: 1.146201367s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.214657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.070991Z","time spent":"1.143622679s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:19:53.214671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.119164486s","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-07-31T21:19:53.214574Z","caller":"traceutil/trace.go:171","msg":"trace[960366925] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:560; }","duration":"1.119057873s","start":"2026-07-31T21:19:52.095497Z","end":"2026-07-31T21:19:53.214555Z","steps":["trace[960366925] 'read index received' (duration: 875.715908ms)","trace[960366925] 'applied index is now lower than readState.Index' (duration: 243.341145ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:53.214716Z","caller":"traceutil/trace.go:171","msg":"trace[283345066] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:552; }","duration":"1.119234007s","start":"2026-07-31T21:19:52.095473Z","end":"2026-07-31T21:19:53.214707Z","steps":["trace[283345066] 'agreement among raft nodes before linearized reading' (duration: 1.119133035s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.214753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.095464Z","time spent":"1.119281488s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-31T21:19:53.214753Z","caller":"traceutil/trace.go:171","msg":"trace[216632423] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"1.131220964s","start":"2026-07-31T21:19:52.083524Z","end":"2026-07-31T21:19:53.214745Z","steps":["trace[216632423] 'process raft request' (duration: 1.130871258s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:53.214774Z","caller":"traceutil/trace.go:171","msg":"trace[1245541178] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.00423185s","start":"2026-07-31T21:19:52.210532Z","end":"2026-07-31T21:19:53.214764Z","steps":["trace[1245541178] 'process raft request' (duration: 1.003961915s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.214801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.083499Z","time spent":"1.131284735s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:53.214818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.210503Z","time spent":"1.004294702s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:53.214706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.068035Z","time spent":"1.146645175s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:19:53.22856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.802758ms","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-07-31T21:19:53.228611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.608646ms","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-07-31T21:19:53.228639Z","caller":"traceutil/trace.go:171","msg":"trace[852834485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:554; }","duration":"837.653437ms","start":"2026-07-31T21:19:52.390973Z","end":"2026-07-31T21:19:53.228626Z","steps":["trace[852834485] 'agreement among raft nodes before linearized reading' (duration: 837.609306ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.228661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.390966Z","time spent":"837.690468ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-31T21:19:53.228618Z","caller":"traceutil/trace.go:171","msg":"trace[336806144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"525.88616ms","start":"2026-07-31T21:19:52.702709Z","end":"2026-07-31T21:19:53.228595Z","steps":["trace[336806144] 'agreement among raft nodes before linearized reading' (duration: 525.694376ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.22875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.702689Z","time spent":"526.051872ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-31T21:19:53.228851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.640778ms","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-07-31T21:19:53.228914Z","caller":"traceutil/trace.go:171","msg":"trace[1939575421] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"680.75112ms","start":"2026-07-31T21:19:52.548148Z","end":"2026-07-31T21:19:53.228899Z","steps":["trace[1939575421] 'agreement among raft nodes before linearized reading' (duration: 680.079148ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.228956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.548119Z","time spent":"680.829142ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-31T21:19:53.228548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.760798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:19:53.229051Z","caller":"traceutil/trace.go:171","msg":"trace[820366441] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"838.304999ms","start":"2026-07-31T21:19:52.390729Z","end":"2026-07-31T21:19:53.229034Z","steps":["trace[820366441] 'agreement among raft nodes before linearized reading' (duration: 837.468584ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:53.229078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:52.390709Z","time spent":"838.36155ms","remote":"127.0.0.1:53054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T21:19:54.408871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.500111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-31T21:19:54.409011Z","caller":"traceutil/trace.go:171","msg":"trace[1170909348] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"553.456293ms","start":"2026-07-31T21:19:53.855536Z","end":"2026-07-31T21:19:54.408992Z","steps":["trace[1170909348] 'process raft request' (duration: 308.743648ms)","trace[1170909348] 'compare' (duration: 244.361769ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:19:54.409071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:53.855512Z","time spent":"553.531075ms","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:19:54.422476Z","caller":"traceutil/trace.go:171","msg":"trace[63201058] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"555.503779ms","start":"2026-07-31T21:19:53.866956Z","end":"2026-07-31T21:19:54.42246Z","steps":["trace[63201058] 'process raft request' (duration: 555.135912ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:54.42255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:53.86693Z","time spent":"555.584931ms","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:19:54.423859Z","caller":"traceutil/trace.go:171","msg":"trace[1636287882] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"506.165879ms","start":"2026-07-31T21:19:53.917669Z","end":"2026-07-31T21:19:54.423835Z","steps":["trace[1636287882] 'process raft request' (duration: 505.10354ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:54.423973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:53.917643Z","time spent":"506.276221ms","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:19:54.924962Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790428888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T21:19:55.425584Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790428888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T21:19:55.926165Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790428888,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T21:19:56.185431Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.763322636s","expected-duration":"1s"} {"level":"info","ts":"2026-07-31T21:19:56.18611Z","caller":"traceutil/trace.go:171","msg":"trace[110905799] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.768186553s","start":"2026-07-31T21:19:54.417892Z","end":"2026-07-31T21:19:56.186078Z","steps":["trace[110905799] 'process raft request' (duration: 1.767960569s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:56.186265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:54.417865Z","time spent":"1.768319246s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:19:56.425018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000262728s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-31T21:19:56.425113Z","caller":"traceutil/trace.go:171","msg":"trace[1524356868] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00039837s","start":"2026-07-31T21:19:54.424688Z","end":"2026-07-31T21:19:56.425087Z","steps":["trace[1524356868] 'agreement among raft nodes before linearized reading' (duration: 2.000283418s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:56.425165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:54.424676Z","time spent":"2.000478322s","remote":"127.0.0.1:53064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/31 21:19:56 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-07-31T21:19:56.517475Z","caller":"traceutil/trace.go:171","msg":"trace[678697483] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:620; }","duration":"2.092731202s","start":"2026-07-31T21:19:54.424718Z","end":"2026-07-31T21:19:56.517449Z","steps":["trace[678697483] 'read index received' (duration: 1.761144117s)","trace[678697483] 'applied index is now lower than readState.Index' (duration: 331.586005ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:19:56.51763Z","caller":"traceutil/trace.go:171","msg":"trace[893432144] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.988680533s","start":"2026-07-31T21:19:54.528916Z","end":"2026-07-31T21:19:56.517597Z","steps":["trace[893432144] 'process raft request' (duration: 1.988406048s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:56.517708Z","caller":"traceutil/trace.go:171","msg":"trace[1703446452] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"2.081622523s","start":"2026-07-31T21:19:54.436038Z","end":"2026-07-31T21:19:56.51766Z","steps":["trace[1703446452] 'process raft request' (duration: 2.059312427s)","trace[1703446452] 'compare' (duration: 21.816447ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:19:56.517793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:54.528894Z","time spent":"1.988818985s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T21:19:56.517688Z","caller":"traceutil/trace.go:171","msg":"trace[488200405] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.793655211s","start":"2026-07-31T21:19:54.724006Z","end":"2026-07-31T21:19:56.517661Z","steps":["trace[488200405] 'process raft request' (duration: 1.793382496s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:56.51797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:54.436012Z","time spent":"2.081847358s","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:19:56.518082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:54.723983Z","time spent":"1.794039528s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:19:56.554542Z","caller":"traceutil/trace.go:171","msg":"trace[559538659] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"336.529914ms","start":"2026-07-31T21:19:56.217993Z","end":"2026-07-31T21:19:56.554522Z","steps":["trace[559538659] 'process raft request' (duration: 336.25348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:56.555018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:56.21796Z","time spent":"336.942502ms","remote":"127.0.0.1:53110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:19:56.560754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.05913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-31T21:19:56.560787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.320946366s","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-07-31T21:19:56.56085Z","caller":"traceutil/trace.go:171","msg":"trace[734367919] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:601; }","duration":"451.181382ms","start":"2026-07-31T21:19:56.109646Z","end":"2026-07-31T21:19:56.560827Z","steps":["trace[734367919] 'agreement among raft nodes before linearized reading' (duration: 451.033599ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:56.560943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:56.10963Z","time spent":"451.293474ms","remote":"127.0.0.1:53086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-07-31T21:19:56.561065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275719207s","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-07-31T21:19:56.561104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276602583s","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-07-31T21:19:56.561159Z","caller":"traceutil/trace.go:171","msg":"trace[2369146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"1.276669574s","start":"2026-07-31T21:19:55.284466Z","end":"2026-07-31T21:19:56.561135Z","steps":["trace[2369146] 'agreement among raft nodes before linearized reading' (duration: 1.276483161s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:56.561206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:55.284448Z","time spent":"1.276750776s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-31T21:19:56.56116Z","caller":"traceutil/trace.go:171","msg":"trace[325716484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"1.275780138s","start":"2026-07-31T21:19:55.285317Z","end":"2026-07-31T21:19:56.561098Z","steps":["trace[325716484] 'agreement among raft nodes before linearized reading' (duration: 1.275479223s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:56.561322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:55.28531Z","time spent":"1.27593949s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-31T21:19:56.561504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.175679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:19:56.561804Z","caller":"traceutil/trace.go:171","msg":"trace[2127915106] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"132.412664ms","start":"2026-07-31T21:19:56.429368Z","end":"2026-07-31T21:19:56.56178Z","steps":["trace[2127915106] 'process raft request' (duration: 125.025543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:56.560756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275399521s","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-07-31T21:19:56.567634Z","caller":"traceutil/trace.go:171","msg":"trace[305208632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"1.282278583s","start":"2026-07-31T21:19:55.285323Z","end":"2026-07-31T21:19:56.567601Z","steps":["trace[305208632] 'agreement among raft nodes before linearized reading' (duration: 1.275385461s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:56.561542Z","caller":"traceutil/trace.go:171","msg":"trace[231483351] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"128.25832ms","start":"2026-07-31T21:19:56.433271Z","end":"2026-07-31T21:19:56.561529Z","steps":["trace[231483351] 'agreement among raft nodes before linearized reading' (duration: 128.198889ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:19:56.56253Z","caller":"traceutil/trace.go:171","msg":"trace[196331648] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"1.321112359s","start":"2026-07-31T21:19:55.239755Z","end":"2026-07-31T21:19:56.560867Z","steps":["trace[196331648] 'agreement among raft nodes before linearized reading' (duration: 1.320824294s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:19:56.567823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:55.239735Z","time spent":"1.328055872s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-31T21:19:56.568207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:19:55.285316Z","time spent":"1.282863274s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-31T21:19:56.795298Z","caller":"traceutil/trace.go:171","msg":"trace[1776942220] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"105.040648ms","start":"2026-07-31T21:19:56.690225Z","end":"2026-07-31T21:19:56.795266Z","steps":["trace[1776942220] 'process raft request' (duration: 104.239793ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:00.021259Z","caller":"traceutil/trace.go:171","msg":"trace[579548838] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"207.513925ms","start":"2026-07-31T21:19:59.813215Z","end":"2026-07-31T21:20:00.020729Z","steps":["trace[579548838] 'process raft request' (duration: 200.641184ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:01.363396Z","caller":"traceutil/trace.go:171","msg":"trace[1703638272] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"395.722401ms","start":"2026-07-31T21:20:00.967644Z","end":"2026-07-31T21:20:01.363366Z","steps":["trace[1703638272] 'process raft request' (duration: 395.248853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:01.363628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:00.967613Z","time spent":"395.876144ms","remote":"127.0.0.1:53130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:20:01.974805Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790428989,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-31T21:20:02.261899Z","caller":"traceutil/trace.go:171","msg":"trace[1202975770] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"842.616685ms","start":"2026-07-31T21:20:01.419245Z","end":"2026-07-31T21:20:02.261862Z","steps":["trace[1202975770] 'process raft request' (duration: 842.478333ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:02.262084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:01.419222Z","time spent":"842.770137ms","remote":"127.0.0.1:53398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-31T21:20:02.399749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.131777ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-31T21:20:02.399836Z","caller":"traceutil/trace.go:171","msg":"trace[1169494553] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:665; }","duration":"925.561194ms","start":"2026-07-31T21:20:01.474261Z","end":"2026-07-31T21:20:02.399822Z","steps":["trace[1169494553] 'read index received' (duration: 787.443938ms)","trace[1169494553] 'applied index is now lower than readState.Index' (duration: 138.116096ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:20:02.399994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.722776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gtfxd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-31T21:20:02.400021Z","caller":"traceutil/trace.go:171","msg":"trace[273973016] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gtfxd; range_end:; response_count:1; response_revision:640; }","duration":"925.782857ms","start":"2026-07-31T21:20:01.474231Z","end":"2026-07-31T21:20:02.400014Z","steps":["trace[273973016] 'agreement among raft nodes before linearized reading' (duration: 925.657405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:02.400012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.541823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:02.400044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:01.474214Z","time spent":"925.824097ms","remote":"127.0.0.1:53228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-gtfxd\" "} {"level":"info","ts":"2026-07-31T21:20:02.400086Z","caller":"traceutil/trace.go:171","msg":"trace[1194114824] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:640; }","duration":"127.656665ms","start":"2026-07-31T21:20:02.272409Z","end":"2026-07-31T21:20:02.400065Z","steps":["trace[1194114824] 'agreement among raft nodes before linearized reading' (duration: 127.537543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:03.136592Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790428995,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T21:20:03.63705Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790428995,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T21:20:04.137825Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790428995,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T21:20:04.638692Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790428995,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T21:20:04.97891Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.564993584s","expected-duration":"1s"} {"level":"info","ts":"2026-07-31T21:20:04.980583Z","caller":"traceutil/trace.go:171","msg":"trace[792210467] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"2.566731193s","start":"2026-07-31T21:20:02.413814Z","end":"2026-07-31T21:20:04.980545Z","steps":["trace[792210467] 'process raft request' (duration: 2.565607294s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:04.980802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:02.413789Z","time spent":"2.566920217s","remote":"127.0.0.1:53228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:20:05.226776Z","caller":"traceutil/trace.go:171","msg":"trace[985591741] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"2.590961486s","start":"2026-07-31T21:20:02.635785Z","end":"2026-07-31T21:20:05.226747Z","steps":["trace[985591741] 'read index received' (duration: 2.344182899s)","trace[985591741] 'applied index is now lower than readState.Index' (duration: 246.777677ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:20:05.226992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.59119509s","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-07-31T21:20:05.22704Z","caller":"traceutil/trace.go:171","msg":"trace[373476696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"2.591279951s","start":"2026-07-31T21:20:02.635746Z","end":"2026-07-31T21:20:05.227026Z","steps":["trace[373476696] 'agreement among raft nodes before linearized reading' (duration: 2.591136448s)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:05.227018Z","caller":"traceutil/trace.go:171","msg":"trace[1114674591] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"2.418382264s","start":"2026-07-31T21:20:02.80855Z","end":"2026-07-31T21:20:05.226932Z","steps":["trace[1114674591] 'process raft request' (duration: 2.417680772s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:05.227078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:02.63573Z","time spent":"2.591339411s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-31T21:20:05.227175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.590035229s","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-07-31T21:20:05.227192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:02.808525Z","time spent":"2.418576627s","remote":"127.0.0.1:53130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036269,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:20:05.22724Z","caller":"traceutil/trace.go:171","msg":"trace[1514249751] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:642; }","duration":"2.590107901s","start":"2026-07-31T21:20:02.637113Z","end":"2026-07-31T21:20:05.227221Z","steps":["trace[1514249751] 'agreement among raft nodes before linearized reading' (duration: 2.589866676s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:05.227276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:02.637099Z","time spent":"2.590168532s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-31T21:20:05.22738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.830228973s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:05.227406Z","caller":"traceutil/trace.go:171","msg":"trace[1128946151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"1.830283735s","start":"2026-07-31T21:20:03.397113Z","end":"2026-07-31T21:20:05.227397Z","steps":["trace[1128946151] 'agreement among raft nodes before linearized reading' (duration: 1.830245984s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:05.227433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:03.397094Z","time spent":"1.830334975s","remote":"127.0.0.1:53054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T21:20:05.227508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.479384557s","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-07-31T21:20:05.227571Z","caller":"traceutil/trace.go:171","msg":"trace[1051545392] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:642; }","duration":"2.479471139s","start":"2026-07-31T21:20:02.748063Z","end":"2026-07-31T21:20:05.227534Z","steps":["trace[1051545392] 'agreement among raft nodes before linearized reading' (duration: 2.479407598s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:05.227601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:02.748037Z","time spent":"2.47955726s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-31T21:20:05.227656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.506242762s","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-07-31T21:20:05.227805Z","caller":"traceutil/trace.go:171","msg":"trace[331151989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"2.506449525s","start":"2026-07-31T21:20:02.721333Z","end":"2026-07-31T21:20:05.227782Z","steps":["trace[331151989] 'agreement among raft nodes before linearized reading' (duration: 2.50615187s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:05.229273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:02.721319Z","time spent":"2.507785877s","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-31T21:20:05.885733Z","caller":"traceutil/trace.go:171","msg":"trace[1469433554] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"179.575811ms","start":"2026-07-31T21:20:05.706128Z","end":"2026-07-31T21:20:05.885704Z","steps":["trace[1469433554] 'process raft request' (duration: 179.025681ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:07.178585Z","caller":"traceutil/trace.go:171","msg":"trace[1209112705] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"452.211189ms","start":"2026-07-31T21:20:06.726356Z","end":"2026-07-31T21:20:07.178568Z","steps":["trace[1209112705] 'process raft request' (duration: 446.532673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:07.178711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:06.726331Z","time spent":"452.31722ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:20:08.821228Z","caller":"traceutil/trace.go:171","msg":"trace[1611290] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"129.847313ms","start":"2026-07-31T21:20:08.691353Z","end":"2026-07-31T21:20:08.8212Z","steps":["trace[1611290] 'process raft request' (duration: 129.714121ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:17.84855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.253063ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-31T21:20:17.848826Z","caller":"traceutil/trace.go:171","msg":"trace[1161726831] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"544.577726ms","start":"2026-07-31T21:20:17.304224Z","end":"2026-07-31T21:20:17.848801Z","steps":["trace[1161726831] 'process raft request' (duration: 544.462465ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:17.848865Z","caller":"traceutil/trace.go:171","msg":"trace[2039289105] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:818; }","duration":"490.034963ms","start":"2026-07-31T21:20:17.358808Z","end":"2026-07-31T21:20:17.848843Z","steps":["trace[2039289105] 'read index received' (duration: 238.525806ms)","trace[2039289105] 'applied index is now lower than readState.Index' (duration: 251.508247ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:20:17.848931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:17.304187Z","time spent":"544.697408ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:20:17.848908Z","caller":"traceutil/trace.go:171","msg":"trace[1816216323] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"542.9278ms","start":"2026-07-31T21:20:17.305962Z","end":"2026-07-31T21:20:17.84889Z","steps":["trace[1816216323] 'process raft request' (duration: 542.794188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:17.849048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.232526ms","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-07-31T21:20:17.849081Z","caller":"traceutil/trace.go:171","msg":"trace[1474755138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:788; }","duration":"490.312078ms","start":"2026-07-31T21:20:17.358762Z","end":"2026-07-31T21:20:17.849074Z","steps":["trace[1474755138] 'agreement among raft nodes before linearized reading' (duration: 490.179716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:17.849105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:17.358745Z","time spent":"490.355288ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-31T21:20:17.849117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:17.305949Z","time spent":"543.070592ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:20:17.849058Z","caller":"traceutil/trace.go:171","msg":"trace[1262167745] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"544.715869ms","start":"2026-07-31T21:20:17.304034Z","end":"2026-07-31T21:20:17.84875Z","steps":["trace[1262167745] 'process raft request' (duration: 293.160751ms)","trace[1262167745] 'compare' (duration: 251.130681ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:20:17.849219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.329582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:17.849303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.754365ms","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-07-31T21:20:17.849354Z","caller":"traceutil/trace.go:171","msg":"trace[1476306982] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:788; }","duration":"313.843547ms","start":"2026-07-31T21:20:17.535496Z","end":"2026-07-31T21:20:17.849339Z","steps":["trace[1476306982] 'agreement among raft nodes before linearized reading' (duration: 313.675554ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:17.849348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:17.304018Z","time spent":"545.204896ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:20:17.849342Z","caller":"traceutil/trace.go:171","msg":"trace[145000652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:788; }","duration":"457.527436ms","start":"2026-07-31T21:20:17.391788Z","end":"2026-07-31T21:20:17.849315Z","steps":["trace[145000652] 'agreement among raft nodes before linearized reading' (duration: 457.295642ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:17.849391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:17.535475Z","time spent":"313.907788ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-31T21:20:17.849423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:17.391767Z","time spent":"457.644547ms","remote":"127.0.0.1:53054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T21:20:22.057299Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874463790429336,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-31T21:20:22.361982Z","caller":"traceutil/trace.go:171","msg":"trace[506510019] linearizableReadLoop","detail":"{readStateIndex:841; appliedIndex:839; }","duration":"805.260133ms","start":"2026-07-31T21:20:21.556696Z","end":"2026-07-31T21:20:22.361956Z","steps":["trace[506510019] 'read index received' (duration: 794.470842ms)","trace[506510019] 'applied index is now lower than readState.Index' (duration: 10.788151ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:20:22.362168Z","caller":"traceutil/trace.go:171","msg":"trace[2110361389] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"757.349999ms","start":"2026-07-31T21:20:21.604805Z","end":"2026-07-31T21:20:22.362155Z","steps":["trace[2110361389] 'process raft request' (duration: 756.915542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.362394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.501949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.3624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.604788Z","time spent":"757.41349ms","remote":"127.0.0.1:53294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T21:20:22.362439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.955123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.362428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.902713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.362452Z","caller":"traceutil/trace.go:171","msg":"trace[1205037796] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:807; }","duration":"453.57246ms","start":"2026-07-31T21:20:21.908863Z","end":"2026-07-31T21:20:22.362436Z","steps":["trace[1205037796] 'agreement among raft nodes before linearized reading' (duration: 453.482049ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.362464Z","caller":"traceutil/trace.go:171","msg":"trace[1250401075] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:807; }","duration":"575.979363ms","start":"2026-07-31T21:20:21.786477Z","end":"2026-07-31T21:20:22.362456Z","steps":["trace[1250401075] 'agreement among raft nodes before linearized reading' (duration: 575.945473ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.362472Z","caller":"traceutil/trace.go:171","msg":"trace[1680920921] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:807; }","duration":"575.956813ms","start":"2026-07-31T21:20:21.786503Z","end":"2026-07-31T21:20:22.36246Z","steps":["trace[1680920921] 'agreement among raft nodes before linearized reading' (duration: 575.893272ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.362456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.135856ms","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":"warn","ts":"2026-07-31T21:20:22.362527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.697672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.362538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.851857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.362552Z","caller":"traceutil/trace.go:171","msg":"trace[71495203] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:807; }","duration":"453.739063ms","start":"2026-07-31T21:20:21.908806Z","end":"2026-07-31T21:20:22.362545Z","steps":["trace[71495203] 'agreement among raft nodes before linearized reading' (duration: 453.703662ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.362556Z","caller":"traceutil/trace.go:171","msg":"trace[1483978771] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:807; }","duration":"126.896528ms","start":"2026-07-31T21:20:22.235654Z","end":"2026-07-31T21:20:22.36255Z","steps":["trace[1483978771] 'agreement among raft nodes before linearized reading' (duration: 126.871057ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.362572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.908798Z","time spent":"453.768973ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.362569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.841748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-6p2dp\" ","response":"range_response_count:1 size:5047"} {"level":"info","ts":"2026-07-31T21:20:22.362562Z","caller":"traceutil/trace.go:171","msg":"trace[1637946168] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:807; }","duration":"109.273378ms","start":"2026-07-31T21:20:22.253271Z","end":"2026-07-31T21:20:22.362545Z","steps":["trace[1637946168] 'agreement among raft nodes before linearized reading' (duration: 109.087525ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.362614Z","caller":"traceutil/trace.go:171","msg":"trace[1806376714] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-6p2dp; range_end:; response_count:1; response_revision:807; }","duration":"640.90547ms","start":"2026-07-31T21:20:21.721702Z","end":"2026-07-31T21:20:22.362608Z","steps":["trace[1806376714] 'agreement among raft nodes before linearized reading' (duration: 640.796038ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.362636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.72169Z","time spent":"640.9377ms","remote":"127.0.0.1:53228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5070,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-6p2dp\" "} {"level":"warn","ts":"2026-07-31T21:20:22.362703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.828679ms","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-07-31T21:20:22.36272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.108271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.362743Z","caller":"traceutil/trace.go:171","msg":"trace[1660232054] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:807; }","duration":"127.161273ms","start":"2026-07-31T21:20:22.235575Z","end":"2026-07-31T21:20:22.362737Z","steps":["trace[1660232054] 'agreement among raft nodes before linearized reading' (duration: 127.124352ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.362746Z","caller":"traceutil/trace.go:171","msg":"trace[1043355773] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:807; }","duration":"469.870369ms","start":"2026-07-31T21:20:21.892853Z","end":"2026-07-31T21:20:22.362723Z","steps":["trace[1043355773] 'agreement among raft nodes before linearized reading' (duration: 469.832649ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.362767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.892844Z","time spent":"469.9165ms","remote":"127.0.0.1:51122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-31T21:20:22.362778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.022524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.362809Z","caller":"traceutil/trace.go:171","msg":"trace[655721773] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:807; }","duration":"752.082615ms","start":"2026-07-31T21:20:21.610716Z","end":"2026-07-31T21:20:22.362799Z","steps":["trace[655721773] 'agreement among raft nodes before linearized reading' (duration: 752.021644ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.36284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.610679Z","time spent":"752.153396ms","remote":"127.0.0.1:51074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-07-31T21:20:22.362388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.65405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.362919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.86049ms","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":"warn","ts":"2026-07-31T21:20:22.362911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.212298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.363015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.537814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.363021Z","caller":"traceutil/trace.go:171","msg":"trace[1340192800] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:807; }","duration":"806.342281ms","start":"2026-07-31T21:20:21.556662Z","end":"2026-07-31T21:20:22.363004Z","steps":["trace[1340192800] 'agreement among raft nodes before linearized reading' (duration: 806.210989ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.36318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.107043ms","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":"warn","ts":"2026-07-31T21:20:22.363194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.556649Z","time spent":"806.528835ms","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-31T21:20:22.363181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.269482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.36323Z","caller":"traceutil/trace.go:171","msg":"trace[2105353166] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:807; }","duration":"729.335813ms","start":"2026-07-31T21:20:21.633889Z","end":"2026-07-31T21:20:22.363225Z","steps":["trace[2105353166] 'agreement among raft nodes before linearized reading' (duration: 729.271462ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.633881Z","time spent":"729.362824ms","remote":"127.0.0.1:51084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-07-31T21:20:22.363302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.465114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.363324Z","caller":"traceutil/trace.go:171","msg":"trace[1884114229] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:807; }","duration":"729.518106ms","start":"2026-07-31T21:20:21.6338Z","end":"2026-07-31T21:20:22.363318Z","steps":["trace[1884114229] 'agreement among raft nodes before linearized reading' (duration: 729.390974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.633788Z","time spent":"729.548016ms","remote":"127.0.0.1:51084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.363354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.112745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.363373Z","caller":"traceutil/trace.go:171","msg":"trace[790046011] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:807; }","duration":"554.150285ms","start":"2026-07-31T21:20:21.809217Z","end":"2026-07-31T21:20:22.363367Z","steps":["trace[790046011] 'agreement among raft nodes before linearized reading' (duration: 554.118585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.36334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.919539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.363393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.809211Z","time spent":"554.176746ms","remote":"127.0.0.1:51106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-31T21:20:22.36343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.722648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.363448Z","caller":"traceutil/trace.go:171","msg":"trace[1304608331] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:807; }","duration":"729.76244ms","start":"2026-07-31T21:20:21.63368Z","end":"2026-07-31T21:20:22.363442Z","steps":["trace[1304608331] 'agreement among raft nodes before linearized reading' (duration: 729.733849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.633668Z","time spent":"729.80299ms","remote":"127.0.0.1:51084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"info","ts":"2026-07-31T21:20:22.363438Z","caller":"traceutil/trace.go:171","msg":"trace[1627582943] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:807; }","duration":"752.99718ms","start":"2026-07-31T21:20:21.610407Z","end":"2026-07-31T21:20:22.363404Z","steps":["trace[1627582943] 'agreement among raft nodes before linearized reading' (duration: 752.741866ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.36348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.279717ms","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-07-31T21:20:22.3635Z","caller":"traceutil/trace.go:171","msg":"trace[1649432409] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:807; }","duration":"554.300817ms","start":"2026-07-31T21:20:21.809194Z","end":"2026-07-31T21:20:22.363495Z","steps":["trace[1649432409] 'agreement among raft nodes before linearized reading' (duration: 554.271937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.809138Z","time spent":"554.376679ms","remote":"127.0.0.1:51106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.363514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.610393Z","time spent":"753.107022ms","remote":"127.0.0.1:51074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-07-31T21:20:22.36362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.329069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.363644Z","caller":"traceutil/trace.go:171","msg":"trace[269827630] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:807; }","duration":"576.361641ms","start":"2026-07-31T21:20:21.787276Z","end":"2026-07-31T21:20:22.363638Z","steps":["trace[269827630] 'agreement among raft nodes before linearized reading' (duration: 576.32948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.787272Z","time spent":"576.385441ms","remote":"127.0.0.1:51100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"info","ts":"2026-07-31T21:20:22.362955Z","caller":"traceutil/trace.go:171","msg":"trace[838342594] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:807; }","duration":"382.909431ms","start":"2026-07-31T21:20:21.980038Z","end":"2026-07-31T21:20:22.362947Z","steps":["trace[838342594] 'agreement among raft nodes before linearized reading' (duration: 382.86551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.980032Z","time spent":"383.755275ms","remote":"127.0.0.1:51150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.363762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.719759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.363819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.698468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.363865Z","caller":"traceutil/trace.go:171","msg":"trace[1024869863] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:807; }","duration":"454.737929ms","start":"2026-07-31T21:20:21.909103Z","end":"2026-07-31T21:20:22.363841Z","steps":["trace[1024869863] 'agreement among raft nodes before linearized reading' (duration: 454.696748ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.909097Z","time spent":"454.78752ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-31T21:20:22.362496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.786498Z","time spent":"575.991924ms","remote":"127.0.0.1:51100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-07-31T21:20:22.363776Z","caller":"traceutil/trace.go:171","msg":"trace[1433363697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:807; }","duration":"806.428812ms","start":"2026-07-31T21:20:21.556665Z","end":"2026-07-31T21:20:22.363094Z","steps":["trace[1433363697] 'agreement among raft nodes before linearized reading' (duration: 805.571759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.362515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.969043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.362869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.187565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.362894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.272531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.362898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.330456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.362986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.967342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:20:22.36299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.83899ms","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-07-31T21:20:22.36303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.625468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.364256Z","caller":"traceutil/trace.go:171","msg":"trace[256608213] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:807; }","duration":"252.595017ms","start":"2026-07-31T21:20:22.111656Z","end":"2026-07-31T21:20:22.364251Z","steps":["trace[256608213] 'agreement among raft nodes before linearized reading' (duration: 251.196824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.364299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.629144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.364039Z","caller":"traceutil/trace.go:171","msg":"trace[241664260] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:807; }","duration":"424.956594ms","start":"2026-07-31T21:20:21.93901Z","end":"2026-07-31T21:20:22.363967Z","steps":["trace[241664260] 'agreement among raft nodes before linearized reading' (duration: 424.644229ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.364392Z","caller":"traceutil/trace.go:171","msg":"trace[958695870] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:807; }","duration":"104.726785ms","start":"2026-07-31T21:20:22.259632Z","end":"2026-07-31T21:20:22.364359Z","steps":["trace[958695870] 'agreement among raft nodes before linearized reading' (duration: 104.635603ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.364434Z","caller":"traceutil/trace.go:171","msg":"trace[1140629914] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:807; }","duration":"384.436336ms","start":"2026-07-31T21:20:21.97999Z","end":"2026-07-31T21:20:22.364427Z","steps":["trace[1140629914] 'agreement among raft nodes before linearized reading' (duration: 382.978172ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.395661ms","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-07-31T21:20:22.364469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.979979Z","time spent":"384.481176ms","remote":"127.0.0.1:51150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-07-31T21:20:22.364504Z","caller":"traceutil/trace.go:171","msg":"trace[1041401344] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:807; }","duration":"488.376935ms","start":"2026-07-31T21:20:21.876117Z","end":"2026-07-31T21:20:22.364494Z","steps":["trace[1041401344] 'agreement among raft nodes before linearized reading' (duration: 486.82254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.362483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.786429Z","time spent":"576.047135ms","remote":"127.0.0.1:51100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"info","ts":"2026-07-31T21:20:22.364401Z","caller":"traceutil/trace.go:171","msg":"trace[792446222] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:807; }","duration":"471.821871ms","start":"2026-07-31T21:20:21.892528Z","end":"2026-07-31T21:20:22.36435Z","steps":["trace[792446222] 'agreement among raft nodes before linearized reading' (duration: 470.352607ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.363208Z","caller":"traceutil/trace.go:171","msg":"trace[549332427] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:807; }","duration":"552.171615ms","start":"2026-07-31T21:20:21.811029Z","end":"2026-07-31T21:20:22.363201Z","steps":["trace[549332427] 'agreement among raft nodes before linearized reading' (duration: 552.139034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.364613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.876097Z","time spent":"488.509707ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-31T21:20:22.364704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.811008Z","time spent":"553.624537ms","remote":"127.0.0.1:51106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-07-31T21:20:22.364651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.939002Z","time spent":"425.37201ms","remote":"127.0.0.1:51140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-07-31T21:20:22.364471Z","caller":"traceutil/trace.go:171","msg":"trace[750705420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:807; }","duration":"490.837284ms","start":"2026-07-31T21:20:21.873626Z","end":"2026-07-31T21:20:22.364463Z","steps":["trace[750705420] 'agreement among raft nodes before linearized reading' (duration: 489.375211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.364873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.87362Z","time spent":"491.245381ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-31T21:20:22.364825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.892506Z","time spent":"472.244207ms","remote":"127.0.0.1:51122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-31T21:20:22.363118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.702155ms","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-07-31T21:20:22.364322Z","caller":"traceutil/trace.go:171","msg":"trace[772808207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:807; }","duration":"779.97513ms","start":"2026-07-31T21:20:21.58433Z","end":"2026-07-31T21:20:22.364305Z","steps":["trace[772808207] 'agreement among raft nodes before linearized reading' (duration: 778.629778ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.364975Z","caller":"traceutil/trace.go:171","msg":"trace[378894844] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:807; }","duration":"697.579104ms","start":"2026-07-31T21:20:21.667387Z","end":"2026-07-31T21:20:22.364966Z","steps":["trace[378894844] 'agreement among raft nodes before linearized reading' (duration: 695.703844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.364992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.58431Z","time spent":"780.671272ms","remote":"127.0.0.1:51066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-31T21:20:22.364999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.667379Z","time spent":"697.612236ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.363142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.797727ms","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-07-31T21:20:22.36511Z","caller":"traceutil/trace.go:171","msg":"trace[231852092] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:807; }","duration":"697.773577ms","start":"2026-07-31T21:20:21.667328Z","end":"2026-07-31T21:20:22.365102Z","steps":["trace[231852092] 'agreement among raft nodes before linearized reading' (duration: 695.800927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.20721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-31T21:20:22.365144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.667321Z","time spent":"697.813138ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-07-31T21:20:22.365151Z","caller":"traceutil/trace.go:171","msg":"trace[1598124207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:807; }","duration":"503.244892ms","start":"2026-07-31T21:20:21.8619Z","end":"2026-07-31T21:20:22.365145Z","steps":["trace[1598124207] 'agreement among raft nodes before linearized reading' (duration: 501.225691ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.362924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.435288ms","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-07-31T21:20:22.363038Z","caller":"traceutil/trace.go:171","msg":"trace[1314241948] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:807; }","duration":"397.583955ms","start":"2026-07-31T21:20:21.965448Z","end":"2026-07-31T21:20:22.363032Z","steps":["trace[1314241948] 'agreement among raft nodes before linearized reading' (duration: 397.551925ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:20:22.365178Z","caller":"traceutil/trace.go:171","msg":"trace[1747877200] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:807; }","duration":"472.701334ms","start":"2026-07-31T21:20:21.89247Z","end":"2026-07-31T21:20:22.365171Z","steps":["trace[1747877200] 'agreement among raft nodes before linearized reading' (duration: 470.441408ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.365205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.892461Z","time spent":"472.735586ms","remote":"127.0.0.1:51122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.364125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.516567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.365259Z","caller":"traceutil/trace.go:171","msg":"trace[1971436577] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:807; }","duration":"400.654905ms","start":"2026-07-31T21:20:21.964599Z","end":"2026-07-31T21:20:22.365254Z","steps":["trace[1971436577] 'agreement among raft nodes before linearized reading' (duration: 399.505357ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.365286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.964557Z","time spent":"400.722796ms","remote":"127.0.0.1:51148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.364153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.90775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.365483Z","caller":"traceutil/trace.go:171","msg":"trace[584032573] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:807; }","duration":"781.23761ms","start":"2026-07-31T21:20:21.58424Z","end":"2026-07-31T21:20:22.365477Z","steps":["trace[584032573] 'agreement among raft nodes before linearized reading' (duration: 779.900249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.365507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.584221Z","time spent":"781.276552ms","remote":"127.0.0.1:51066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.364173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.511602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.365599Z","caller":"traceutil/trace.go:171","msg":"trace[1878309162] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:807; }","duration":"105.953564ms","start":"2026-07-31T21:20:22.25964Z","end":"2026-07-31T21:20:22.365594Z","steps":["trace[1878309162] 'agreement among raft nodes before linearized reading' (duration: 104.516762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.364178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.88017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.36577Z","caller":"traceutil/trace.go:171","msg":"trace[1299299212] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:807; }","duration":"781.487154ms","start":"2026-07-31T21:20:21.584237Z","end":"2026-07-31T21:20:22.365725Z","steps":["trace[1299299212] 'agreement among raft nodes before linearized reading' (duration: 779.92619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.365796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.584218Z","time spent":"781.570186ms","remote":"127.0.0.1:51066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-07-31T21:20:22.364196Z","caller":"traceutil/trace.go:171","msg":"trace[304636286] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:807; }","duration":"127.682181ms","start":"2026-07-31T21:20:22.236507Z","end":"2026-07-31T21:20:22.364189Z","steps":["trace[304636286] 'agreement among raft nodes before linearized reading' (duration: 125.992564ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.362486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.908843Z","time spent":"453.633081ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-31T21:20:22.364217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.556645Z","time spent":"807.566391ms","remote":"127.0.0.1:51050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-07-31T21:20:22.36424Z","caller":"traceutil/trace.go:171","msg":"trace[1128075710] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:807; }","duration":"383.630984ms","start":"2026-07-31T21:20:21.980603Z","end":"2026-07-31T21:20:22.364234Z","steps":["trace[1128075710] 'agreement among raft nodes before linearized reading' (duration: 382.275982ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.366027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.980596Z","time spent":"385.418443ms","remote":"127.0.0.1:51150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-07-31T21:20:22.363076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.5031ms","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-07-31T21:20:22.366123Z","caller":"traceutil/trace.go:171","msg":"trace[1058886121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:807; }","duration":"495.55637ms","start":"2026-07-31T21:20:21.870559Z","end":"2026-07-31T21:20:22.366115Z","steps":["trace[1058886121] 'agreement among raft nodes before linearized reading' (duration: 492.4871ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.366145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.870553Z","time spent":"495.58532ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-31T21:20:22.363075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.084935ms","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-07-31T21:20:22.366278Z","caller":"traceutil/trace.go:171","msg":"trace[69836007] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:807; }","duration":"698.354727ms","start":"2026-07-31T21:20:21.667908Z","end":"2026-07-31T21:20:22.366263Z","steps":["trace[69836007] 'agreement among raft nodes before linearized reading' (duration: 695.089225ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.366359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.667898Z","time spent":"698.441699ms","remote":"127.0.0.1:51094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-31T21:20:22.364439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.688225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.366575Z","caller":"traceutil/trace.go:171","msg":"trace[769983879] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:807; }","duration":"106.835419ms","start":"2026-07-31T21:20:22.259728Z","end":"2026-07-31T21:20:22.366563Z","steps":["trace[769983879] 'agreement among raft nodes before linearized reading' (duration: 104.692125ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.363116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.531277ms","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-07-31T21:20:22.366934Z","caller":"traceutil/trace.go:171","msg":"trace[1910372657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:807; }","duration":"500.348947ms","start":"2026-07-31T21:20:21.866571Z","end":"2026-07-31T21:20:22.36692Z","steps":["trace[1910372657] 'agreement among raft nodes before linearized reading' (duration: 496.515325ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.367034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.866567Z","time spent":"500.450588ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-31T21:20:22.36455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.35001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.36719Z","caller":"traceutil/trace.go:171","msg":"trace[238510392] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:807; }","duration":"428.009702ms","start":"2026-07-31T21:20:21.939169Z","end":"2026-07-31T21:20:22.367179Z","steps":["trace[238510392] 'agreement among raft nodes before linearized reading' (duration: 425.356039ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.367231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.939157Z","time spent":"428.058922ms","remote":"127.0.0.1:51140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.363113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.655174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.367356Z","caller":"traceutil/trace.go:171","msg":"trace[286809758] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:807; }","duration":"756.915611ms","start":"2026-07-31T21:20:21.610429Z","end":"2026-07-31T21:20:22.367345Z","steps":["trace[286809758] 'agreement among raft nodes before linearized reading' (duration: 752.632973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.367396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.610424Z","time spent":"756.960312ms","remote":"127.0.0.1:51074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-07-31T21:20:22.365174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.861872Z","time spent":"503.295222ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-31T21:20:22.36284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.137804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.367719Z","caller":"traceutil/trace.go:171","msg":"trace[201552391] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:807; }","duration":"256.050952ms","start":"2026-07-31T21:20:22.111654Z","end":"2026-07-31T21:20:22.367705Z","steps":["trace[201552391] 'agreement among raft nodes before linearized reading' (duration: 251.167084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.364141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.519717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:20:22.367928Z","caller":"traceutil/trace.go:171","msg":"trace[30927458] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:807; }","duration":"403.323917ms","start":"2026-07-31T21:20:21.964593Z","end":"2026-07-31T21:20:22.367917Z","steps":["trace[30927458] 'agreement among raft nodes before linearized reading' (duration: 399.528037ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:20:22.367975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.964582Z","time spent":"403.379558ms","remote":"127.0.0.1:51148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-31T21:20:22.365274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:20:21.965437Z","time spent":"399.79127ms","remote":"127.0.0.1:51140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-07-31T21:21:14.774835Z","caller":"traceutil/trace.go:171","msg":"trace[1192011088] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"143.776259ms","start":"2026-07-31T21:21:14.631029Z","end":"2026-07-31T21:21:14.774805Z","steps":["trace[1192011088] 'process raft request' (duration: 142.133436ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:21:33.144866Z","caller":"traceutil/trace.go:171","msg":"trace[318203965] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"105.414064ms","start":"2026-07-31T21:21:33.039422Z","end":"2026-07-31T21:21:33.144837Z","steps":["trace[318203965] 'process raft request' (duration: 105.211921ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:22:00.541168Z","caller":"traceutil/trace.go:171","msg":"trace[1962950524] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1337; }","duration":"150.748868ms","start":"2026-07-31T21:22:00.390393Z","end":"2026-07-31T21:22:00.541142Z","steps":["trace[1962950524] 'read index received' (duration: 109.248289ms)","trace[1962950524] 'applied index is now lower than readState.Index' (duration: 41.499489ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:22:00.541603Z","caller":"traceutil/trace.go:171","msg":"trace[644934023] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"173.818708ms","start":"2026-07-31T21:22:00.367763Z","end":"2026-07-31T21:22:00.541582Z","steps":["trace[644934023] 'process raft request' (duration: 131.982624ms)","trace[644934023] 'compare' (duration: 41.282887ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:22:00.541642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.902336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T21:22:00.541715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.308645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:22:00.541762Z","caller":"traceutil/trace.go:171","msg":"trace[2045181711] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1281; }","duration":"143.049888ms","start":"2026-07-31T21:22:00.398684Z","end":"2026-07-31T21:22:00.541734Z","steps":["trace[2045181711] 'agreement among raft nodes before linearized reading' (duration: 142.721394ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:22:00.541809Z","caller":"traceutil/trace.go:171","msg":"trace[1604141746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1281; }","duration":"151.451767ms","start":"2026-07-31T21:22:00.390337Z","end":"2026-07-31T21:22:00.541788Z","steps":["trace[1604141746] 'agreement among raft nodes before linearized reading' (duration: 151.299575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:22:16.59289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.840035ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-31T21:22:16.593Z","caller":"traceutil/trace.go:171","msg":"trace[492026110] linearizableReadLoop","detail":"{readStateIndex:1423; appliedIndex:1422; }","duration":"202.117809ms","start":"2026-07-31T21:22:16.390865Z","end":"2026-07-31T21:22:16.592983Z","steps":["trace[492026110] 'read index received' (duration: 60.962µs)","trace[492026110] 'applied index is now lower than readState.Index' (duration: 202.053627ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:22:16.593172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.314004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T21:22:16.593205Z","caller":"traceutil/trace.go:171","msg":"trace[1908379055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1361; }","duration":"202.346905ms","start":"2026-07-31T21:22:16.390849Z","end":"2026-07-31T21:22:16.593196Z","steps":["trace[1908379055] 'agreement among raft nodes before linearized reading' (duration: 202.236272ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:22:16.593349Z","caller":"traceutil/trace.go:171","msg":"trace[1234104442] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"456.456574ms","start":"2026-07-31T21:22:16.136836Z","end":"2026-07-31T21:22:16.593292Z","steps":["trace[1234104442] 'process raft request' (duration: 156.130764ms)","trace[1234104442] 'compare' (duration: 299.554657ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T21:22:16.593625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T21:22:16.136815Z","time spent":"456.612768ms","remote":"127.0.0.1:53086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T21:22:19.44098Z","caller":"traceutil/trace.go:171","msg":"trace[790649883] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"182.367581ms","start":"2026-07-31T21:22:19.25859Z","end":"2026-07-31T21:22:19.440958Z","steps":["trace[790649883] 'process raft request' (duration: 182.232707ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:22:19.458607Z","caller":"traceutil/trace.go:171","msg":"trace[2136548617] linearizableReadLoop","detail":"{readStateIndex:1436; appliedIndex:1434; }","duration":"106.62581ms","start":"2026-07-31T21:22:19.351964Z","end":"2026-07-31T21:22:19.45859Z","steps":["trace[2136548617] 'read index received' (duration: 88.951883ms)","trace[2136548617] 'applied index is now lower than readState.Index' (duration: 17.672866ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:22:19.458654Z","caller":"traceutil/trace.go:171","msg":"trace[833031830] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"120.494631ms","start":"2026-07-31T21:22:19.338135Z","end":"2026-07-31T21:22:19.45863Z","steps":["trace[833031830] 'process raft request' (duration: 118.296144ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:22:19.458776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.807295ms","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-07-31T21:22:19.458802Z","caller":"traceutil/trace.go:171","msg":"trace[986891395] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1374; }","duration":"106.887568ms","start":"2026-07-31T21:22:19.351908Z","end":"2026-07-31T21:22:19.458796Z","steps":["trace[986891395] 'agreement among raft nodes before linearized reading' (duration: 106.776414ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:22:23.622936Z","caller":"traceutil/trace.go:171","msg":"trace[1151014537] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"164.740544ms","start":"2026-07-31T21:22:23.458169Z","end":"2026-07-31T21:22:23.62291Z","steps":["trace[1151014537] 'process raft request' (duration: 164.565829ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:22:23.628589Z","caller":"traceutil/trace.go:171","msg":"trace[1057827300] linearizableReadLoop","detail":"{readStateIndex:1452; appliedIndex:1450; }","duration":"157.092716ms","start":"2026-07-31T21:22:23.47147Z","end":"2026-07-31T21:22:23.628563Z","steps":["trace[1057827300] 'read index received' (duration: 151.340744ms)","trace[1057827300] 'applied index is now lower than readState.Index' (duration: 5.750582ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T21:22:23.628725Z","caller":"traceutil/trace.go:171","msg":"trace[1422455876] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"159.905359ms","start":"2026-07-31T21:22:23.468774Z","end":"2026-07-31T21:22:23.628679Z","steps":["trace[1422455876] 'process raft request' (duration: 159.633931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:22:23.62885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.541331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:1 size:1930"} {"level":"info","ts":"2026-07-31T21:22:23.628891Z","caller":"traceutil/trace.go:171","msg":"trace[342714728] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:1; response_revision:1389; }","duration":"142.618933ms","start":"2026-07-31T21:22:23.486261Z","end":"2026-07-31T21:22:23.62888Z","steps":["trace[342714728] 'agreement among raft nodes before linearized reading' (duration: 142.558051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:22:23.628782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.287231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:1 size:2025"} {"level":"info","ts":"2026-07-31T21:22:23.629011Z","caller":"traceutil/trace.go:171","msg":"trace[262633459] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:1; response_revision:1389; }","duration":"157.56616ms","start":"2026-07-31T21:22:23.471409Z","end":"2026-07-31T21:22:23.628976Z","steps":["trace[262633459] 'agreement among raft nodes before linearized reading' (duration: 157.285962ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T21:22:23.629128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.729048ms","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-07-31T21:22:23.629153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.765443ms","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-07-31T21:22:23.629175Z","caller":"traceutil/trace.go:171","msg":"trace[662078510] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1389; }","duration":"127.840691ms","start":"2026-07-31T21:22:23.50132Z","end":"2026-07-31T21:22:23.629161Z","steps":["trace[662078510] 'agreement among raft nodes before linearized reading' (duration: 127.650036ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T21:22:23.62923Z","caller":"traceutil/trace.go:171","msg":"trace[2047955584] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1389; }","duration":"104.888746ms","start":"2026-07-31T21:22:23.524325Z","end":"2026-07-31T21:22:23.629214Z","steps":["trace[2047955584] 'agreement among raft nodes before linearized reading' (duration: 104.618088ms)"],"step_count":1}