{"level":"warn","ts":"2026-05-08T18:12:17.16332Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T18:12:17.163448Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-08T18:12:17.163768Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T18:12:17.163801Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-05-08T18:12:17.163903Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T18:12:17.165273Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-05-08T18:12:17.165511Z","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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-08T18:12:17.171588Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.625744ms"} {"level":"info","ts":"2026-05-08T18:12:17.182383Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-05-08T18:12:17.182606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T18:12:17.182643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-05-08T18:12:17.182719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T18:12:17.182735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-05-08T18:12:17.182829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-05-08T18:12:17.189273Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T18:12:17.190581Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T18:12:17.191679Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-08T18:12:17.193853Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T18:12:17.194031Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T18:12:17.194205Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T18:12:17.194265Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T18:12:17.194276Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T18:12:17.196209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-05-08T18:12:17.196397Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-05-08T18:12:17.200085Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T18:12:17.200256Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-08T18:12:17.200346Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-08T18:12:17.200453Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T18:12:17.200703Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T18:12:17.983469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T18:12:17.98353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T18:12:17.983576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-05-08T18:12:17.983596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-05-08T18:12:17.983607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-08T18:12:17.983623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-05-08T18:12:17.983637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-08T18:12:17.985332Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T18:12:17.985339Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T18:12:17.985382Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T18:12:17.985356Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T18:12:17.985819Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T18:12:17.985899Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T18:12:17.986693Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T18:12:17.986829Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T18:12:17.98687Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T18:12:17.988977Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-05-08T18:12:17.989231Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-08T18:12:19.708371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.079483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-08T18:12:19.708469Z","caller":"traceutil/trace.go:171","msg":"trace[460884658] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"142.105694ms","start":"2026-05-08T18:12:19.566331Z","end":"2026-05-08T18:12:19.708437Z","steps":["trace[460884658] 'process raft request' (duration: 97.190164ms)","trace[460884658] 'compare' (duration: 44.469424ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:19.708609Z","caller":"traceutil/trace.go:171","msg":"trace[157964377] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:29; }","duration":"142.360977ms","start":"2026-05-08T18:12:19.566222Z","end":"2026-05-08T18:12:19.708583Z","steps":["trace[157964377] 'agreement among raft nodes before linearized reading' (duration: 142.054263ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:19.70876Z","caller":"traceutil/trace.go:171","msg":"trace[2090660640] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"141.674237ms","start":"2026-05-08T18:12:19.567048Z","end":"2026-05-08T18:12:19.708722Z","steps":["trace[2090660640] 'process raft request' (duration: 141.11798ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:19.709026Z","caller":"traceutil/trace.go:171","msg":"trace[1902343458] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"141.535996ms","start":"2026-05-08T18:12:19.567475Z","end":"2026-05-08T18:12:19.709011Z","steps":["trace[1902343458] 'process raft request' (duration: 140.728906ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:19.709211Z","caller":"traceutil/trace.go:171","msg":"trace[1223617944] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"142.234455ms","start":"2026-05-08T18:12:19.566963Z","end":"2026-05-08T18:12:19.709197Z","steps":["trace[1223617944] 'process raft request' (duration: 141.152591ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:19.739816Z","caller":"traceutil/trace.go:171","msg":"trace[386320517] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"113.255941ms","start":"2026-05-08T18:12:19.626537Z","end":"2026-05-08T18:12:19.739793Z","steps":["trace[386320517] 'process raft request' (duration: 113.226001ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:19.739836Z","caller":"traceutil/trace.go:171","msg":"trace[147691399] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"113.525154ms","start":"2026-05-08T18:12:19.62626Z","end":"2026-05-08T18:12:19.739785Z","steps":["trace[147691399] 'process raft request' (duration: 113.397233ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:19.739883Z","caller":"traceutil/trace.go:171","msg":"trace[2057228324] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"113.517134ms","start":"2026-05-08T18:12:19.626346Z","end":"2026-05-08T18:12:19.739863Z","steps":["trace[2057228324] 'process raft request' (duration: 113.348342ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:19.740028Z","caller":"traceutil/trace.go:171","msg":"trace[928387860] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"113.567475ms","start":"2026-05-08T18:12:19.626443Z","end":"2026-05-08T18:12:19.74001Z","steps":["trace[928387860] 'process raft request' (duration: 113.294652ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:19.740026Z","caller":"traceutil/trace.go:171","msg":"trace[1096329116] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"114.401776ms","start":"2026-05-08T18:12:19.62545Z","end":"2026-05-08T18:12:19.739852Z","steps":["trace[1096329116] 'process raft request' (duration: 114.108342ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:20.098873Z","caller":"traceutil/trace.go:171","msg":"trace[1885722429] linearizableReadLoop","detail":"{readStateIndex:54; appliedIndex:52; }","duration":"167.697971ms","start":"2026-05-08T18:12:19.931157Z","end":"2026-05-08T18:12:20.098855Z","steps":["trace[1885722429] 'read index received' (duration: 124.127415ms)","trace[1885722429] 'applied index is now lower than readState.Index' (duration: 43.569796ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:20.099187Z","caller":"traceutil/trace.go:171","msg":"trace[779626496] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"258.665584ms","start":"2026-05-08T18:12:19.840513Z","end":"2026-05-08T18:12:20.099179Z","steps":["trace[779626496] 'process raft request' (duration: 214.750964ms)","trace[779626496] 'compare' (duration: 43.457094ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:20.099318Z","caller":"traceutil/trace.go:171","msg":"trace[546331906] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"257.181636ms","start":"2026-05-08T18:12:19.84213Z","end":"2026-05-08T18:12:20.099312Z","steps":["trace[546331906] 'process raft request' (duration: 256.68772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:20.099417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.255068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-08T18:12:20.099439Z","caller":"traceutil/trace.go:171","msg":"trace[759660708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:50; }","duration":"168.322479ms","start":"2026-05-08T18:12:19.931109Z","end":"2026-05-08T18:12:20.099432Z","steps":["trace[759660708] 'agreement among raft nodes before linearized reading' (duration: 168.276819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:20.099542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.975615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-08T18:12:20.099562Z","caller":"traceutil/trace.go:171","msg":"trace[2025374180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:50; }","duration":"168.026575ms","start":"2026-05-08T18:12:19.931531Z","end":"2026-05-08T18:12:20.099557Z","steps":["trace[2025374180] 'agreement among raft nodes before linearized reading' (duration: 167.991995ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:21.068977Z","caller":"traceutil/trace.go:171","msg":"trace[1658383446] transaction","detail":"{read_only:false; response_revision:96; number_of_response:1; }","duration":"119.65309ms","start":"2026-05-08T18:12:20.949296Z","end":"2026-05-08T18:12:21.068949Z","steps":["trace[1658383446] 'process raft request' (duration: 54.06452ms)","trace[1658383446] 'compare' (duration: 65.429198ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:21.424857Z","caller":"traceutil/trace.go:171","msg":"trace[89170873] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"125.307564ms","start":"2026-05-08T18:12:21.299516Z","end":"2026-05-08T18:12:21.424823Z","steps":["trace[89170873] 'process raft request' (duration: 70.266178ms)","trace[89170873] 'compare' (duration: 54.904904ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:22.086033Z","caller":"traceutil/trace.go:171","msg":"trace[1041195043] transaction","detail":"{read_only:false; response_revision:121; number_of_response:1; }","duration":"131.860606ms","start":"2026-05-08T18:12:21.954138Z","end":"2026-05-08T18:12:22.085998Z","steps":["trace[1041195043] 'process raft request' (duration: 101.298384ms)","trace[1041195043] 'compare' (duration: 30.39988ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:22.243265Z","caller":"traceutil/trace.go:171","msg":"trace[815092680] transaction","detail":"{read_only:false; response_revision:125; number_of_response:1; }","duration":"101.048734ms","start":"2026-05-08T18:12:22.142182Z","end":"2026-05-08T18:12:22.243231Z","steps":["trace[815092680] 'process raft request' (duration: 87.096859ms)","trace[815092680] 'compare' (duration: 13.828113ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:24.950966Z","caller":"traceutil/trace.go:171","msg":"trace[1159957458] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"134.819205ms","start":"2026-05-08T18:12:24.816115Z","end":"2026-05-08T18:12:24.950934Z","steps":["trace[1159957458] 'process raft request' (duration: 47.131369ms)","trace[1159957458] 'compare' (duration: 87.460943ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:24.950966Z","caller":"traceutil/trace.go:171","msg":"trace[358515248] linearizableReadLoop","detail":"{readStateIndex:290; appliedIndex:289; }","duration":"112.42741ms","start":"2026-05-08T18:12:24.838524Z","end":"2026-05-08T18:12:24.950951Z","steps":["trace[358515248] 'read index received' (duration: 24.747534ms)","trace[358515248] 'applied index is now lower than readState.Index' (duration: 87.677896ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:24.951343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.684577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:24.951368Z","caller":"traceutil/trace.go:171","msg":"trace[136166930] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:285; }","duration":"109.771597ms","start":"2026-05-08T18:12:24.841586Z","end":"2026-05-08T18:12:24.951358Z","steps":["trace[136166930] 'agreement among raft nodes before linearized reading' (duration: 109.671106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:24.951565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.030998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T18:12:24.951618Z","caller":"traceutil/trace.go:171","msg":"trace[1013242995] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:285; }","duration":"113.091088ms","start":"2026-05-08T18:12:24.838513Z","end":"2026-05-08T18:12:24.951604Z","steps":["trace[1013242995] 'agreement among raft nodes before linearized reading' (duration: 112.661713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.473495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.821758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:12:29.473665Z","caller":"traceutil/trace.go:171","msg":"trace[602028396] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"796.186395ms","start":"2026-05-08T18:12:28.677454Z","end":"2026-05-08T18:12:29.47364Z","steps":["trace[602028396] 'process raft request' (duration: 180.456717ms)","trace[602028396] 'compare' (duration: 614.048789ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:29.473742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.677445Z","time spent":"796.262066ms","remote":"127.0.0.1:33288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:29.476437Z","caller":"traceutil/trace.go:171","msg":"trace[1267800667] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:357; }","duration":"759.138817ms","start":"2026-05-08T18:12:28.71727Z","end":"2026-05-08T18:12:29.476408Z","steps":["trace[1267800667] 'read index received' (duration: 140.809948ms)","trace[1267800667] 'applied index is now lower than readState.Index' (duration: 618.327629ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:29.476479Z","caller":"traceutil/trace.go:171","msg":"trace[889353580] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"794.400404ms","start":"2026-05-08T18:12:28.682053Z","end":"2026-05-08T18:12:29.476454Z","steps":["trace[889353580] 'process raft request' (duration: 794.211452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.476739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.39829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-05-08T18:12:29.4768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.108789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:29.476816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.682036Z","time spent":"794.521515ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4781,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:29.476871Z","caller":"traceutil/trace.go:171","msg":"trace[1622648984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:348; }","duration":"712.207441ms","start":"2026-05-08T18:12:28.76464Z","end":"2026-05-08T18:12:29.476848Z","steps":["trace[1622648984] 'agreement among raft nodes before linearized reading' (duration: 712.09449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.476886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.371407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-08T18:12:29.477068Z","caller":"traceutil/trace.go:171","msg":"trace[990666280] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:348; }","duration":"509.59447ms","start":"2026-05-08T18:12:28.96745Z","end":"2026-05-08T18:12:29.477044Z","steps":["trace[990666280] 'agreement among raft nodes before linearized reading' (duration: 509.297837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.477097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.01532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-08T18:12:29.477146Z","caller":"traceutil/trace.go:171","msg":"trace[1173068582] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:348; }","duration":"659.06431ms","start":"2026-05-08T18:12:28.818072Z","end":"2026-05-08T18:12:29.477136Z","steps":["trace[1173068582] 'agreement among raft nodes before linearized reading' (duration: 658.959099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.477171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.223198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-05-08T18:12:29.477183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.818016Z","time spent":"659.160052ms","remote":"127.0.0.1:33396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-05-08T18:12:29.47722Z","caller":"traceutil/trace.go:171","msg":"trace[1955583516] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:348; }","duration":"409.306368ms","start":"2026-05-08T18:12:29.067898Z","end":"2026-05-08T18:12:29.477204Z","steps":["trace[1955583516] 'agreement among raft nodes before linearized reading' (duration: 409.208387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.477265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.625333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-05-08T18:12:29.477963Z","caller":"traceutil/trace.go:171","msg":"trace[1857347494] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:348; }","duration":"506.329842ms","start":"2026-05-08T18:12:28.971591Z","end":"2026-05-08T18:12:29.47792Z","steps":["trace[1857347494] 'agreement among raft nodes before linearized reading' (duration: 505.617633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.478058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.971572Z","time spent":"506.453823ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7326,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"warn","ts":"2026-05-08T18:12:29.477027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.817411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-08T18:12:29.478286Z","caller":"traceutil/trace.go:171","msg":"trace[568214928] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:348; }","duration":"461.32402ms","start":"2026-05-08T18:12:29.016951Z","end":"2026-05-08T18:12:29.478275Z","steps":["trace[568214928] 'agreement among raft nodes before linearized reading' (duration: 459.809512ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.478325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.016899Z","time spent":"461.412821ms","remote":"127.0.0.1:33396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-05-08T18:12:29.477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.764614Z","time spent":"712.330642ms","remote":"127.0.0.1:33200","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-05-08T18:12:29.477271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.067878Z","time spent":"409.383719ms","remote":"127.0.0.1:33396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-05-08T18:12:29.477174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.936259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-08T18:12:29.478818Z","caller":"traceutil/trace.go:171","msg":"trace[1990847227] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:348; }","duration":"611.683179ms","start":"2026-05-08T18:12:28.867119Z","end":"2026-05-08T18:12:29.478802Z","steps":["trace[1990847227] 'agreement among raft nodes before linearized reading' (duration: 609.808847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.478895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.867095Z","time spent":"611.785101ms","remote":"127.0.0.1:33396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"info","ts":"2026-05-08T18:12:29.476828Z","caller":"traceutil/trace.go:171","msg":"trace[1749631097] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:348; }","duration":"759.572431ms","start":"2026-05-08T18:12:28.717232Z","end":"2026-05-08T18:12:29.476805Z","steps":["trace[1749631097] 'agreement among raft nodes before linearized reading' (duration: 759.330119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.479158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.71722Z","time spent":"761.924279ms","remote":"127.0.0.1:33396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-05-08T18:12:29.477348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.802643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-08T18:12:29.479426Z","caller":"traceutil/trace.go:171","msg":"trace[1172341893] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:348; }","duration":"560.890088ms","start":"2026-05-08T18:12:28.918509Z","end":"2026-05-08T18:12:29.479399Z","steps":["trace[1172341893] 'agreement among raft nodes before linearized reading' (duration: 558.810283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.479518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.918487Z","time spent":"561.005789ms","remote":"127.0.0.1:33396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-05-08T18:12:29.477415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.230093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T18:12:29.479634Z","caller":"traceutil/trace.go:171","msg":"trace[1488497125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:348; }","duration":"493.454989ms","start":"2026-05-08T18:12:28.986165Z","end":"2026-05-08T18:12:29.47962Z","steps":["trace[1488497125] 'agreement among raft nodes before linearized reading' (duration: 491.213312ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.479679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.986157Z","time spent":"493.511509ms","remote":"127.0.0.1:33450","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-05-08T18:12:29.477412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.639329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-08T18:12:29.479784Z","caller":"traceutil/trace.go:171","msg":"trace[2126020572] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:348; }","duration":"712.023528ms","start":"2026-05-08T18:12:28.767723Z","end":"2026-05-08T18:12:29.479747Z","steps":["trace[2126020572] 'agreement among raft nodes before linearized reading' (duration: 709.60148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.479844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.767704Z","time spent":"712.122169ms","remote":"127.0.0.1:33396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-05-08T18:12:29.477216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:28.967412Z","time spent":"509.715901ms","remote":"127.0.0.1:33396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"info","ts":"2026-05-08T18:12:29.632744Z","caller":"traceutil/trace.go:171","msg":"trace[868740529] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"148.008719ms","start":"2026-05-08T18:12:29.48471Z","end":"2026-05-08T18:12:29.632718Z","steps":["trace[868740529] 'process raft request' (duration: 94.656112ms)","trace[868740529] 'compare' (duration: 53.257436ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:29.966943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.035921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:12:29.967342Z","caller":"traceutil/trace.go:171","msg":"trace[1090697974] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"481.81316ms","start":"2026-05-08T18:12:29.485291Z","end":"2026-05-08T18:12:29.967104Z","steps":["trace[1090697974] 'process raft request' (duration: 338.564897ms)","trace[1090697974] 'compare' (duration: 142.918279ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:29.967459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.48527Z","time spent":"482.143684ms","remote":"127.0.0.1:33288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":654,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:29.967814Z","caller":"traceutil/trace.go:171","msg":"trace[1989537111] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:360; }","duration":"217.617836ms","start":"2026-05-08T18:12:29.750188Z","end":"2026-05-08T18:12:29.967806Z","steps":["trace[1989537111] 'read index received' (duration: 73.603485ms)","trace[1989537111] 'applied index is now lower than readState.Index' (duration: 144.013821ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:29.967893Z","caller":"traceutil/trace.go:171","msg":"trace[876932853] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"477.57171ms","start":"2026-05-08T18:12:29.490309Z","end":"2026-05-08T18:12:29.96788Z","steps":["trace[876932853] 'process raft request' (duration: 477.203016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.967978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.490298Z","time spent":"477.639741ms","remote":"127.0.0.1:33396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:29.96806Z","caller":"traceutil/trace.go:171","msg":"trace[1381747524] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"477.717412ms","start":"2026-05-08T18:12:29.490335Z","end":"2026-05-08T18:12:29.968052Z","steps":["trace[1381747524] 'process raft request' (duration: 477.232047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.968126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.490325Z","time spent":"477.758323ms","remote":"127.0.0.1:33316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:29.968267Z","caller":"traceutil/trace.go:171","msg":"trace[30485399] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"482.74241ms","start":"2026-05-08T18:12:29.4855Z","end":"2026-05-08T18:12:29.968243Z","steps":["trace[30485399] 'process raft request' (duration: 481.518976ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:29.968317Z","caller":"traceutil/trace.go:171","msg":"trace[1081314493] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"476.832741ms","start":"2026-05-08T18:12:29.49148Z","end":"2026-05-08T18:12:29.968312Z","steps":["trace[1081314493] 'process raft request' (duration: 476.187624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.968372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.485491Z","time spent":"482.836262ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:29.968591Z","caller":"traceutil/trace.go:171","msg":"trace[1998167453] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"480.002288ms","start":"2026-05-08T18:12:29.488579Z","end":"2026-05-08T18:12:29.968581Z","steps":["trace[1998167453] 'process raft request' (duration: 478.825725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.968651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.488549Z","time spent":"480.07536ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:29.968729Z","caller":"traceutil/trace.go:171","msg":"trace[540716894] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"483.016204ms","start":"2026-05-08T18:12:29.485688Z","end":"2026-05-08T18:12:29.968704Z","steps":["trace[540716894] 'process raft request' (duration: 481.656258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.967914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.732388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:29.968835Z","caller":"traceutil/trace.go:171","msg":"trace[26491253] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:361; }","duration":"218.702559ms","start":"2026-05-08T18:12:29.750122Z","end":"2026-05-08T18:12:29.968825Z","steps":["trace[26491253] 'agreement among raft nodes before linearized reading' (duration: 217.716808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.968875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.485682Z","time spent":"483.125875ms","remote":"127.0.0.1:33672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:29.968298Z","caller":"traceutil/trace.go:171","msg":"trace[2092091191] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"476.827181ms","start":"2026-05-08T18:12:29.491462Z","end":"2026-05-08T18:12:29.968289Z","steps":["trace[2092091191] 'process raft request' (duration: 476.134493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.9691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.491455Z","time spent":"477.611321ms","remote":"127.0.0.1:33550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:29.969119Z","caller":"traceutil/trace.go:171","msg":"trace[167382754] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"483.315208ms","start":"2026-05-08T18:12:29.485797Z","end":"2026-05-08T18:12:29.969112Z","steps":["trace[167382754] 'process raft request' (duration: 481.578517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.969188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.485791Z","time spent":"483.380128ms","remote":"127.0.0.1:33366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T18:12:29.96839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.491463Z","time spent":"476.866832ms","remote":"127.0.0.1:33550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:29.969717Z","caller":"traceutil/trace.go:171","msg":"trace[215171431] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"477.56482ms","start":"2026-05-08T18:12:29.492142Z","end":"2026-05-08T18:12:29.969707Z","steps":["trace[215171431] 'process raft request' (duration: 475.635617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.969788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.49213Z","time spent":"477.621591ms","remote":"127.0.0.1:33436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1251,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:29.970003Z","caller":"traceutil/trace.go:171","msg":"trace[1340266492] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"478.4248ms","start":"2026-05-08T18:12:29.491571Z","end":"2026-05-08T18:12:29.969996Z","steps":["trace[1340266492] 'process raft request' (duration: 476.156083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.970054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.491553Z","time spent":"478.46805ms","remote":"127.0.0.1:33372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:29.970544Z","caller":"traceutil/trace.go:171","msg":"trace[1282853814] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"476.859241ms","start":"2026-05-08T18:12:29.491547Z","end":"2026-05-08T18:12:29.968406Z","steps":["trace[1282853814] 'process raft request' (duration: 476.156583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:29.970712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:29.49154Z","time spent":"479.078888ms","remote":"127.0.0.1:33550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:30.190433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.222743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:12:30.190669Z","caller":"traceutil/trace.go:171","msg":"trace[1443953] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"215.621605ms","start":"2026-05-08T18:12:29.975015Z","end":"2026-05-08T18:12:30.190637Z","steps":["trace[1443953] 'process raft request' (duration: 215.505684ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.190648Z","caller":"traceutil/trace.go:171","msg":"trace[938185659] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"217.257574ms","start":"2026-05-08T18:12:29.973341Z","end":"2026-05-08T18:12:30.190598Z","steps":["trace[938185659] 'process raft request' (duration: 107.806978ms)","trace[938185659] 'compare' (duration: 109.091691ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:30.191269Z","caller":"traceutil/trace.go:171","msg":"trace[427875348] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"215.333321ms","start":"2026-05-08T18:12:29.975907Z","end":"2026-05-08T18:12:30.19124Z","steps":["trace[427875348] 'process raft request' (duration: 214.654863ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.191633Z","caller":"traceutil/trace.go:171","msg":"trace[1353926844] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"211.111232ms","start":"2026-05-08T18:12:29.980489Z","end":"2026-05-08T18:12:30.1916Z","steps":["trace[1353926844] 'process raft request' (duration: 210.110611ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.191789Z","caller":"traceutil/trace.go:171","msg":"trace[1741588531] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"211.137052ms","start":"2026-05-08T18:12:29.980637Z","end":"2026-05-08T18:12:30.191774Z","steps":["trace[1741588531] 'process raft request' (duration: 210.715867ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.191927Z","caller":"traceutil/trace.go:171","msg":"trace[770882648] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:373; }","duration":"198.13853ms","start":"2026-05-08T18:12:29.993774Z","end":"2026-05-08T18:12:30.191912Z","steps":["trace[770882648] 'read index received' (duration: 87.281568ms)","trace[770882648] 'applied index is now lower than readState.Index' (duration: 110.856112ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:30.1922Z","caller":"traceutil/trace.go:171","msg":"trace[658760161] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"204.263361ms","start":"2026-05-08T18:12:29.987914Z","end":"2026-05-08T18:12:30.192177Z","steps":["trace[658760161] 'process raft request' (duration: 203.824596ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.192269Z","caller":"traceutil/trace.go:171","msg":"trace[511844007] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"211.460116ms","start":"2026-05-08T18:12:29.980801Z","end":"2026-05-08T18:12:30.192261Z","steps":["trace[511844007] 'process raft request' (duration: 210.866199ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:30.192311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.180171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-08T18:12:30.192362Z","caller":"traceutil/trace.go:171","msg":"trace[2054801377] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:370; }","duration":"216.347683ms","start":"2026-05-08T18:12:29.976003Z","end":"2026-05-08T18:12:30.19235Z","steps":["trace[2054801377] 'agreement among raft nodes before linearized reading' (duration: 216.233021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:30.192332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.550107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-08T18:12:30.192462Z","caller":"traceutil/trace.go:171","msg":"trace[1998201667] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:370; }","duration":"103.797969ms","start":"2026-05-08T18:12:30.088649Z","end":"2026-05-08T18:12:30.192447Z","steps":["trace[1998201667] 'agreement among raft nodes before linearized reading' (duration: 103.530956ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.192231Z","caller":"traceutil/trace.go:171","msg":"trace[1909693468] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"211.128071ms","start":"2026-05-08T18:12:29.981091Z","end":"2026-05-08T18:12:30.192219Z","steps":["trace[1909693468] 'process raft request' (duration: 210.613445ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.345953Z","caller":"traceutil/trace.go:171","msg":"trace[2119633380] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"149.599283ms","start":"2026-05-08T18:12:30.196335Z","end":"2026-05-08T18:12:30.345934Z","steps":["trace[2119633380] 'process raft request' (duration: 138.673166ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.346134Z","caller":"traceutil/trace.go:171","msg":"trace[633816181] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:381; }","duration":"146.661718ms","start":"2026-05-08T18:12:30.199449Z","end":"2026-05-08T18:12:30.346111Z","steps":["trace[633816181] 'read index received' (duration: 55.047611ms)","trace[633816181] 'applied index is now lower than readState.Index' (duration: 91.613187ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:30.346222Z","caller":"traceutil/trace.go:171","msg":"trace[1890312273] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"145.796638ms","start":"2026-05-08T18:12:30.200395Z","end":"2026-05-08T18:12:30.346192Z","steps":["trace[1890312273] 'process raft request' (duration: 145.639436ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:30.346394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.927451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-05-08T18:12:30.346441Z","caller":"traceutil/trace.go:171","msg":"trace[962981169] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:378; }","duration":"147.005523ms","start":"2026-05-08T18:12:30.199424Z","end":"2026-05-08T18:12:30.34643Z","steps":["trace[962981169] 'agreement among raft nodes before linearized reading' (duration: 146.919302ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.34657Z","caller":"traceutil/trace.go:171","msg":"trace[123807989] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"145.02056ms","start":"2026-05-08T18:12:30.201539Z","end":"2026-05-08T18:12:30.34656Z","steps":["trace[123807989] 'process raft request' (duration: 144.525954ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.346599Z","caller":"traceutil/trace.go:171","msg":"trace[1504720182] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"146.609988ms","start":"2026-05-08T18:12:30.199976Z","end":"2026-05-08T18:12:30.346586Z","steps":["trace[1504720182] 'process raft request' (duration: 146.008921ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.346773Z","caller":"traceutil/trace.go:171","msg":"trace[1741655480] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"148.101166ms","start":"2026-05-08T18:12:30.198054Z","end":"2026-05-08T18:12:30.346155Z","steps":["trace[1741655480] 'process raft request' (duration: 147.892613ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.346895Z","caller":"traceutil/trace.go:171","msg":"trace[1754826553] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"149.722284ms","start":"2026-05-08T18:12:30.19716Z","end":"2026-05-08T18:12:30.346882Z","steps":["trace[1754826553] 'process raft request' (duration: 148.721523ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.346931Z","caller":"traceutil/trace.go:171","msg":"trace[1199179248] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"149.877756ms","start":"2026-05-08T18:12:30.197043Z","end":"2026-05-08T18:12:30.346921Z","steps":["trace[1199179248] 'process raft request' (duration: 148.782763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:30.627513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.895622ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:12:30.627847Z","caller":"traceutil/trace.go:171","msg":"trace[1847945126] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"274.387417ms","start":"2026-05-08T18:12:30.353433Z","end":"2026-05-08T18:12:30.62782Z","steps":["trace[1847945126] 'process raft request' (duration: 274.256275ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.628031Z","caller":"traceutil/trace.go:171","msg":"trace[27697411] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"273.892151ms","start":"2026-05-08T18:12:30.354127Z","end":"2026-05-08T18:12:30.628019Z","steps":["trace[27697411] 'process raft request' (duration: 273.588848ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.628075Z","caller":"traceutil/trace.go:171","msg":"trace[1602977358] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"274.597229ms","start":"2026-05-08T18:12:30.353265Z","end":"2026-05-08T18:12:30.627862Z","steps":["trace[1602977358] 'process raft request' (duration: 108.286942ms)","trace[1602977358] 'compare' (duration: 165.744141ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:30.628177Z","caller":"traceutil/trace.go:171","msg":"trace[116560099] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"273.430636ms","start":"2026-05-08T18:12:30.354735Z","end":"2026-05-08T18:12:30.628165Z","steps":["trace[116560099] 'process raft request' (duration: 273.057361ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.628231Z","caller":"traceutil/trace.go:171","msg":"trace[1561799563] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"273.932072ms","start":"2026-05-08T18:12:30.354289Z","end":"2026-05-08T18:12:30.628221Z","steps":["trace[1561799563] 'process raft request' (duration: 273.462686ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.628316Z","caller":"traceutil/trace.go:171","msg":"trace[238134342] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"274.919293ms","start":"2026-05-08T18:12:30.353385Z","end":"2026-05-08T18:12:30.628305Z","steps":["trace[238134342] 'process raft request' (duration: 274.270456ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.62834Z","caller":"traceutil/trace.go:171","msg":"trace[885238270] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"272.274293ms","start":"2026-05-08T18:12:30.356048Z","end":"2026-05-08T18:12:30.628323Z","steps":["trace[885238270] 'process raft request' (duration: 271.834758ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.628138Z","caller":"traceutil/trace.go:171","msg":"trace[1290739536] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"274.823092ms","start":"2026-05-08T18:12:30.353303Z","end":"2026-05-08T18:12:30.628126Z","steps":["trace[1290739536] 'process raft request' (duration: 274.311266ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.628129Z","caller":"traceutil/trace.go:171","msg":"trace[1936013345] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"272.155781ms","start":"2026-05-08T18:12:30.355936Z","end":"2026-05-08T18:12:30.628092Z","steps":["trace[1936013345] 'process raft request' (duration: 271.888658ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.628581Z","caller":"traceutil/trace.go:171","msg":"trace[236829475] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"254.438505ms","start":"2026-05-08T18:12:30.374126Z","end":"2026-05-08T18:12:30.628564Z","steps":["trace[236829475] 'process raft request' (duration: 253.819917ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:30.628611Z","caller":"traceutil/trace.go:171","msg":"trace[1123578554] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"255.468156ms","start":"2026-05-08T18:12:30.373132Z","end":"2026-05-08T18:12:30.6286Z","steps":["trace[1123578554] 'process raft request' (duration: 254.782908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:31.605283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.441919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:12:31.605418Z","caller":"traceutil/trace.go:171","msg":"trace[214961561] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"971.087778ms","start":"2026-05-08T18:12:30.634308Z","end":"2026-05-08T18:12:31.605396Z","steps":["trace[214961561] 'process raft request' (duration: 225.468177ms)","trace[214961561] 'compare' (duration: 745.327797ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:31.605475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:30.634293Z","time spent":"971.159409ms","remote":"127.0.0.1:33288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:31.605508Z","caller":"traceutil/trace.go:171","msg":"trace[1347930177] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"968.867692ms","start":"2026-05-08T18:12:30.63663Z","end":"2026-05-08T18:12:31.605497Z","steps":["trace[1347930177] 'process raft request' (duration: 968.752871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:31.605582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:30.636619Z","time spent":"968.921873ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3759,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:31.605862Z","caller":"traceutil/trace.go:171","msg":"trace[1798224452] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"964.308958ms","start":"2026-05-08T18:12:30.641535Z","end":"2026-05-08T18:12:31.605844Z","steps":["trace[1798224452] 'process raft request' (duration: 963.917024ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:31.605885Z","caller":"traceutil/trace.go:171","msg":"trace[1734365133] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"948.216791ms","start":"2026-05-08T18:12:30.657653Z","end":"2026-05-08T18:12:31.60587Z","steps":["trace[1734365133] 'process raft request' (duration: 948.051389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:31.605921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:30.641525Z","time spent":"964.36744ms","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:31.605957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.034685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:31.606049Z","caller":"traceutil/trace.go:171","msg":"trace[1345853624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:394; }","duration":"112.166116ms","start":"2026-05-08T18:12:31.493864Z","end":"2026-05-08T18:12:31.60603Z","steps":["trace[1345853624] 'agreement among raft nodes before linearized reading' (duration: 112.020595ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:31.605837Z","caller":"traceutil/trace.go:171","msg":"trace[1581690149] linearizableReadLoop","detail":"{readStateIndex:405; appliedIndex:401; }","duration":"111.904453ms","start":"2026-05-08T18:12:31.493903Z","end":"2026-05-08T18:12:31.605807Z","steps":["trace[1581690149] 'read index received' (duration: 50.06µs)","trace[1581690149] 'applied index is now lower than readState.Index' (duration: 111.853523ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:31.606869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:30.657631Z","time spent":"949.148062ms","remote":"127.0.0.1:33288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T18:12:32.137445Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114213264466527,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T18:12:32.305819Z","caller":"traceutil/trace.go:171","msg":"trace[1406716546] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:405; }","duration":"668.915233ms","start":"2026-05-08T18:12:31.636859Z","end":"2026-05-08T18:12:32.305774Z","steps":["trace[1406716546] 'read index received' (duration: 659.576876ms)","trace[1406716546] 'applied index is now lower than readState.Index' (duration: 9.336277ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:32.305928Z","caller":"traceutil/trace.go:171","msg":"trace[445840533] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"690.403111ms","start":"2026-05-08T18:12:31.615485Z","end":"2026-05-08T18:12:32.305889Z","steps":["trace[445840533] 'process raft request' (duration: 681.046574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:32.306002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.116155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T18:12:32.306065Z","caller":"traceutil/trace.go:171","msg":"trace[927373123] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:395; }","duration":"669.195496ms","start":"2026-05-08T18:12:31.636854Z","end":"2026-05-08T18:12:32.30605Z","steps":["trace[927373123] 'agreement among raft nodes before linearized reading' (duration: 669.052834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:32.306099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.730388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:32.306145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:31.63681Z","time spent":"669.327258ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-08T18:12:32.306179Z","caller":"traceutil/trace.go:171","msg":"trace[818368627] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:395; }","duration":"557.850809ms","start":"2026-05-08T18:12:31.748311Z","end":"2026-05-08T18:12:32.306162Z","steps":["trace[818368627] 'agreement among raft nodes before linearized reading' (duration: 557.700857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:32.306061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:31.615463Z","time spent":"690.533793ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:32.306237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:31.7483Z","time spent":"557.92576ms","remote":"127.0.0.1:33200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T18:12:32.485512Z","caller":"traceutil/trace.go:171","msg":"trace[537470114] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"170.342914ms","start":"2026-05-08T18:12:32.315152Z","end":"2026-05-08T18:12:32.485495Z","steps":["trace[537470114] 'process raft request' (duration: 170.297683ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:32.485596Z","caller":"traceutil/trace.go:171","msg":"trace[493760836] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"174.31839ms","start":"2026-05-08T18:12:32.311261Z","end":"2026-05-08T18:12:32.48558Z","steps":["trace[493760836] 'process raft request' (duration: 155.276681ms)","trace[493760836] 'compare' (duration: 18.806586ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:35.101271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.320929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4795"} {"level":"warn","ts":"2026-05-08T18:12:35.101292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.754706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:35.101354Z","caller":"traceutil/trace.go:171","msg":"trace[1109533149] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:413; }","duration":"157.46499ms","start":"2026-05-08T18:12:34.94387Z","end":"2026-05-08T18:12:35.101335Z","steps":["trace[1109533149] 'range keys from in-memory index tree' (duration: 157.123837ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:35.101391Z","caller":"traceutil/trace.go:171","msg":"trace[265135567] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:413; }","duration":"352.907219ms","start":"2026-05-08T18:12:34.748457Z","end":"2026-05-08T18:12:35.101365Z","steps":["trace[265135567] 'range keys from in-memory index tree' (duration: 352.597035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:35.101446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:34.748442Z","time spent":"352.990849ms","remote":"127.0.0.1:33194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T18:12:35.229516Z","caller":"traceutil/trace.go:171","msg":"trace[300553523] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"118.322847ms","start":"2026-05-08T18:12:35.111168Z","end":"2026-05-08T18:12:35.229491Z","steps":["trace[300553523] 'process raft request' (duration: 118.181585ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:35.230447Z","caller":"traceutil/trace.go:171","msg":"trace[2132326129] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"109.79072ms","start":"2026-05-08T18:12:35.120634Z","end":"2026-05-08T18:12:35.230424Z","steps":["trace[2132326129] 'process raft request' (duration: 109.657119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:42.947141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.200857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T18:12:42.947229Z","caller":"traceutil/trace.go:171","msg":"trace[614947765] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:461; }","duration":"419.343118ms","start":"2026-05-08T18:12:42.527864Z","end":"2026-05-08T18:12:42.947207Z","steps":["trace[614947765] 'range keys from in-memory index tree' (duration: 419.029894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:42.947271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:42.527826Z","time spent":"419.435758ms","remote":"127.0.0.1:33450","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-05-08T18:12:42.947292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.8719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-08T18:12:42.947385Z","caller":"traceutil/trace.go:171","msg":"trace[1080058478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:461; }","duration":"242.992181ms","start":"2026-05-08T18:12:42.704373Z","end":"2026-05-08T18:12:42.947365Z","steps":["trace[1080058478] 'range keys from in-memory index tree' (duration: 242.783719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:42.947263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.02098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-08T18:12:42.947581Z","caller":"traceutil/trace.go:171","msg":"trace[1875538978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:461; }","duration":"170.368943ms","start":"2026-05-08T18:12:42.777191Z","end":"2026-05-08T18:12:42.94756Z","steps":["trace[1875538978] 'range keys from in-memory index tree' (duration: 169.944789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:42.947789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.619358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:42.947823Z","caller":"traceutil/trace.go:171","msg":"trace[135051374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:461; }","duration":"202.266965ms","start":"2026-05-08T18:12:42.745545Z","end":"2026-05-08T18:12:42.947812Z","steps":["trace[135051374] 'range keys from in-memory index tree' (duration: 201.580607ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:43.376458Z","caller":"traceutil/trace.go:171","msg":"trace[624515215] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"424.356959ms","start":"2026-05-08T18:12:42.952072Z","end":"2026-05-08T18:12:43.376429Z","steps":["trace[624515215] 'process raft request' (duration: 419.058742ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:43.376677Z","caller":"traceutil/trace.go:171","msg":"trace[120796925] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"423.035295ms","start":"2026-05-08T18:12:42.953623Z","end":"2026-05-08T18:12:43.376659Z","steps":["trace[120796925] 'process raft request' (duration: 422.953424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:43.376685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:42.952052Z","time spent":"424.551141ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:43.376779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:42.953613Z","time spent":"423.109006ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:43.376921Z","caller":"traceutil/trace.go:171","msg":"trace[500144441] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"424.225658ms","start":"2026-05-08T18:12:42.952686Z","end":"2026-05-08T18:12:43.376911Z","steps":["trace[500144441] 'process raft request' (duration: 423.678522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:43.376981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:42.952676Z","time spent":"424.273698ms","remote":"127.0.0.1:33450","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-05-08T18:12:43.407456Z","caller":"traceutil/trace.go:171","msg":"trace[2085362367] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"295.913658ms","start":"2026-05-08T18:12:43.111522Z","end":"2026-05-08T18:12:43.407436Z","steps":["trace[2085362367] 'process raft request' (duration: 295.768757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:44.825229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077821628s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:44.825298Z","caller":"traceutil/trace.go:171","msg":"trace[462185021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:465; }","duration":"1.077932378s","start":"2026-05-08T18:12:43.747351Z","end":"2026-05-08T18:12:44.825283Z","steps":["trace[462185021] 'range keys from in-memory index tree' (duration: 1.077677265s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:44.825323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:43.747329Z","time spent":"1.077986459s","remote":"127.0.0.1:33194","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-05-08T18:12:44.825437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.034183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-08T18:12:44.825503Z","caller":"traceutil/trace.go:171","msg":"trace[891958778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:465; }","duration":"350.144613ms","start":"2026-05-08T18:12:44.475341Z","end":"2026-05-08T18:12:44.825486Z","steps":["trace[891958778] 'range keys from in-memory index tree' (duration: 349.932341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:44.825542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:44.475321Z","time spent":"350.212255ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T18:12:44.938318Z","caller":"traceutil/trace.go:171","msg":"trace[82890513] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"108.70048ms","start":"2026-05-08T18:12:44.829599Z","end":"2026-05-08T18:12:44.9383Z","steps":["trace[82890513] 'process raft request' (duration: 108.359416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:51.977834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.547833ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:12:51.978014Z","caller":"traceutil/trace.go:171","msg":"trace[1643539485] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:497; }","duration":"223.681741ms","start":"2026-05-08T18:12:51.754316Z","end":"2026-05-08T18:12:51.977998Z","steps":["trace[1643539485] 'read index received' (duration: 205.97661ms)","trace[1643539485] 'applied index is now lower than readState.Index' (duration: 17.704191ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:51.978123Z","caller":"traceutil/trace.go:171","msg":"trace[788054902] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"453.737677ms","start":"2026-05-08T18:12:51.524357Z","end":"2026-05-08T18:12:51.978094Z","steps":["trace[788054902] 'process raft request' (duration: 453.588975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:51.978204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.886993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:51.978237Z","caller":"traceutil/trace.go:171","msg":"trace[756398587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"223.960484ms","start":"2026-05-08T18:12:51.754265Z","end":"2026-05-08T18:12:51.978225Z","steps":["trace[756398587] 'agreement among raft nodes before linearized reading' (duration: 223.832413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:51.978272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:51.524338Z","time spent":"453.852908ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:51.97837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.804035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-05-08T18:12:51.978472Z","caller":"traceutil/trace.go:171","msg":"trace[1356581234] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:483; }","duration":"138.946147ms","start":"2026-05-08T18:12:51.839502Z","end":"2026-05-08T18:12:51.978448Z","steps":["trace[1356581234] 'agreement among raft nodes before linearized reading' (duration: 138.715745ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:51.978226Z","caller":"traceutil/trace.go:171","msg":"trace[518857690] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"454.047909ms","start":"2026-05-08T18:12:51.524126Z","end":"2026-05-08T18:12:51.978174Z","steps":["trace[518857690] 'process raft request' (duration: 55.085282ms)","trace[518857690] 'compare' (duration: 398.418412ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:51.979784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:51.524105Z","time spent":"454.453763ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:53.240544Z","caller":"traceutil/trace.go:171","msg":"trace[2062187409] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:501; }","duration":"287.264844ms","start":"2026-05-08T18:12:52.953258Z","end":"2026-05-08T18:12:53.240522Z","steps":["trace[2062187409] 'read index received' (duration: 286.471436ms)","trace[2062187409] 'applied index is now lower than readState.Index' (duration: 792.648µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:53.240642Z","caller":"traceutil/trace.go:171","msg":"trace[1132182365] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"303.660571ms","start":"2026-05-08T18:12:52.936947Z","end":"2026-05-08T18:12:53.240607Z","steps":["trace[1132182365] 'process raft request' (duration: 303.298258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:53.240777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.825322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-08T18:12:53.240835Z","caller":"traceutil/trace.go:171","msg":"trace[373735696] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:485; }","duration":"233.911072ms","start":"2026-05-08T18:12:53.006914Z","end":"2026-05-08T18:12:53.240825Z","steps":["trace[373735696] 'agreement among raft nodes before linearized reading' (duration: 233.826652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:53.240836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:52.936876Z","time spent":"303.851732ms","remote":"127.0.0.1:33308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317292,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T18:12:53.240776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.504237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-05-08T18:12:53.240986Z","caller":"traceutil/trace.go:171","msg":"trace[2125888544] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:485; }","duration":"287.744229ms","start":"2026-05-08T18:12:52.953212Z","end":"2026-05-08T18:12:53.240956Z","steps":["trace[2125888544] 'agreement among raft nodes before linearized reading' (duration: 287.429826ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:53.371587Z","caller":"traceutil/trace.go:171","msg":"trace[2062165746] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"101.254462ms","start":"2026-05-08T18:12:53.270299Z","end":"2026-05-08T18:12:53.371554Z","steps":["trace[2062165746] 'process raft request' (duration: 101.10634ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:53.64885Z","caller":"traceutil/trace.go:171","msg":"trace[1604669813] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:505; }","duration":"124.055854ms","start":"2026-05-08T18:12:53.524768Z","end":"2026-05-08T18:12:53.648824Z","steps":["trace[1604669813] 'read index received' (duration: 104.710558ms)","trace[1604669813] 'applied index is now lower than readState.Index' (duration: 19.344086ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:53.648965Z","caller":"traceutil/trace.go:171","msg":"trace[1551933450] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"271.706985ms","start":"2026-05-08T18:12:53.377214Z","end":"2026-05-08T18:12:53.648921Z","steps":["trace[1551933450] 'process raft request' (duration: 252.292418ms)","trace[1551933450] 'compare' (duration: 18.946002ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:53.649167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.314586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-08T18:12:53.649336Z","caller":"traceutil/trace.go:171","msg":"trace[330043974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:489; }","duration":"124.616849ms","start":"2026-05-08T18:12:53.524699Z","end":"2026-05-08T18:12:53.649316Z","steps":["trace[330043974] 'agreement among raft nodes before linearized reading' (duration: 124.243185ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:55.720406Z","caller":"traceutil/trace.go:171","msg":"trace[2039845984] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"191.256726ms","start":"2026-05-08T18:12:55.529128Z","end":"2026-05-08T18:12:55.720385Z","steps":["trace[2039845984] 'process raft request' (duration: 191.212795ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:55.720588Z","caller":"traceutil/trace.go:171","msg":"trace[1831888465] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"228.532279ms","start":"2026-05-08T18:12:55.492046Z","end":"2026-05-08T18:12:55.720578Z","steps":["trace[1831888465] 'process raft request' (duration: 225.469808ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:55.720699Z","caller":"traceutil/trace.go:171","msg":"trace[1938242112] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"217.78335ms","start":"2026-05-08T18:12:55.502887Z","end":"2026-05-08T18:12:55.72067Z","steps":["trace[1938242112] 'process raft request' (duration: 217.242825ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:55.720835Z","caller":"traceutil/trace.go:171","msg":"trace[753450707] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"221.75162ms","start":"2026-05-08T18:12:55.498989Z","end":"2026-05-08T18:12:55.720741Z","steps":["trace[753450707] 'process raft request' (duration: 221.057923ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:55.721042Z","caller":"traceutil/trace.go:171","msg":"trace[1817182466] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"207.69844ms","start":"2026-05-08T18:12:55.51333Z","end":"2026-05-08T18:12:55.721028Z","steps":["trace[1817182466] 'process raft request' (duration: 206.902152ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:55.721097Z","caller":"traceutil/trace.go:171","msg":"trace[74382536] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"218.029844ms","start":"2026-05-08T18:12:55.503059Z","end":"2026-05-08T18:12:55.721089Z","steps":["trace[74382536] 'process raft request' (duration: 217.105874ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:55.721039Z","caller":"traceutil/trace.go:171","msg":"trace[1610665323] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"218.179935ms","start":"2026-05-08T18:12:55.502838Z","end":"2026-05-08T18:12:55.721018Z","steps":["trace[1610665323] 'process raft request' (duration: 217.258486ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:55.721209Z","caller":"traceutil/trace.go:171","msg":"trace[404910061] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"201.831581ms","start":"2026-05-08T18:12:55.519368Z","end":"2026-05-08T18:12:55.7212Z","steps":["trace[404910061] 'process raft request' (duration: 200.925972ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:55.72119Z","caller":"traceutil/trace.go:171","msg":"trace[1778231898] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"229.054293ms","start":"2026-05-08T18:12:55.492096Z","end":"2026-05-08T18:12:55.721151Z","steps":["trace[1778231898] 'process raft request' (duration: 227.904482ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.195196Z","caller":"traceutil/trace.go:171","msg":"trace[759320150] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"655.085951ms","start":"2026-05-08T18:12:55.540085Z","end":"2026-05-08T18:12:56.195171Z","steps":["trace[759320150] 'process raft request' (duration: 654.92925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.195338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.540079Z","time spent":"655.181432ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:56.195396Z","caller":"traceutil/trace.go:171","msg":"trace[1604050310] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"656.042811ms","start":"2026-05-08T18:12:55.539149Z","end":"2026-05-08T18:12:56.195192Z","steps":["trace[1604050310] 'process raft request' (duration: 570.677729ms)","trace[1604050310] 'compare' (duration: 84.885237ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:56.195449Z","caller":"traceutil/trace.go:171","msg":"trace[2095400515] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:541; }","duration":"499.746206ms","start":"2026-05-08T18:12:55.695677Z","end":"2026-05-08T18:12:56.195423Z","steps":["trace[2095400515] 'read index received' (duration: 21.865409ms)","trace[2095400515] 'applied index is now lower than readState.Index' (duration: 477.879977ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:56.195548Z","caller":"traceutil/trace.go:171","msg":"trace[413574465] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"547.686416ms","start":"2026-05-08T18:12:55.647844Z","end":"2026-05-08T18:12:56.19553Z","steps":["trace[413574465] 'process raft request' (duration: 547.421023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.195627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.647818Z","time spent":"547.773367ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:56.195723Z","caller":"traceutil/trace.go:171","msg":"trace[1588834239] transaction","detail":"{read_only:false; number_of_response:1; response_revision:535; }","duration":"654.452475ms","start":"2026-05-08T18:12:55.541262Z","end":"2026-05-08T18:12:56.195715Z","steps":["trace[1588834239] 'process raft request' (duration: 653.820089ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.195727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.539133Z","time spent":"656.420594ms","remote":"127.0.0.1:33724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T18:12:56.195782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.541255Z","time spent":"654.494835ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:56.195824Z","caller":"traceutil/trace.go:171","msg":"trace[978931979] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"497.992238ms","start":"2026-05-08T18:12:55.697813Z","end":"2026-05-08T18:12:56.195805Z","steps":["trace[978931979] 'process raft request' (duration: 497.558853ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.195874Z","caller":"traceutil/trace.go:171","msg":"trace[299030460] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"651.774808ms","start":"2026-05-08T18:12:55.544092Z","end":"2026-05-08T18:12:56.195866Z","steps":["trace[299030460] 'process raft request' (duration: 651.067381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.195933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.544084Z","time spent":"651.817079ms","remote":"127.0.0.1:33264","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-05-08T18:12:56.196034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.697791Z","time spent":"498.083359ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:56.196071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.400792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-08T18:12:56.196102Z","caller":"traceutil/trace.go:171","msg":"trace[1312927042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:538; }","duration":"500.466263ms","start":"2026-05-08T18:12:55.695626Z","end":"2026-05-08T18:12:56.196093Z","steps":["trace[1312927042] 'agreement among raft nodes before linearized reading' (duration: 500.402712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.196136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.69561Z","time spent":"500.520473ms","remote":"127.0.0.1:33450","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-05-08T18:12:56.199928Z","caller":"traceutil/trace.go:171","msg":"trace[1141999304] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"468.883377ms","start":"2026-05-08T18:12:55.731016Z","end":"2026-05-08T18:12:56.1999Z","steps":["trace[1141999304] 'process raft request' (duration: 468.435742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.200092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.731002Z","time spent":"468.991048ms","remote":"127.0.0.1:33724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:56.200229Z","caller":"traceutil/trace.go:171","msg":"trace[1403326023] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"467.553374ms","start":"2026-05-08T18:12:55.732652Z","end":"2026-05-08T18:12:56.200206Z","steps":["trace[1403326023] 'process raft request' (duration: 467.244881ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.200403Z","caller":"traceutil/trace.go:171","msg":"trace[436623594] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"466.680095ms","start":"2026-05-08T18:12:55.733716Z","end":"2026-05-08T18:12:56.200396Z","steps":["trace[436623594] 'process raft request' (duration: 466.297501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.200456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.733699Z","time spent":"466.729575ms","remote":"127.0.0.1:33724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T18:12:56.200404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.732648Z","time spent":"467.687175ms","remote":"127.0.0.1:33264","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-05-08T18:12:56.200275Z","caller":"traceutil/trace.go:171","msg":"trace[775263544] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"467.753765ms","start":"2026-05-08T18:12:55.732507Z","end":"2026-05-08T18:12:56.20026Z","steps":["trace[775263544] 'process raft request' (duration: 467.124449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.200678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.732499Z","time spent":"468.160359ms","remote":"127.0.0.1:33724","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-05-08T18:12:56.200305Z","caller":"traceutil/trace.go:171","msg":"trace[1751515255] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"467.731955ms","start":"2026-05-08T18:12:55.732568Z","end":"2026-05-08T18:12:56.2003Z","steps":["trace[1751515255] 'process raft request' (duration: 467.216629ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.200791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.732564Z","time spent":"468.207229ms","remote":"127.0.0.1:33724","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-05-08T18:12:56.200819Z","caller":"traceutil/trace.go:171","msg":"trace[1306281492] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"463.3066ms","start":"2026-05-08T18:12:55.737457Z","end":"2026-05-08T18:12:56.200763Z","steps":["trace[1306281492] 'process raft request' (duration: 462.722954ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.20102Z","caller":"traceutil/trace.go:171","msg":"trace[224500031] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"462.724775ms","start":"2026-05-08T18:12:55.738285Z","end":"2026-05-08T18:12:56.20101Z","steps":["trace[224500031] 'process raft request' (duration: 462.111529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.201026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.737448Z","time spent":"463.441913ms","remote":"127.0.0.1:33264","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-05-08T18:12:56.20108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.738276Z","time spent":"462.770835ms","remote":"127.0.0.1:33264","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-05-08T18:12:56.20117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.924754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-08T18:12:56.201196Z","caller":"traceutil/trace.go:171","msg":"trace[2003940488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:546; }","duration":"179.949575ms","start":"2026-05-08T18:12:56.021239Z","end":"2026-05-08T18:12:56.201189Z","steps":["trace[2003940488] 'agreement among raft nodes before linearized reading' (duration: 179.896064ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.201159Z","caller":"traceutil/trace.go:171","msg":"trace[650835648] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"459.574593ms","start":"2026-05-08T18:12:55.741561Z","end":"2026-05-08T18:12:56.201136Z","steps":["trace[650835648] 'process raft request' (duration: 459.29338ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.201349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:55.741543Z","time spent":"459.749896ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:56.20118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.401858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T18:12:56.201595Z","caller":"traceutil/trace.go:171","msg":"trace[914099855] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"181.848293ms","start":"2026-05-08T18:12:56.019729Z","end":"2026-05-08T18:12:56.201577Z","steps":["trace[914099855] 'agreement among raft nodes before linearized reading' (duration: 181.322438ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.528438Z","caller":"traceutil/trace.go:171","msg":"trace[75973776] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"299.105732ms","start":"2026-05-08T18:12:56.229298Z","end":"2026-05-08T18:12:56.528404Z","steps":["trace[75973776] 'process raft request' (duration: 254.898862ms)","trace[75973776] 'compare' (duration: 43.938078ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:56.528673Z","caller":"traceutil/trace.go:171","msg":"trace[479849425] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"286.058033ms","start":"2026-05-08T18:12:56.242589Z","end":"2026-05-08T18:12:56.528647Z","steps":["trace[479849425] 'process raft request' (duration: 285.73337ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.528851Z","caller":"traceutil/trace.go:171","msg":"trace[1334524435] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:569; }","duration":"270.994002ms","start":"2026-05-08T18:12:56.257798Z","end":"2026-05-08T18:12:56.528791Z","steps":["trace[1334524435] 'read index received' (duration: 226.295127ms)","trace[1334524435] 'applied index is now lower than readState.Index' (duration: 44.696475ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:56.52887Z","caller":"traceutil/trace.go:171","msg":"trace[1981831752] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"276.039623ms","start":"2026-05-08T18:12:56.252801Z","end":"2026-05-08T18:12:56.528841Z","steps":["trace[1981831752] 'process raft request' (duration: 275.79384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.529033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.211994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:1019"} {"level":"info","ts":"2026-05-08T18:12:56.529098Z","caller":"traceutil/trace.go:171","msg":"trace[825948966] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:553; }","duration":"271.286775ms","start":"2026-05-08T18:12:56.257794Z","end":"2026-05-08T18:12:56.52908Z","steps":["trace[825948966] 'agreement among raft nodes before linearized reading' (duration: 271.146764ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.83457Z","caller":"traceutil/trace.go:171","msg":"trace[2048203363] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"576.566409ms","start":"2026-05-08T18:12:56.257973Z","end":"2026-05-08T18:12:56.83454Z","steps":["trace[2048203363] 'process raft request' (duration: 521.469119ms)","trace[2048203363] 'compare' (duration: 54.876148ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:56.834837Z","caller":"traceutil/trace.go:171","msg":"trace[1297637655] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"572.298156ms","start":"2026-05-08T18:12:56.262483Z","end":"2026-05-08T18:12:56.834781Z","steps":["trace[1297637655] 'process raft request' (duration: 572.003123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.834746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:56.257958Z","time spent":"576.69469ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:56.834892Z","caller":"traceutil/trace.go:171","msg":"trace[988800091] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"570.794472ms","start":"2026-05-08T18:12:56.264067Z","end":"2026-05-08T18:12:56.834861Z","steps":["trace[988800091] 'process raft request' (duration: 570.6211ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.834989Z","caller":"traceutil/trace.go:171","msg":"trace[1729570506] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"543.448899ms","start":"2026-05-08T18:12:56.291519Z","end":"2026-05-08T18:12:56.834967Z","steps":["trace[1729570506] 'process raft request' (duration: 543.310418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.835024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:56.262469Z","time spent":"572.456158ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:56.835034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:56.264055Z","time spent":"570.898143ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:56.835126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:56.291489Z","time spent":"543.56414ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:56.85874Z","caller":"traceutil/trace.go:171","msg":"trace[1634098435] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"316.260594ms","start":"2026-05-08T18:12:56.542467Z","end":"2026-05-08T18:12:56.858728Z","steps":["trace[1634098435] 'process raft request' (duration: 316.060482ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:56.858803Z","caller":"traceutil/trace.go:171","msg":"trace[1697770018] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"254.049003ms","start":"2026-05-08T18:12:56.604726Z","end":"2026-05-08T18:12:56.858775Z","steps":["trace[1697770018] 'process raft request' (duration: 253.886742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:56.858857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:56.542447Z","time spent":"316.337204ms","remote":"127.0.0.1:33724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T18:12:56.858961Z","caller":"traceutil/trace.go:171","msg":"trace[1641479987] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:572; }","duration":"110.197428ms","start":"2026-05-08T18:12:56.748493Z","end":"2026-05-08T18:12:56.85869Z","steps":["trace[1641479987] 'read index received' (duration: 30.849367ms)","trace[1641479987] 'applied index is now lower than readState.Index' (duration: 79.347491ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:56.858982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.490212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:56.859042Z","caller":"traceutil/trace.go:171","msg":"trace[1352033112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"110.618503ms","start":"2026-05-08T18:12:56.748409Z","end":"2026-05-08T18:12:56.859028Z","steps":["trace[1352033112] 'agreement among raft nodes before linearized reading' (duration: 110.485831ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:57.031714Z","caller":"traceutil/trace.go:171","msg":"trace[1639721162] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"143.221416ms","start":"2026-05-08T18:12:56.888465Z","end":"2026-05-08T18:12:57.031686Z","steps":["trace[1639721162] 'process raft request' (duration: 76.249189ms)","trace[1639721162] 'compare' (duration: 66.783745ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:57.031907Z","caller":"traceutil/trace.go:171","msg":"trace[1248324267] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"141.418739ms","start":"2026-05-08T18:12:56.890465Z","end":"2026-05-08T18:12:57.031884Z","steps":["trace[1248324267] 'process raft request' (duration: 141.164336ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:57.031983Z","caller":"traceutil/trace.go:171","msg":"trace[1198586842] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"123.875524ms","start":"2026-05-08T18:12:56.908092Z","end":"2026-05-08T18:12:57.031967Z","steps":["trace[1198586842] 'process raft request' (duration: 123.746153ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:57.395245Z","caller":"traceutil/trace.go:171","msg":"trace[938616832] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"195.338579ms","start":"2026-05-08T18:12:57.199879Z","end":"2026-05-08T18:12:57.395217Z","steps":["trace[938616832] 'process raft request' (duration: 184.722184ms)","trace[938616832] 'compare' (duration: 10.463254ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:57.405522Z","caller":"traceutil/trace.go:171","msg":"trace[44012311] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:590; }","duration":"101.134094ms","start":"2026-05-08T18:12:57.304364Z","end":"2026-05-08T18:12:57.405498Z","steps":["trace[44012311] 'read index received' (duration: 80.321488ms)","trace[44012311] 'applied index is now lower than readState.Index' (duration: 20.811496ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:57.405662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.288586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-08T18:12:57.405704Z","caller":"traceutil/trace.go:171","msg":"trace[812929976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:574; }","duration":"101.412067ms","start":"2026-05-08T18:12:57.304281Z","end":"2026-05-08T18:12:57.405693Z","steps":["trace[812929976] 'agreement among raft nodes before linearized reading' (duration: 101.306326ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:57.40578Z","caller":"traceutil/trace.go:171","msg":"trace[1518924534] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"192.134778ms","start":"2026-05-08T18:12:57.213631Z","end":"2026-05-08T18:12:57.405766Z","steps":["trace[1518924534] 'process raft request' (duration: 191.799035ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:57.405779Z","caller":"traceutil/trace.go:171","msg":"trace[1244855942] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"194.546162ms","start":"2026-05-08T18:12:57.211183Z","end":"2026-05-08T18:12:57.40573Z","steps":["trace[1244855942] 'process raft request' (duration: 194.124187ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:58.229625Z","caller":"traceutil/trace.go:171","msg":"trace[1142845496] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"534.63787ms","start":"2026-05-08T18:12:57.694925Z","end":"2026-05-08T18:12:58.229562Z","steps":["trace[1142845496] 'process raft request' (duration: 514.004476ms)","trace[1142845496] 'compare' (duration: 16.771886ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:58.229814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:57.694908Z","time spent":"534.812132ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:58.238861Z","caller":"traceutil/trace.go:171","msg":"trace[728158271] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"538.845582ms","start":"2026-05-08T18:12:57.69999Z","end":"2026-05-08T18:12:58.238835Z","steps":["trace[728158271] 'process raft request' (duration: 538.303816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:58.238986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:57.699905Z","time spent":"539.022352ms","remote":"127.0.0.1:33264","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-05-08T18:12:58.95867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.487777ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:12:58.95881Z","caller":"traceutil/trace.go:171","msg":"trace[408176792] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"632.404905ms","start":"2026-05-08T18:12:58.326376Z","end":"2026-05-08T18:12:58.95878Z","steps":["trace[408176792] 'process raft request' (duration: 15.740126ms)","trace[408176792] 'compare' (duration: 616.257565ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:12:58.958891Z","caller":"traceutil/trace.go:171","msg":"trace[713857597] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"627.286174ms","start":"2026-05-08T18:12:58.33159Z","end":"2026-05-08T18:12:58.958876Z","steps":["trace[713857597] 'process raft request' (duration: 627.192633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:58.95893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.326357Z","time spent":"632.516466ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T18:12:58.958959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.331577Z","time spent":"627.346684ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:58.958941Z","caller":"traceutil/trace.go:171","msg":"trace[513650016] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"630.901009ms","start":"2026-05-08T18:12:58.328006Z","end":"2026-05-08T18:12:58.958907Z","steps":["trace[513650016] 'read index received' (duration: 14.122299ms)","trace[513650016] 'applied index is now lower than readState.Index' (duration: 616.77642ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:58.959246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.205912ms","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-05-08T18:12:58.959315Z","caller":"traceutil/trace.go:171","msg":"trace[759593747] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:591; }","duration":"631.327374ms","start":"2026-05-08T18:12:58.32797Z","end":"2026-05-08T18:12:58.959298Z","steps":["trace[759593747] 'agreement among raft nodes before linearized reading' (duration: 631.098282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:58.959367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.327957Z","time spent":"631.394004ms","remote":"127.0.0.1:43766","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":"info","ts":"2026-05-08T18:12:59.006891Z","caller":"traceutil/trace.go:171","msg":"trace[461991771] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"352.722518ms","start":"2026-05-08T18:12:58.654122Z","end":"2026-05-08T18:12:59.006844Z","steps":["trace[461991771] 'process raft request' (duration: 352.477076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.00698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.144065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.00704Z","caller":"traceutil/trace.go:171","msg":"trace[341977949] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:593; }","duration":"508.217886ms","start":"2026-05-08T18:12:58.498809Z","end":"2026-05-08T18:12:59.007027Z","steps":["trace[341977949] 'agreement among raft nodes before linearized reading' (duration: 508.088485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.372728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:59.007074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.498787Z","time spent":"508.279778ms","remote":"127.0.0.1:43822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"info","ts":"2026-05-08T18:12:59.00709Z","caller":"traceutil/trace.go:171","msg":"trace[1876265783] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:593; }","duration":"508.429659ms","start":"2026-05-08T18:12:58.498644Z","end":"2026-05-08T18:12:59.007074Z","steps":["trace[1876265783] 'agreement among raft nodes before linearized reading' (duration: 508.377598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.654091Z","time spent":"352.90675ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:12:59.007167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.574235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.007196Z","caller":"traceutil/trace.go:171","msg":"trace[1271003267] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:593; }","duration":"648.609835ms","start":"2026-05-08T18:12:58.358575Z","end":"2026-05-08T18:12:59.007185Z","steps":["trace[1271003267] 'agreement among raft nodes before linearized reading' (duration: 648.573554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.506167ms","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-05-08T18:12:59.007237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.358568Z","time spent":"648.660855ms","remote":"127.0.0.1:43786","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":"info","ts":"2026-05-08T18:12:59.007249Z","caller":"traceutil/trace.go:171","msg":"trace[585284701] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:593; }","duration":"615.618288ms","start":"2026-05-08T18:12:58.39162Z","end":"2026-05-08T18:12:59.007238Z","steps":["trace[585284701] 'agreement among raft nodes before linearized reading' (duration: 615.524247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.00725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.204693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:59.007127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.498625Z","time spent":"508.492869ms","remote":"127.0.0.1:43838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-05-08T18:12:59.007272Z","caller":"traceutil/trace.go:171","msg":"trace[27613555] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"259.271275ms","start":"2026-05-08T18:12:58.747994Z","end":"2026-05-08T18:12:59.007266Z","steps":["trace[27613555] 'agreement among raft nodes before linearized reading' (duration: 259.238454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.0073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.685091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.00732Z","caller":"traceutil/trace.go:171","msg":"trace[318126225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:593; }","duration":"508.704241ms","start":"2026-05-08T18:12:58.498609Z","end":"2026-05-08T18:12:59.007313Z","steps":["trace[318126225] 'agreement among raft nodes before linearized reading' (duration: 508.675311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.498572Z","time spent":"508.760982ms","remote":"127.0.0.1:43838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-08T18:12:59.00737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.047106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.00739Z","caller":"traceutil/trace.go:171","msg":"trace[1339754473] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:593; }","duration":"321.075596ms","start":"2026-05-08T18:12:58.686309Z","end":"2026-05-08T18:12:59.007385Z","steps":["trace[1339754473] 'agreement among raft nodes before linearized reading' (duration: 321.044865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.864379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:59.007408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.686305Z","time spent":"321.098066ms","remote":"127.0.0.1:43890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-05-08T18:12:59.007406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.222061ms","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-05-08T18:12:59.00744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.943829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.007412Z","caller":"traceutil/trace.go:171","msg":"trace[371744179] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:593; }","duration":"547.896039ms","start":"2026-05-08T18:12:58.459511Z","end":"2026-05-08T18:12:59.007407Z","steps":["trace[371744179] 'agreement among raft nodes before linearized reading' (duration: 547.867589ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:59.007457Z","caller":"traceutil/trace.go:171","msg":"trace[1468117638] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:593; }","duration":"548.003159ms","start":"2026-05-08T18:12:58.459449Z","end":"2026-05-08T18:12:59.007452Z","steps":["trace[1468117638] 'agreement among raft nodes before linearized reading' (duration: 547.976469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.459506Z","time spent":"547.953849ms","remote":"127.0.0.1:43822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-08T18:12:59.007501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.263828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:59.007505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.277978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.007517Z","caller":"traceutil/trace.go:171","msg":"trace[1936835320] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:593; }","duration":"588.282308ms","start":"2026-05-08T18:12:58.419229Z","end":"2026-05-08T18:12:59.007512Z","steps":["trace[1936835320] 'agreement among raft nodes before linearized reading' (duration: 588.256168ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:59.007525Z","caller":"traceutil/trace.go:171","msg":"trace[1839662732] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:593; }","duration":"321.307478ms","start":"2026-05-08T18:12:58.686212Z","end":"2026-05-08T18:12:59.007519Z","steps":["trace[1839662732] 'agreement among raft nodes before linearized reading' (duration: 321.275958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.419195Z","time spent":"588.335269ms","remote":"127.0.0.1:43800","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":"warn","ts":"2026-05-08T18:12:59.007544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.686208Z","time spent":"321.331338ms","remote":"127.0.0.1:43890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-08T18:12:59.007595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.443264ms","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-05-08T18:12:59.00762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.486189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.007622Z","caller":"traceutil/trace.go:171","msg":"trace[322259199] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:593; }","duration":"649.473324ms","start":"2026-05-08T18:12:58.358141Z","end":"2026-05-08T18:12:59.007614Z","steps":["trace[322259199] 'agreement among raft nodes before linearized reading' (duration: 649.429274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.669832ms","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-05-08T18:12:59.00764Z","caller":"traceutil/trace.go:171","msg":"trace[1922660472] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:593; }","duration":"321.51734ms","start":"2026-05-08T18:12:58.686116Z","end":"2026-05-08T18:12:59.007633Z","steps":["trace[1922660472] 'agreement among raft nodes before linearized reading' (duration: 321.48848ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:59.007655Z","caller":"traceutil/trace.go:171","msg":"trace[1558749294] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:593; }","duration":"588.713882ms","start":"2026-05-08T18:12:58.418935Z","end":"2026-05-08T18:12:59.007649Z","steps":["trace[1558749294] 'agreement among raft nodes before linearized reading' (duration: 588.684552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.358088Z","time spent":"649.557674ms","remote":"127.0.0.1:43786","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":"warn","ts":"2026-05-08T18:12:59.007659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.686109Z","time spent":"321.54466ms","remote":"127.0.0.1:43890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-05-08T18:12:59.007671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.418916Z","time spent":"588.751233ms","remote":"127.0.0.1:43812","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-05-08T18:12:59.0077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.992343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:59.007748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.051544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.007744Z","caller":"traceutil/trace.go:171","msg":"trace[126462816] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:593; }","duration":"616.057563ms","start":"2026-05-08T18:12:58.391674Z","end":"2026-05-08T18:12:59.007731Z","steps":["trace[126462816] 'agreement among raft nodes before linearized reading' (duration: 615.979732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.212359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.007772Z","caller":"traceutil/trace.go:171","msg":"trace[240818026] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:593; }","duration":"334.085404ms","start":"2026-05-08T18:12:58.67368Z","end":"2026-05-08T18:12:59.007765Z","steps":["trace[240818026] 'agreement among raft nodes before linearized reading' (duration: 334.046764ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:59.007786Z","caller":"traceutil/trace.go:171","msg":"trace[1659295891] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:593; }","duration":"661.28808ms","start":"2026-05-08T18:12:58.346489Z","end":"2026-05-08T18:12:59.007777Z","steps":["trace[1659295891] 'agreement among raft nodes before linearized reading' (duration: 661.249129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.00779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.391668Z","time spent":"616.108904ms","remote":"127.0.0.1:43800","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-05-08T18:12:59.007815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.346469Z","time spent":"661.337921ms","remote":"127.0.0.1:43774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-08T18:12:59.007822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.274686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.007839Z","caller":"traceutil/trace.go:171","msg":"trace[2099809187] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:593; }","duration":"334.301096ms","start":"2026-05-08T18:12:58.673533Z","end":"2026-05-08T18:12:59.007834Z","steps":["trace[2099809187] 'agreement among raft nodes before linearized reading' (duration: 334.271236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.994379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.007877Z","caller":"traceutil/trace.go:171","msg":"trace[17547918] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:593; }","duration":"459.048471ms","start":"2026-05-08T18:12:58.548823Z","end":"2026-05-08T18:12:59.007871Z","steps":["trace[17547918] 'agreement among raft nodes before linearized reading' (duration: 459.01598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.02467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:59.007896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.548807Z","time spent":"459.082051ms","remote":"127.0.0.1:43848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-05-08T18:12:59.007901Z","caller":"traceutil/trace.go:171","msg":"trace[1701428391] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:593; }","duration":"459.073631ms","start":"2026-05-08T18:12:58.548822Z","end":"2026-05-08T18:12:59.007895Z","steps":["trace[1701428391] 'agreement among raft nodes before linearized reading' (duration: 459.047941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.007928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.548803Z","time spent":"459.120631ms","remote":"127.0.0.1:43848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-08T18:12:59.006978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.907144ms","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":"warn","ts":"2026-05-08T18:12:59.007967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.006985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:59.007997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.026078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.008002Z","caller":"traceutil/trace.go:171","msg":"trace[1576911728] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:593; }","duration":"589.073956ms","start":"2026-05-08T18:12:58.418918Z","end":"2026-05-08T18:12:59.007992Z","steps":["trace[1576911728] 'agreement among raft nodes before linearized reading' (duration: 589.015005ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:59.008028Z","caller":"traceutil/trace.go:171","msg":"trace[582284570] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:593; }","duration":"662.059058ms","start":"2026-05-08T18:12:58.345961Z","end":"2026-05-08T18:12:59.00802Z","steps":["trace[582284570] 'agreement among raft nodes before linearized reading' (duration: 662.012558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.00804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.418904Z","time spent":"589.127876ms","remote":"127.0.0.1:43812","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-05-08T18:12:59.008062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.762919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:12:59.00806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.345948Z","time spent":"662.103828ms","remote":"127.0.0.1:43774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-08T18:12:59.008081Z","caller":"traceutil/trace.go:171","msg":"trace[417970309] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:593; }","duration":"347.80015ms","start":"2026-05-08T18:12:58.660275Z","end":"2026-05-08T18:12:59.008075Z","steps":["trace[417970309] 'agreement among raft nodes before linearized reading' (duration: 347.773869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.0081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.660262Z","time spent":"347.83252ms","remote":"127.0.0.1:43872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-08T18:12:59.007272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.391599Z","time spent":"615.66603ms","remote":"127.0.0.1:43800","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-05-08T18:12:59.007475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.459429Z","time spent":"548.040801ms","remote":"127.0.0.1:43822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-08T18:12:59.008164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.231949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.008189Z","caller":"traceutil/trace.go:171","msg":"trace[335346352] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:593; }","duration":"662.27473ms","start":"2026-05-08T18:12:58.345908Z","end":"2026-05-08T18:12:59.008182Z","steps":["trace[335346352] 'agreement among raft nodes before linearized reading' (duration: 662.236619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.008221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.458186ms","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-05-08T18:12:59.008242Z","caller":"traceutil/trace.go:171","msg":"trace[93773910] 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:593; }","duration":"438.484036ms","start":"2026-05-08T18:12:58.569749Z","end":"2026-05-08T18:12:59.008233Z","steps":["trace[93773910] 'agreement among raft nodes before linearized reading' (duration: 438.458346ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:59.007978Z","caller":"traceutil/trace.go:171","msg":"trace[1770857882] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:593; }","duration":"679.940155ms","start":"2026-05-08T18:12:58.328032Z","end":"2026-05-08T18:12:59.007972Z","steps":["trace[1770857882] 'agreement among raft nodes before linearized reading' (duration: 678.860624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.008249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.782523ms","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-05-08T18:12:59.008264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.569745Z","time spent":"438.513576ms","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-05-08T18:12:59.007435Z","caller":"traceutil/trace.go:171","msg":"trace[1019279965] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:593; }","duration":"649.265681ms","start":"2026-05-08T18:12:58.358161Z","end":"2026-05-08T18:12:59.007427Z","steps":["trace[1019279965] 'agreement among raft nodes before linearized reading' (duration: 649.223021ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:12:59.008272Z","caller":"traceutil/trace.go:171","msg":"trace[68377994] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:593; }","duration":"679.855273ms","start":"2026-05-08T18:12:58.32841Z","end":"2026-05-08T18:12:59.008265Z","steps":["trace[68377994] 'agreement among raft nodes before linearized reading' (duration: 679.823343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.008298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.358156Z","time spent":"650.131041ms","remote":"127.0.0.1:43786","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-05-08T18:12:59.0083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.328029Z","time spent":"680.241057ms","remote":"127.0.0.1:43766","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-05-08T18:12:59.008038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.717009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.00836Z","caller":"traceutil/trace.go:171","msg":"trace[252139548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:593; }","duration":"348.035892ms","start":"2026-05-08T18:12:58.660317Z","end":"2026-05-08T18:12:59.008352Z","steps":["trace[252139548] 'agreement among raft nodes before linearized reading' (duration: 347.708379ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.008366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.638588ms","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-05-08T18:12:59.008386Z","caller":"traceutil/trace.go:171","msg":"trace[1352804045] 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:593; }","duration":"438.662339ms","start":"2026-05-08T18:12:58.569718Z","end":"2026-05-08T18:12:59.00838Z","steps":["trace[1352804045] 'agreement among raft nodes before linearized reading' (duration: 438.628298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.008387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.660305Z","time spent":"348.073753ms","remote":"127.0.0.1:43872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-08T18:12:59.007793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.673677Z","time spent":"334.111375ms","remote":"127.0.0.1:43872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-05-08T18:12:59.008409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.569701Z","time spent":"438.700859ms","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-05-08T18:12:59.008216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.345897Z","time spent":"662.31189ms","remote":"127.0.0.1:43774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-08T18:12:59.008298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.328396Z","time spent":"679.895775ms","remote":"127.0.0.1:43766","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-05-08T18:12:59.00849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.201372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.008509Z","caller":"traceutil/trace.go:171","msg":"trace[1830565753] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:593; }","duration":"459.242892ms","start":"2026-05-08T18:12:58.54926Z","end":"2026-05-08T18:12:59.008503Z","steps":["trace[1830565753] 'agreement among raft nodes before linearized reading' (duration: 459.213291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.008526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.549246Z","time spent":"459.275242ms","remote":"127.0.0.1:43848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-08T18:12:59.007858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.67353Z","time spent":"334.323626ms","remote":"127.0.0.1:43884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-08T18:12:59.008196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.406486ms","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-05-08T18:12:59.008606Z","caller":"traceutil/trace.go:171","msg":"trace[1449769512] 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:593; }","duration":"437.84156ms","start":"2026-05-08T18:12:58.570758Z","end":"2026-05-08T18:12:59.0086Z","steps":["trace[1449769512] 'agreement among raft nodes before linearized reading' (duration: 437.420016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.008628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.570745Z","time spent":"437.876411ms","remote":"127.0.0.1:43860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-05-08T18:12:59.008012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.566639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:12:59.0087Z","caller":"traceutil/trace.go:171","msg":"trace[56584904] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:593; }","duration":"335.269616ms","start":"2026-05-08T18:12:58.673424Z","end":"2026-05-08T18:12:59.008694Z","steps":["trace[56584904] 'agreement among raft nodes before linearized reading' (duration: 334.569909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.008723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:58.673416Z","time spent":"335.298136ms","remote":"127.0.0.1:43884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-08T18:12:59.364237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.113132ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:12:59.364351Z","caller":"traceutil/trace.go:171","msg":"trace[131961935] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"341.17753ms","start":"2026-05-08T18:12:59.023156Z","end":"2026-05-08T18:12:59.364333Z","steps":["trace[131961935] 'process raft request' (duration: 159.879115ms)","trace[131961935] 'compare' (duration: 180.968049ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:12:59.364419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:59.023143Z","time spent":"341.245671ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:59.375882Z","caller":"traceutil/trace.go:171","msg":"trace[304046825] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"344.767985ms","start":"2026-05-08T18:12:59.031092Z","end":"2026-05-08T18:12:59.375859Z","steps":["trace[304046825] 'process raft request' (duration: 344.525641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:12:59.37599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:12:59.031059Z","time spent":"344.873356ms","remote":"127.0.0.1:33264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:12:59.376107Z","caller":"traceutil/trace.go:171","msg":"trace[964232700] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"271.544294ms","start":"2026-05-08T18:12:59.10455Z","end":"2026-05-08T18:12:59.376094Z","steps":["trace[964232700] 'process raft request' (duration: 271.483673ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:00.095882Z","caller":"traceutil/trace.go:171","msg":"trace[791238305] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"272.686958ms","start":"2026-05-08T18:12:59.823161Z","end":"2026-05-08T18:13:00.095848Z","steps":["trace[791238305] 'process raft request' (duration: 271.477501ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:00.374854Z","caller":"traceutil/trace.go:171","msg":"trace[577271368] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"118.549268ms","start":"2026-05-08T18:13:00.256264Z","end":"2026-05-08T18:13:00.374813Z","steps":["trace[577271368] 'process raft request' (duration: 109.175988ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:01.991574Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114213264466932,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T18:13:02.000551Z","caller":"traceutil/trace.go:171","msg":"trace[419592416] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"509.627974ms","start":"2026-05-08T18:13:01.490887Z","end":"2026-05-08T18:13:02.000515Z","steps":["trace[419592416] 'read index received' (duration: 509.287813ms)","trace[419592416] 'applied index is now lower than readState.Index' (duration: 338.581µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:13:02.000614Z","caller":"traceutil/trace.go:171","msg":"trace[1743909768] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"528.413382ms","start":"2026-05-08T18:13:01.472169Z","end":"2026-05-08T18:13:02.000582Z","steps":["trace[1743909768] 'process raft request' (duration: 528.129724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:02.000767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.847858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T18:13:02.000779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:01.47213Z","time spent":"528.560231ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:13:02.000819Z","caller":"traceutil/trace.go:171","msg":"trace[191000495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"509.968385ms","start":"2026-05-08T18:13:01.490838Z","end":"2026-05-08T18:13:02.000806Z","steps":["trace[191000495] 'agreement among raft nodes before linearized reading' (duration: 509.855588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:02.000863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:01.490818Z","time spent":"510.03459ms","remote":"127.0.0.1:33194","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-05-08T18:13:02.000944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.031525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:13:02.001075Z","caller":"traceutil/trace.go:171","msg":"trace[1937177105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"252.180294ms","start":"2026-05-08T18:13:01.748817Z","end":"2026-05-08T18:13:02.000997Z","steps":["trace[1937177105] 'agreement among raft nodes before linearized reading' (duration: 252.033365ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:04.513593Z","caller":"traceutil/trace.go:171","msg":"trace[288375365] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"125.348916ms","start":"2026-05-08T18:13:04.388223Z","end":"2026-05-08T18:13:04.513572Z","steps":["trace[288375365] 'read index received' (duration: 124.636163ms)","trace[288375365] 'applied index is now lower than readState.Index' (duration: 711.913µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:13:04.513675Z","caller":"traceutil/trace.go:171","msg":"trace[134052149] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"196.573628ms","start":"2026-05-08T18:13:04.317096Z","end":"2026-05-08T18:13:04.513669Z","steps":["trace[134052149] 'process raft request' (duration: 196.037925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:04.513888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.655295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-08T18:13:04.513909Z","caller":"traceutil/trace.go:171","msg":"trace[1990992187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:622; }","duration":"125.7399ms","start":"2026-05-08T18:13:04.388162Z","end":"2026-05-08T18:13:04.513902Z","steps":["trace[1990992187] 'agreement among raft nodes before linearized reading' (duration: 125.680016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:04.711521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.943801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:13:04.711733Z","caller":"traceutil/trace.go:171","msg":"trace[2020685867] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"192.822062ms","start":"2026-05-08T18:13:04.518893Z","end":"2026-05-08T18:13:04.711715Z","steps":["trace[2020685867] 'process raft request' (duration: 192.732416ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:04.711758Z","caller":"traceutil/trace.go:171","msg":"trace[838255964] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"194.089108ms","start":"2026-05-08T18:13:04.517627Z","end":"2026-05-08T18:13:04.711716Z","steps":["trace[838255964] 'process raft request' (duration: 39.833878ms)","trace[838255964] 'compare' (duration: 153.790272ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:13:04.711967Z","caller":"traceutil/trace.go:171","msg":"trace[1860594040] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"193.012103ms","start":"2026-05-08T18:13:04.518944Z","end":"2026-05-08T18:13:04.711956Z","steps":["trace[1860594040] 'process raft request' (duration: 192.732896ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:04.711969Z","caller":"traceutil/trace.go:171","msg":"trace[818999331] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"141.26603ms","start":"2026-05-08T18:13:04.57068Z","end":"2026-05-08T18:13:04.711946Z","steps":["trace[818999331] 'process raft request' (duration: 141.171785ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:05.324059Z","caller":"traceutil/trace.go:171","msg":"trace[64968580] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"171.707504ms","start":"2026-05-08T18:13:05.152322Z","end":"2026-05-08T18:13:05.324029Z","steps":["trace[64968580] 'process raft request' (duration: 171.079577ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:05.727874Z","caller":"traceutil/trace.go:171","msg":"trace[1475224594] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"331.63177ms","start":"2026-05-08T18:13:05.396203Z","end":"2026-05-08T18:13:05.727835Z","steps":["trace[1475224594] 'process raft request' (duration: 330.805471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:05.728225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:05.39617Z","time spent":"331.988332ms","remote":"127.0.0.1:33524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T18:13:06.387396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.022713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hkpm2\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-08T18:13:06.387469Z","caller":"traceutil/trace.go:171","msg":"trace[473338023] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hkpm2; range_end:; response_count:1; response_revision:631; }","duration":"304.128118ms","start":"2026-05-08T18:13:06.083321Z","end":"2026-05-08T18:13:06.387449Z","steps":["trace[473338023] 'range keys from in-memory index tree' (duration: 303.863053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:06.387503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.083305Z","time spent":"304.189222ms","remote":"127.0.0.1:33374","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-hkpm2\" "} {"level":"warn","ts":"2026-05-08T18:13:06.387943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.829352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-08T18:13:06.388099Z","caller":"traceutil/trace.go:171","msg":"trace[313374030] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"373.021973ms","start":"2026-05-08T18:13:06.015039Z","end":"2026-05-08T18:13:06.388061Z","steps":["trace[313374030] 'range keys from in-memory index tree' (duration: 372.489412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:06.388173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.015023Z","time spent":"373.13606ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T18:13:06.632872Z","caller":"traceutil/trace.go:171","msg":"trace[1372538876] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"434.158833ms","start":"2026-05-08T18:13:06.198663Z","end":"2026-05-08T18:13:06.632822Z","steps":["trace[1372538876] 'process raft request' (duration: 433.357556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:06.633177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.198635Z","time spent":"434.403908ms","remote":"127.0.0.1:33308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:13:07.216886Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114213264467009,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T18:13:07.409207Z","caller":"traceutil/trace.go:171","msg":"trace[1152535485] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"1.037624704s","start":"2026-05-08T18:13:06.371558Z","end":"2026-05-08T18:13:07.409182Z","steps":["trace[1152535485] 'process raft request' (duration: 1.020143132s)","trace[1152535485] 'compare' (duration: 16.886347ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:13:07.409273Z","caller":"traceutil/trace.go:171","msg":"trace[603613565] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.004645373s","start":"2026-05-08T18:13:06.404595Z","end":"2026-05-08T18:13:07.40924Z","steps":["trace[603613565] 'process raft request' (duration: 1.004515086s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:07.409536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.40452Z","time spent":"1.00494014s","remote":"127.0.0.1:33374","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-05-08T18:13:07.409543Z","caller":"traceutil/trace.go:171","msg":"trace[307636407] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.016583902s","start":"2026-05-08T18:13:06.392925Z","end":"2026-05-08T18:13:07.409508Z","steps":["trace[307636407] 'process raft request' (duration: 1.016074852s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:07.409669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.371531Z","time spent":"1.037758872s","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:13:07.409726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.392876Z","time spent":"1.016757171s","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:13:07.420391Z","caller":"traceutil/trace.go:171","msg":"trace[1961897445] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:653; }","duration":"703.959017ms","start":"2026-05-08T18:13:06.71642Z","end":"2026-05-08T18:13:07.420379Z","steps":["trace[1961897445] 'read index received' (duration: 675.291458ms)","trace[1961897445] 'applied index is now lower than readState.Index' (duration: 28.666969ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:13:07.420439Z","caller":"traceutil/trace.go:171","msg":"trace[883597194] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"721.002846ms","start":"2026-05-08T18:13:06.69942Z","end":"2026-05-08T18:13:07.420423Z","steps":["trace[883597194] 'process raft request' (duration: 720.885909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:07.4205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.699384Z","time spent":"721.08583ms","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T18:13:07.420589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.134797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-08T18:13:07.420612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.17997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-08T18:13:07.420636Z","caller":"traceutil/trace.go:171","msg":"trace[1120397312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"704.245574ms","start":"2026-05-08T18:13:06.716378Z","end":"2026-05-08T18:13:07.420624Z","steps":["trace[1120397312] 'agreement among raft nodes before linearized reading' (duration: 704.109966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:07.420665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.716354Z","time spent":"704.306367ms","remote":"127.0.0.1:33450","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-05-08T18:13:07.420675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.225531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:13:07.420767Z","caller":"traceutil/trace.go:171","msg":"trace[393476647] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"671.413562ms","start":"2026-05-08T18:13:06.749339Z","end":"2026-05-08T18:13:07.420753Z","steps":["trace[393476647] 'agreement among raft nodes before linearized reading' (duration: 671.222821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:07.420837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.749321Z","time spent":"671.508077ms","remote":"127.0.0.1:33200","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-05-08T18:13:07.420718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.206951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T18:13:07.420918Z","caller":"traceutil/trace.go:171","msg":"trace[372155679] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"704.400703ms","start":"2026-05-08T18:13:06.716488Z","end":"2026-05-08T18:13:07.420889Z","steps":["trace[372155679] 'agreement among raft nodes before linearized reading' (duration: 704.173649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:07.421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.716482Z","time spent":"704.490348ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-08T18:13:07.420639Z","caller":"traceutil/trace.go:171","msg":"trace[1948855514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"704.228493ms","start":"2026-05-08T18:13:06.716403Z","end":"2026-05-08T18:13:07.420631Z","steps":["trace[1948855514] 'agreement among raft nodes before linearized reading' (duration: 704.063313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:07.421135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:06.716349Z","time spent":"704.778394ms","remote":"127.0.0.1:33450","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-05-08T18:13:09.03546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286641956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:13:09.035528Z","caller":"traceutil/trace.go:171","msg":"trace[1158017678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"1.286773373s","start":"2026-05-08T18:13:07.748739Z","end":"2026-05-08T18:13:09.035512Z","steps":["trace[1158017678] 'range keys from in-memory index tree' (duration: 1.2865553s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:09.035563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:07.748716Z","time spent":"1.286839767s","remote":"127.0.0.1:33194","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-05-08T18:13:09.537204Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114213264467021,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T18:13:10.030412Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.158928408s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T18:13:10.032583Z","caller":"traceutil/trace.go:171","msg":"trace[316552650] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"2.162595465s","start":"2026-05-08T18:13:07.869944Z","end":"2026-05-08T18:13:10.032539Z","steps":["trace[316552650] 'process raft request' (duration: 2.161387138s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:10.032775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:07.869914Z","time spent":"2.162729153s","remote":"127.0.0.1:33308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:13:10.071701Z","caller":"traceutil/trace.go:171","msg":"trace[751489628] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"1.035011059s","start":"2026-05-08T18:13:09.036638Z","end":"2026-05-08T18:13:10.071649Z","steps":["trace[751489628] 'read index received' (duration: 994.125734ms)","trace[751489628] 'applied index is now lower than readState.Index' (duration: 40.884375ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:13:10.07701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040364229s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:13:10.077093Z","caller":"traceutil/trace.go:171","msg":"trace[1393014713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"1.040452043s","start":"2026-05-08T18:13:09.036625Z","end":"2026-05-08T18:13:10.077077Z","steps":["trace[1393014713] 'agreement among raft nodes before linearized reading' (duration: 1.040329207s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:10.07713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:09.03658Z","time spent":"1.040536228s","remote":"127.0.0.1:33200","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-05-08T18:13:10.077476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.208188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-08T18:13:10.077509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.496053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-08T18:13:10.077544Z","caller":"traceutil/trace.go:171","msg":"trace[1605439725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:640; }","duration":"599.317634ms","start":"2026-05-08T18:13:09.478204Z","end":"2026-05-08T18:13:10.077522Z","steps":["trace[1605439725] 'agreement among raft nodes before linearized reading' (duration: 599.136724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:10.077582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:09.478184Z","time spent":"599.391908ms","remote":"127.0.0.1:33450","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-05-08T18:13:10.077649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.178587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T18:13:10.077649Z","caller":"traceutil/trace.go:171","msg":"trace[1533480260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:640; }","duration":"588.615659ms","start":"2026-05-08T18:13:09.488953Z","end":"2026-05-08T18:13:10.077569Z","steps":["trace[1533480260] 'agreement among raft nodes before linearized reading' (duration: 588.404607ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:10.077675Z","caller":"traceutil/trace.go:171","msg":"trace[307050680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:640; }","duration":"590.209009ms","start":"2026-05-08T18:13:09.487455Z","end":"2026-05-08T18:13:10.077664Z","steps":["trace[307050680] 'agreement among raft nodes before linearized reading' (duration: 589.877011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:10.077682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:09.488938Z","time spent":"588.736406ms","remote":"127.0.0.1:33450","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-05-08T18:13:10.077695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:09.48745Z","time spent":"590.239871ms","remote":"127.0.0.1:33450","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-05-08T18:13:10.077826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.525934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-08T18:13:10.077941Z","caller":"traceutil/trace.go:171","msg":"trace[1220119697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:640; }","duration":"663.598177ms","start":"2026-05-08T18:13:09.41425Z","end":"2026-05-08T18:13:10.077848Z","steps":["trace[1220119697] 'agreement among raft nodes before linearized reading' (duration: 663.039486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:10.077971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:09.414227Z","time spent":"663.736766ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T18:13:11.628153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.873164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:13:11.628329Z","caller":"traceutil/trace.go:171","msg":"trace[1073637488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"134.080756ms","start":"2026-05-08T18:13:11.494219Z","end":"2026-05-08T18:13:11.6283Z","steps":["trace[1073637488] 'range keys from in-memory index tree' (duration: 133.810271ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:20.576677Z","caller":"traceutil/trace.go:171","msg":"trace[999005232] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"120.752003ms","start":"2026-05-08T18:13:20.455886Z","end":"2026-05-08T18:13:20.576638Z","steps":["trace[999005232] 'process raft request' (duration: 120.514731ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:20.581768Z","caller":"traceutil/trace.go:171","msg":"trace[154125788] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"118.867958ms","start":"2026-05-08T18:13:20.462876Z","end":"2026-05-08T18:13:20.581744Z","steps":["trace[154125788] 'process raft request' (duration: 118.730642ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:20.701264Z","caller":"traceutil/trace.go:171","msg":"trace[579424935] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"115.303842ms","start":"2026-05-08T18:13:20.585934Z","end":"2026-05-08T18:13:20.701238Z","steps":["trace[579424935] 'process raft request' (duration: 107.509633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:26.250177Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114213264467349,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T18:13:26.750496Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114213264467349,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T18:13:26.943023Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.757158143s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T18:13:26.943632Z","caller":"traceutil/trace.go:171","msg":"trace[1826445738] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"1.757920179s","start":"2026-05-08T18:13:25.185689Z","end":"2026-05-08T18:13:26.943609Z","steps":["trace[1826445738] 'process raft request' (duration: 1.757638906s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:26.943916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:25.185663Z","time spent":"1.75816814s","remote":"127.0.0.1:33374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:13:26.955859Z","caller":"traceutil/trace.go:171","msg":"trace[945519722] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:836; }","duration":"1.206667287s","start":"2026-05-08T18:13:25.749169Z","end":"2026-05-08T18:13:26.955837Z","steps":["trace[945519722] 'read index received' (duration: 1.194136042s)","trace[945519722] 'applied index is now lower than readState.Index' (duration: 12.530365ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:13:26.955968Z","caller":"traceutil/trace.go:171","msg":"trace[1884799276] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"567.679164ms","start":"2026-05-08T18:13:26.38828Z","end":"2026-05-08T18:13:26.955959Z","steps":["trace[1884799276] 'process raft request' (duration: 567.430122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:26.956068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:26.38825Z","time spent":"567.749467ms","remote":"127.0.0.1:33372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5052,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T18:13:26.956165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.795903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-08T18:13:26.956272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.229161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-08T18:13:26.956296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.233905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-08T18:13:26.956328Z","caller":"traceutil/trace.go:171","msg":"trace[1599077879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:811; }","duration":"794.291908ms","start":"2026-05-08T18:13:26.162028Z","end":"2026-05-08T18:13:26.95632Z","steps":["trace[1599077879] 'agreement among raft nodes before linearized reading' (duration: 794.158612ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:26.956326Z","caller":"traceutil/trace.go:171","msg":"trace[193272709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:811; }","duration":"798.320156ms","start":"2026-05-08T18:13:26.15799Z","end":"2026-05-08T18:13:26.95631Z","steps":["trace[193272709] 'agreement among raft nodes before linearized reading' (duration: 798.19478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:26.956356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:26.162017Z","time spent":"794.333019ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-08T18:13:26.956361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:26.157968Z","time spent":"798.385069ms","remote":"127.0.0.1:33450","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-05-08T18:13:26.956276Z","caller":"traceutil/trace.go:171","msg":"trace[813888849] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:811; }","duration":"933.961521ms","start":"2026-05-08T18:13:26.022301Z","end":"2026-05-08T18:13:26.956263Z","steps":["trace[813888849] 'agreement among raft nodes before linearized reading' (duration: 933.686028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:26.956489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:26.022274Z","time spent":"934.205582ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-08T18:13:26.956543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207384321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T18:13:26.95659Z","caller":"traceutil/trace.go:171","msg":"trace[840387126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"1.207472185s","start":"2026-05-08T18:13:25.749108Z","end":"2026-05-08T18:13:26.95658Z","steps":["trace[840387126] 'agreement among raft nodes before linearized reading' (duration: 1.207017204s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:26.956618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:25.749089Z","time spent":"1.207523928s","remote":"127.0.0.1:33194","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-05-08T18:13:26.956509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.206077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-08T18:13:26.956742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.5011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-08T18:13:26.956794Z","caller":"traceutil/trace.go:171","msg":"trace[87394143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"787.578614ms","start":"2026-05-08T18:13:26.169204Z","end":"2026-05-08T18:13:26.956783Z","steps":["trace[87394143] 'agreement among raft nodes before linearized reading' (duration: 786.888381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:26.956832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:26.169192Z","time spent":"787.630076ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-08T18:13:26.956852Z","caller":"traceutil/trace.go:171","msg":"trace[343724626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:811; }","duration":"787.538092ms","start":"2026-05-08T18:13:26.169239Z","end":"2026-05-08T18:13:26.956777Z","steps":["trace[343724626] 'agreement among raft nodes before linearized reading' (duration: 786.929154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:26.956966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:26.169218Z","time spent":"787.735312ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-08T18:13:41.353066Z","caller":"traceutil/trace.go:171","msg":"trace[1631139128] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"105.32133ms","start":"2026-05-08T18:13:41.247726Z","end":"2026-05-08T18:13:41.353047Z","steps":["trace[1631139128] 'process raft request' (duration: 105.199655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:13:41.677492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.015227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T18:13:41.677669Z","caller":"traceutil/trace.go:171","msg":"trace[1235733061] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"208.747353ms","start":"2026-05-08T18:13:41.468906Z","end":"2026-05-08T18:13:41.677653Z","steps":["trace[1235733061] 'process raft request' (duration: 208.705302ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:13:41.677743Z","caller":"traceutil/trace.go:171","msg":"trace[56945651] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"306.260381ms","start":"2026-05-08T18:13:41.371462Z","end":"2026-05-08T18:13:41.677723Z","steps":["trace[56945651] 'process raft request' (duration: 191.950922ms)","trace[56945651] 'compare' (duration: 113.902223ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T18:13:41.677833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T18:13:41.371439Z","time spent":"306.347965ms","remote":"127.0.0.1:33632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T18:13:41.677899Z","caller":"traceutil/trace.go:171","msg":"trace[367473876] transaction","detail":"{read_only:false; number_of_response:1; response_revision:987; }","duration":"249.268803ms","start":"2026-05-08T18:13:41.428611Z","end":"2026-05-08T18:13:41.67788Z","steps":["trace[367473876] 'process raft request' (duration: 248.960751ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:14:05.25294Z","caller":"traceutil/trace.go:171","msg":"trace[1230994187] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"103.007887ms","start":"2026-05-08T18:14:05.149912Z","end":"2026-05-08T18:14:05.25292Z","steps":["trace[1230994187] 'process raft request' (duration: 101.788088ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:14:33.562617Z","caller":"traceutil/trace.go:171","msg":"trace[1470682483] linearizableReadLoop","detail":"{readStateIndex:1204; appliedIndex:1203; }","duration":"119.428485ms","start":"2026-05-08T18:14:33.443165Z","end":"2026-05-08T18:14:33.562593Z","steps":["trace[1470682483] 'read index received' (duration: 119.25641ms)","trace[1470682483] 'applied index is now lower than readState.Index' (duration: 171.165µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:14:33.562749Z","caller":"traceutil/trace.go:171","msg":"trace[38403631] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"127.870342ms","start":"2026-05-08T18:14:33.434868Z","end":"2026-05-08T18:14:33.562738Z","steps":["trace[38403631] 'process raft request' (duration: 127.580225ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:14:33.563236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.065391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-08T18:14:33.563285Z","caller":"traceutil/trace.go:171","msg":"trace[1282999485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1162; }","duration":"120.144353ms","start":"2026-05-08T18:14:33.443127Z","end":"2026-05-08T18:14:33.563271Z","steps":["trace[1282999485] 'agreement among raft nodes before linearized reading' (duration: 120.045361ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:15:15.749309Z","caller":"traceutil/trace.go:171","msg":"trace[924401140] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"105.860674ms","start":"2026-05-08T18:15:15.643389Z","end":"2026-05-08T18:15:15.74925Z","steps":["trace[924401140] 'process raft request' (duration: 105.66231ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:15:15.986118Z","caller":"traceutil/trace.go:171","msg":"trace[1898651195] linearizableReadLoop","detail":"{readStateIndex:1388; appliedIndex:1387; }","duration":"135.673383ms","start":"2026-05-08T18:15:15.850425Z","end":"2026-05-08T18:15:15.986099Z","steps":["trace[1898651195] 'read index received' (duration: 135.50464ms)","trace[1898651195] 'applied index is now lower than readState.Index' (duration: 167.773µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T18:15:15.986166Z","caller":"traceutil/trace.go:171","msg":"trace[1824283780] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"229.179524ms","start":"2026-05-08T18:15:15.756965Z","end":"2026-05-08T18:15:15.986144Z","steps":["trace[1824283780] 'process raft request' (duration: 229.007131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T18:15:15.986492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.689197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-08T18:15:15.986555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.121843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T18:15:15.986609Z","caller":"traceutil/trace.go:171","msg":"trace[9239573] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1337; }","duration":"136.200724ms","start":"2026-05-08T18:15:15.850392Z","end":"2026-05-08T18:15:15.986592Z","steps":["trace[9239573] 'agreement among raft nodes before linearized reading' (duration: 135.812196ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T18:15:15.986629Z","caller":"traceutil/trace.go:171","msg":"trace[908708080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1337; }","duration":"120.82238ms","start":"2026-05-08T18:15:15.865741Z","end":"2026-05-08T18:15:15.986563Z","steps":["trace[908708080] 'agreement among raft nodes before linearized reading' (duration: 120.604035ms)"],"step_count":1}