{"level":"warn","ts":"2026-05-30T09:43:40.809304Z","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-30T09:43:40.809444Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74: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.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-30T09:43:40.809534Z","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-30T09:43:40.809548Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-05-30T09:43:40.809578Z","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-30T09:43:40.81069Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-05-30T09:43:40.810843Z","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.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-30T09:43:40.816102Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.974653ms"} {"level":"info","ts":"2026-05-30T09:43:40.824734Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-05-30T09:43:40.824847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T09:43:40.824979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-05-30T09:43:40.825006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T09:43:40.825018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-05-30T09:43:40.825112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-05-30T09:43:40.833045Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T09:43:40.834268Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T09:43:40.83539Z","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-30T09:43:40.837837Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T09:43:40.837984Z","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-30T09:43:40.838028Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T09:43:40.838126Z","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-30T09:43:40.838162Z","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-30T09:43:40.840974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-05-30T09:43:40.84122Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-05-30T09:43:40.844453Z","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-30T09:43:40.844608Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-05-30T09:43:40.844642Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-05-30T09:43:40.845804Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T09:43:40.845751Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T09:43:41.327617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T09:43:41.327675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T09:43:41.32769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-05-30T09:43:41.327702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-05-30T09:43:41.327709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-05-30T09:43:41.327716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-05-30T09:43:41.327724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-05-30T09:43:41.332056Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T09:43:41.333225Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T09:43:41.333193Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T09:43:41.333504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T09:43:41.333699Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T09:43:41.333816Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T09:43:41.337798Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-30T09:43:41.338002Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T09:43:41.338214Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T09:43:41.338256Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T09:43:41.344302Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"info","ts":"2026-05-30T09:43:42.995333Z","caller":"traceutil/trace.go:171","msg":"trace[1603543943] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"253.46335ms","start":"2026-05-30T09:43:42.741815Z","end":"2026-05-30T09:43:42.995278Z","steps":["trace[1603543943] 'process raft request' (duration: 199.163395ms)","trace[1603543943] 'compare' (duration: 54.020253ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:42.995458Z","caller":"traceutil/trace.go:171","msg":"trace[251793702] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"253.22223ms","start":"2026-05-30T09:43:42.742209Z","end":"2026-05-30T09:43:42.995432Z","steps":["trace[251793702] 'process raft request' (duration: 253.018211ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:42.995449Z","caller":"traceutil/trace.go:171","msg":"trace[260057375] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"252.674167ms","start":"2026-05-30T09:43:42.742746Z","end":"2026-05-30T09:43:42.99542Z","steps":["trace[260057375] 'process raft request' (duration: 252.563902ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:42.995385Z","caller":"traceutil/trace.go:171","msg":"trace[1822021451] linearizableReadLoop","detail":"{readStateIndex:11; appliedIndex:5; }","duration":"241.622714ms","start":"2026-05-30T09:43:42.753733Z","end":"2026-05-30T09:43:42.995356Z","steps":["trace[1822021451] 'read index received' (duration: 187.259867ms)","trace[1822021451] 'applied index is now lower than readState.Index' (duration: 54.361597ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:42.995694Z","caller":"traceutil/trace.go:171","msg":"trace[959286747] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"253.345236ms","start":"2026-05-30T09:43:42.742326Z","end":"2026-05-30T09:43:42.995671Z","steps":["trace[959286747] 'process raft request' (duration: 252.932618ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:42.99572Z","caller":"traceutil/trace.go:171","msg":"trace[1713305467] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"253.44785ms","start":"2026-05-30T09:43:42.742242Z","end":"2026-05-30T09:43:42.99569Z","steps":["trace[1713305467] 'process raft request' (duration: 252.934428ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:42.995917Z","caller":"traceutil/trace.go:171","msg":"trace[1327407155] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"253.209651ms","start":"2026-05-30T09:43:42.74269Z","end":"2026-05-30T09:43:42.995899Z","steps":["trace[1327407155] 'process raft request' (duration: 252.597514ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:42.996215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.790776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:42.996386Z","caller":"traceutil/trace.go:171","msg":"trace[621348899] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:8; }","duration":"250.082218ms","start":"2026-05-30T09:43:42.746253Z","end":"2026-05-30T09:43:42.996335Z","steps":["trace[621348899] 'agreement among raft nodes before linearized reading' (duration: 249.628489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:42.996447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.121281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:42.998038Z","caller":"traceutil/trace.go:171","msg":"trace[1708834980] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:8; }","duration":"250.57697ms","start":"2026-05-30T09:43:42.745931Z","end":"2026-05-30T09:43:42.996508Z","steps":["trace[1708834980] 'agreement among raft nodes before linearized reading' (duration: 250.10582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:42.998121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.096261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:42.998262Z","caller":"traceutil/trace.go:171","msg":"trace[2057711668] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:0; response_revision:8; }","duration":"258.226619ms","start":"2026-05-30T09:43:42.739975Z","end":"2026-05-30T09:43:42.998202Z","steps":["trace[2057711668] 'agreement among raft nodes before linearized reading' (duration: 256.08106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:42.998625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.36712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:42.99869Z","caller":"traceutil/trace.go:171","msg":"trace[1713659833] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:8; }","duration":"315.916867ms","start":"2026-05-30T09:43:42.682754Z","end":"2026-05-30T09:43:42.998671Z","steps":["trace[1713659833] 'agreement among raft nodes before linearized reading' (duration: 313.321858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:42.998752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:42.682747Z","time spent":"315.988261ms","remote":"127.0.0.1:58282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-30T09:43:42.996379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.722453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:42.999604Z","caller":"traceutil/trace.go:171","msg":"trace[2099024129] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:8; }","duration":"320.962669ms","start":"2026-05-30T09:43:42.678613Z","end":"2026-05-30T09:43:42.999575Z","steps":["trace[2099024129] 'agreement among raft nodes before linearized reading' (duration: 317.604068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:42.999665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:42.678607Z","time spent":"321.036291ms","remote":"127.0.0.1:42958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-05-30T09:43:42.996231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.744515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:42.999942Z","caller":"traceutil/trace.go:171","msg":"trace[1411416223] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:8; }","duration":"264.564475ms","start":"2026-05-30T09:43:42.735352Z","end":"2026-05-30T09:43:42.999917Z","steps":["trace[1411416223] 'agreement among raft nodes before linearized reading' (duration: 260.586248ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:43.044393Z","caller":"traceutil/trace.go:171","msg":"trace[43560279] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"281.743207ms","start":"2026-05-30T09:43:42.762611Z","end":"2026-05-30T09:43:43.044354Z","steps":["trace[43560279] 'process raft request' (duration: 281.410153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:43.045216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.776121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:43.04535Z","caller":"traceutil/trace.go:171","msg":"trace[1885543035] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"247.849365ms","start":"2026-05-30T09:43:42.797466Z","end":"2026-05-30T09:43:43.045315Z","steps":["trace[1885543035] 'agreement among raft nodes before linearized reading' (duration: 246.928187ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:43.04541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.712675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:43.045468Z","caller":"traceutil/trace.go:171","msg":"trace[48751745] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:9; }","duration":"234.823769ms","start":"2026-05-30T09:43:42.81063Z","end":"2026-05-30T09:43:43.045454Z","steps":["trace[48751745] 'agreement among raft nodes before linearized reading' (duration: 233.695512ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:44.875849Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.615505885s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-30T09:43:45.004994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999922493s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-30T09:43:45.005225Z","caller":"traceutil/trace.go:171","msg":"trace[1194934015] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000219095s","start":"2026-05-30T09:43:43.004968Z","end":"2026-05-30T09:43:45.005187Z","steps":["trace[1194934015] 'agreement among raft nodes before linearized reading' (duration: 1.999955765s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:45.00541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.004948Z","time spent":"2.000439144s","remote":"127.0.0.1:42892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T09:43:45.798452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999817857s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-30T09:43:45.79862Z","caller":"traceutil/trace.go:171","msg":"trace[1304477679] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000090778s","start":"2026-05-30T09:43:43.798501Z","end":"2026-05-30T09:43:45.798592Z","steps":["trace[1304477679] 'agreement among raft nodes before linearized reading' (duration: 1.999864149s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:45.798772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.798474Z","time spent":"2.000281666s","remote":"127.0.0.1:42890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/30 09:43:45 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-30T09:43:46.733324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.472241323s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-30T09:43:46.733621Z","caller":"traceutil/trace.go:171","msg":"trace[250049998] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"3.731113978s","start":"2026-05-30T09:43:43.002459Z","end":"2026-05-30T09:43:46.733573Z","steps":["trace[250049998] 'process raft request' (duration: 3.730981383s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.733803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.00245Z","time spent":"3.731255474s","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:46.733765Z","caller":"traceutil/trace.go:171","msg":"trace[518766239] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"3.730370217s","start":"2026-05-30T09:43:43.003327Z","end":"2026-05-30T09:43:46.733697Z","steps":["trace[518766239] 'process raft request' (duration: 3.730210911s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:46.733848Z","caller":"traceutil/trace.go:171","msg":"trace[2064734349] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"3.728906306s","start":"2026-05-30T09:43:43.004862Z","end":"2026-05-30T09:43:46.733768Z","steps":["trace[2064734349] 'process raft request' (duration: 3.728726379s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:46.733819Z","caller":"traceutil/trace.go:171","msg":"trace[1664241030] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"3.731055586s","start":"2026-05-30T09:43:43.002728Z","end":"2026-05-30T09:43:46.733784Z","steps":["trace[1664241030] 'process raft request' (duration: 3.730761324s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:46.733881Z","caller":"traceutil/trace.go:171","msg":"trace[1964031389] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"3.730133317s","start":"2026-05-30T09:43:43.003732Z","end":"2026-05-30T09:43:46.733865Z","steps":["trace[1964031389] 'process raft request' (duration: 3.729833115s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:46.733627Z","caller":"traceutil/trace.go:171","msg":"trace[617468950] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"3.732093289s","start":"2026-05-30T09:43:43.001506Z","end":"2026-05-30T09:43:46.733599Z","steps":["trace[617468950] 'process raft request' (duration: 258.813784ms)","trace[617468950] 'compare' (duration: 3.471835806s)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:46.733972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.003275Z","time spent":"3.730597066s","remote":"127.0.0.1:58344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:46.73401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.00372Z","time spent":"3.730230691s","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:46.734015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.004829Z","time spent":"3.729105184s","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:46.73407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.001485Z","time spent":"3.732526686s","remote":"127.0.0.1:42958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T09:43:46.734057Z","caller":"traceutil/trace.go:171","msg":"trace[1124764991] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"3.730994412s","start":"2026-05-30T09:43:43.00305Z","end":"2026-05-30T09:43:46.734045Z","steps":["trace[1124764991] 'process raft request' (duration: 3.730462881s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.73401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.00272Z","time spent":"3.731195721s","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:46.734187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.003042Z","time spent":"3.731076886s","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:46.734404Z","caller":"traceutil/trace.go:171","msg":"trace[1179924293] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"3.729473818s","start":"2026-05-30T09:43:43.004918Z","end":"2026-05-30T09:43:46.734392Z","steps":["trace[1179924293] 'process raft request' (duration: 3.728694717s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:46.734422Z","caller":"traceutil/trace.go:171","msg":"trace[1866945341] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"3.729332452s","start":"2026-05-30T09:43:43.005068Z","end":"2026-05-30T09:43:46.7344Z","steps":["trace[1866945341] 'process raft request' (duration: 3.728642795s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.734471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.004894Z","time spent":"3.729550081s","remote":"127.0.0.1:43006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:46.734487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.005048Z","time spent":"3.729401855s","remote":"127.0.0.1:43006","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:46.734525Z","caller":"traceutil/trace.go:171","msg":"trace[1051364162] linearizableReadLoop","detail":"{readStateIndex:21; appliedIndex:12; }","duration":"3.690251153s","start":"2026-05-30T09:43:43.04426Z","end":"2026-05-30T09:43:46.734511Z","steps":["trace[1051364162] 'read index received' (duration: 216.077773ms)","trace[1051364162] 'applied index is now lower than readState.Index' (duration: 3.47417033s)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:46.734749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.72952636s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-05-30T09:43:46.734825Z","caller":"traceutil/trace.go:171","msg":"trace[729720876] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:17; }","duration":"3.729594422s","start":"2026-05-30T09:43:43.005181Z","end":"2026-05-30T09:43:46.734775Z","steps":["trace[729720876] 'agreement among raft nodes before linearized reading' (duration: 3.729438386s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.734872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.00517Z","time spent":"3.729693117s","remote":"127.0.0.1:43074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-30T09:43:46.735322Z","caller":"traceutil/trace.go:171","msg":"trace[173745780] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"3.679008816s","start":"2026-05-30T09:43:43.0563Z","end":"2026-05-30T09:43:46.735309Z","steps":["trace[173745780] 'process raft request' (duration: 3.678144402s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:46.735377Z","caller":"traceutil/trace.go:171","msg":"trace[1374031721] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"1.82023854s","start":"2026-05-30T09:43:44.915126Z","end":"2026-05-30T09:43:46.735364Z","steps":["trace[1374031721] 'process raft request' (duration: 1.819898155s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.73546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.056255Z","time spent":"3.679130581s","remote":"127.0.0.1:43074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:43:46.735816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.634477651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:46.735887Z","caller":"traceutil/trace.go:171","msg":"trace[691042412] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:19; }","duration":"3.634560435s","start":"2026-05-30T09:43:43.101288Z","end":"2026-05-30T09:43:46.735849Z","steps":["trace[691042412] 'agreement among raft nodes before linearized reading' (duration: 3.634461111s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.735937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.391962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-30T09:43:46.735931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.101264Z","time spent":"3.634657439s","remote":"127.0.0.1:43006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"info","ts":"2026-05-30T09:43:46.735984Z","caller":"traceutil/trace.go:171","msg":"trace[786508750] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"435.496396ms","start":"2026-05-30T09:43:46.300474Z","end":"2026-05-30T09:43:46.73597Z","steps":["trace[786508750] 'agreement among raft nodes before linearized reading' (duration: 435.436363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.736054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.300421Z","time spent":"435.621532ms","remote":"127.0.0.1:42890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T09:43:46.735874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.086610191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:46.736165Z","caller":"traceutil/trace.go:171","msg":"trace[888788824] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:19; }","duration":"3.086933884s","start":"2026-05-30T09:43:43.649219Z","end":"2026-05-30T09:43:46.736153Z","steps":["trace[888788824] 'agreement among raft nodes before linearized reading' (duration: 3.086604531s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.736218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.62703612s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-30T09:43:46.736229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.649206Z","time spent":"3.087009847s","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-05-30T09:43:46.736249Z","caller":"traceutil/trace.go:171","msg":"trace[924854717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"1.627117183s","start":"2026-05-30T09:43:45.109122Z","end":"2026-05-30T09:43:46.736239Z","steps":["trace[924854717] 'agreement among raft nodes before linearized reading' (duration: 1.627072422s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.73623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.631931045s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-05-30T09:43:46.736278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:45.109096Z","time spent":"1.627177536s","remote":"127.0.0.1:42890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-30T09:43:46.736317Z","caller":"traceutil/trace.go:171","msg":"trace[226105424] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"3.63205053s","start":"2026-05-30T09:43:43.104245Z","end":"2026-05-30T09:43:46.736296Z","steps":["trace[226105424] 'agreement among raft nodes before linearized reading' (duration: 3.631889943s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.736365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.104234Z","time spent":"3.632122323s","remote":"127.0.0.1:43006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-30T09:43:46.736545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:44.915074Z","time spent":"1.820333773s","remote":"127.0.0.1:58128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:46.737076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.095945026s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:46.737222Z","caller":"traceutil/trace.go:171","msg":"trace[1863449735] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:19; }","duration":"3.096091392s","start":"2026-05-30T09:43:43.641116Z","end":"2026-05-30T09:43:46.737207Z","steps":["trace[1863449735] 'agreement among raft nodes before linearized reading' (duration: 3.095923465s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.73709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.528515688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:46.737782Z","caller":"traceutil/trace.go:171","msg":"trace[894615294] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:19; }","duration":"3.528904504s","start":"2026-05-30T09:43:43.208525Z","end":"2026-05-30T09:43:46.73743Z","steps":["trace[894615294] 'agreement among raft nodes before linearized reading' (duration: 3.528523988s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.738134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.208504Z","time spent":"3.529610172s","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-05-30T09:43:46.739178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.879892751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-30T09:43:46.739243Z","caller":"traceutil/trace.go:171","msg":"trace[172517784] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"2.880007266s","start":"2026-05-30T09:43:43.859221Z","end":"2026-05-30T09:43:46.739229Z","steps":["trace[172517784] 'agreement among raft nodes before linearized reading' (duration: 2.877162342s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:46.739283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.859194Z","time spent":"2.880080969s","remote":"127.0.0.1:43006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-30T09:43:46.739688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:43.641035Z","time spent":"3.096218677s","remote":"127.0.0.1:58250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-05-30T09:43:47.056546Z","caller":"traceutil/trace.go:171","msg":"trace[324486327] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:23; }","duration":"317.007563ms","start":"2026-05-30T09:43:46.739507Z","end":"2026-05-30T09:43:47.056514Z","steps":["trace[324486327] 'read index received' (duration: 304.419085ms)","trace[324486327] 'applied index is now lower than readState.Index' (duration: 12.586948ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:47.056875Z","caller":"traceutil/trace.go:171","msg":"trace[1197142716] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"317.976251ms","start":"2026-05-30T09:43:46.738877Z","end":"2026-05-30T09:43:47.056853Z","steps":["trace[1197142716] 'process raft request' (duration: 304.909704ms)","trace[1197142716] 'compare' (duration: 11.971274ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:47.057096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.738854Z","time spent":"318.064045ms","remote":"127.0.0.1:58344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:47.057157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.624977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-30T09:43:47.057245Z","caller":"traceutil/trace.go:171","msg":"trace[819531593] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"317.784294ms","start":"2026-05-30T09:43:46.739442Z","end":"2026-05-30T09:43:47.057226Z","steps":["trace[819531593] 'agreement among raft nodes before linearized reading' (duration: 317.549945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.057295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.739413Z","time spent":"317.873527ms","remote":"127.0.0.1:43006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-30T09:43:47.05894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.394118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-30T09:43:47.059182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.662583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:47.059239Z","caller":"traceutil/trace.go:171","msg":"trace[1696608281] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:29; }","duration":"264.778119ms","start":"2026-05-30T09:43:46.794445Z","end":"2026-05-30T09:43:47.059223Z","steps":["trace[1696608281] 'agreement among raft nodes before linearized reading' (duration: 264.688605ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:47.059211Z","caller":"traceutil/trace.go:171","msg":"trace[458542091] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"314.184649ms","start":"2026-05-30T09:43:46.744969Z","end":"2026-05-30T09:43:47.059153Z","steps":["trace[458542091] 'process raft request' (duration: 313.675199ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:47.05927Z","caller":"traceutil/trace.go:171","msg":"trace[784646213] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"314.21469ms","start":"2026-05-30T09:43:46.745025Z","end":"2026-05-30T09:43:47.05924Z","steps":["trace[784646213] 'process raft request' (duration: 313.726711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.059325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.915148ms","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-30T09:43:47.059392Z","caller":"traceutil/trace.go:171","msg":"trace[269707640] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:29; }","duration":"312.999191ms","start":"2026-05-30T09:43:46.746364Z","end":"2026-05-30T09:43:47.059363Z","steps":["trace[269707640] 'agreement among raft nodes before linearized reading' (duration: 312.900237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.059414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.744917Z","time spent":"314.383437ms","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:47.059432Z","caller":"traceutil/trace.go:171","msg":"trace[1302887242] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"314.584785ms","start":"2026-05-30T09:43:46.744794Z","end":"2026-05-30T09:43:47.059378Z","steps":["trace[1302887242] 'process raft request' (duration: 313.756062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.059552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.645937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:47.059536Z","caller":"traceutil/trace.go:171","msg":"trace[26097643] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"314.547874ms","start":"2026-05-30T09:43:46.744978Z","end":"2026-05-30T09:43:47.059526Z","steps":["trace[26097643] 'process raft request' (duration: 313.70551ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:47.059649Z","caller":"traceutil/trace.go:171","msg":"trace[1212088353] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:29; }","duration":"314.707069ms","start":"2026-05-30T09:43:46.744882Z","end":"2026-05-30T09:43:47.059589Z","steps":["trace[1212088353] 'agreement among raft nodes before linearized reading' (duration: 314.634186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.059702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.744874Z","time spent":"314.815664ms","remote":"127.0.0.1:58244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-05-30T09:43:47.059687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.744776Z","time spent":"314.812604ms","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:47.059457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.746355Z","time spent":"313.089805ms","remote":"127.0.0.1:43004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-05-30T09:43:47.059801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.083324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T09:43:47.059741Z","caller":"traceutil/trace.go:171","msg":"trace[1357184] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"314.831025ms","start":"2026-05-30T09:43:46.744901Z","end":"2026-05-30T09:43:47.059732Z","steps":["trace[1357184] 'process raft request' (duration: 313.717991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.059708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.744971Z","time spent":"314.7111ms","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:47.059942Z","caller":"traceutil/trace.go:171","msg":"trace[488180464] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:29; }","duration":"315.265112ms","start":"2026-05-30T09:43:46.744622Z","end":"2026-05-30T09:43:47.059887Z","steps":["trace[488180464] 'agreement among raft nodes before linearized reading' (duration: 314.949269ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:47.060075Z","caller":"traceutil/trace.go:171","msg":"trace[652869939] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"315.319253ms","start":"2026-05-30T09:43:46.744741Z","end":"2026-05-30T09:43:47.06006Z","steps":["trace[652869939] 'process raft request' (duration: 313.763702ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:47.059699Z","caller":"traceutil/trace.go:171","msg":"trace[725449031] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"314.822854ms","start":"2026-05-30T09:43:46.744863Z","end":"2026-05-30T09:43:47.059686Z","steps":["trace[725449031] 'process raft request' (duration: 313.72092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.059964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.744893Z","time spent":"315.011001ms","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:47.060089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.744604Z","time spent":"315.46665ms","remote":"127.0.0.1:43042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-05-30T09:43:47.059232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.112206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-np4h6\" ","response":"range_response_count:1 size:861"} {"level":"warn","ts":"2026-05-30T09:43:47.060257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.744854Z","time spent":"315.325674ms","remote":"127.0.0.1:58250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:47.06026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.744729Z","time spent":"315.389357ms","remote":"127.0.0.1:43004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:47.06032Z","caller":"traceutil/trace.go:171","msg":"trace[679071126] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-np4h6; range_end:; response_count:1; response_revision:29; }","duration":"315.232021ms","start":"2026-05-30T09:43:46.745072Z","end":"2026-05-30T09:43:47.060304Z","steps":["trace[679071126] 'agreement among raft nodes before linearized reading' (duration: 314.082685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.05949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.745018Z","time spent":"314.346545ms","remote":"127.0.0.1:58444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:47.060386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.745055Z","time spent":"315.307514ms","remote":"127.0.0.1:58128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-np4h6\" "} {"level":"info","ts":"2026-05-30T09:43:47.059753Z","caller":"traceutil/trace.go:171","msg":"trace[1665332656] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"315.070524ms","start":"2026-05-30T09:43:46.744671Z","end":"2026-05-30T09:43:47.059742Z","steps":["trace[1665332656] 'process raft request' (duration: 313.732171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.060471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.744646Z","time spent":"315.800284ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:47.059479Z","caller":"traceutil/trace.go:171","msg":"trace[1773491754] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"314.415438ms","start":"2026-05-30T09:43:46.74505Z","end":"2026-05-30T09:43:47.059466Z","steps":["trace[1773491754] 'process raft request' (duration: 313.739142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.060599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.745043Z","time spent":"315.526702ms","remote":"127.0.0.1:58282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:47.060104Z","caller":"traceutil/trace.go:171","msg":"trace[1089327331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29; }","duration":"319.531024ms","start":"2026-05-30T09:43:46.739489Z","end":"2026-05-30T09:43:47.05902Z","steps":["trace[1089327331] 'agreement among raft nodes before linearized reading' (duration: 319.353727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.061037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:46.739479Z","time spent":"321.526253ms","remote":"127.0.0.1:42892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-30T09:43:47.933531Z","caller":"traceutil/trace.go:171","msg":"trace[231346481] linearizableReadLoop","detail":"{readStateIndex:104; appliedIndex:103; }","duration":"109.447809ms","start":"2026-05-30T09:43:47.824051Z","end":"2026-05-30T09:43:47.933499Z","steps":["trace[231346481] 'read index received' (duration: 85.673997ms)","trace[231346481] 'applied index is now lower than readState.Index' (duration: 23.770092ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:47.933694Z","caller":"traceutil/trace.go:171","msg":"trace[1932650650] transaction","detail":"{read_only:false; response_revision:100; number_of_response:1; }","duration":"106.630047ms","start":"2026-05-30T09:43:47.82683Z","end":"2026-05-30T09:43:47.93346Z","steps":["trace[1932650650] 'process raft request' (duration: 106.561895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.933797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.988001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-30T09:43:47.93381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.263762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b44ea3ecb6c4c2\" ","response":"range_response_count:1 size:654"} {"level":"warn","ts":"2026-05-30T09:43:47.933809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.889156ms","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-30T09:43:47.933867Z","caller":"traceutil/trace.go:171","msg":"trace[382215799] range","detail":"{range_begin:/registry/clusterroles/system:node; range_end:; response_count:0; response_revision:100; }","duration":"108.107515ms","start":"2026-05-30T09:43:47.825738Z","end":"2026-05-30T09:43:47.933846Z","steps":["trace[382215799] 'agreement among raft nodes before linearized reading' (duration: 107.97799ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:47.933875Z","caller":"traceutil/trace.go:171","msg":"trace[1938679877] range","detail":"{range_begin:/registry/events/default/instance.18b44ea3ecb6c4c2; range_end:; response_count:1; response_revision:100; }","duration":"109.332285ms","start":"2026-05-30T09:43:47.824523Z","end":"2026-05-30T09:43:47.933855Z","steps":["trace[1938679877] 'agreement among raft nodes before linearized reading' (duration: 109.190989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:47.933819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.708319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2917"} {"level":"info","ts":"2026-05-30T09:43:47.933961Z","caller":"traceutil/trace.go:171","msg":"trace[769777325] transaction","detail":"{read_only:false; response_revision:99; number_of_response:1; }","duration":"109.903657ms","start":"2026-05-30T09:43:47.823713Z","end":"2026-05-30T09:43:47.933616Z","steps":["trace[769777325] 'process raft request' (duration: 86.076293ms)","trace[769777325] 'compare' (duration: 23.391237ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:47.933989Z","caller":"traceutil/trace.go:171","msg":"trace[2054736683] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:100; }","duration":"111.898866ms","start":"2026-05-30T09:43:47.822065Z","end":"2026-05-30T09:43:47.933964Z","steps":["trace[2054736683] 'agreement among raft nodes before linearized reading' (duration: 111.587364ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:47.933882Z","caller":"traceutil/trace.go:171","msg":"trace[1632485653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:100; }","duration":"111.969439ms","start":"2026-05-30T09:43:47.821895Z","end":"2026-05-30T09:43:47.933865Z","steps":["trace[1632485653] 'agreement among raft nodes before linearized reading' (duration: 111.794732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:48.3599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.422015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-30T09:43:48.360104Z","caller":"traceutil/trace.go:171","msg":"trace[1290017685] linearizableReadLoop","detail":"{readStateIndex:108; appliedIndex:105; }","duration":"420.30247ms","start":"2026-05-30T09:43:47.93978Z","end":"2026-05-30T09:43:48.360083Z","steps":["trace[1290017685] 'read index received' (duration: 7.55496ms)","trace[1290017685] 'applied index is now lower than readState.Index' (duration: 412.7463ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:48.360182Z","caller":"traceutil/trace.go:171","msg":"trace[1865866269] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"420.55653ms","start":"2026-05-30T09:43:47.939616Z","end":"2026-05-30T09:43:48.360172Z","steps":["trace[1865866269] 'process raft request' (duration: 420.409834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:48.360244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:47.939532Z","time spent":"420.684005ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1473,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:48.360252Z","caller":"traceutil/trace.go:171","msg":"trace[2126360528] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"420.649634ms","start":"2026-05-30T09:43:47.939571Z","end":"2026-05-30T09:43:48.360221Z","steps":["trace[2126360528] 'process raft request' (duration: 317.796941ms)","trace[2126360528] 'compare' (duration: 102.227868ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:48.360345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:47.939535Z","time spent":"420.765738ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:48.360765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.975936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-05-30T09:43:48.3609Z","caller":"traceutil/trace.go:171","msg":"trace[1810408374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:103; }","duration":"421.160824ms","start":"2026-05-30T09:43:47.939717Z","end":"2026-05-30T09:43:48.360878Z","steps":["trace[1810408374] 'agreement among raft nodes before linearized reading' (duration: 420.647924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:48.361005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:47.939704Z","time spent":"421.285019ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-30T09:43:48.366638Z","caller":"traceutil/trace.go:171","msg":"trace[1910877005] transaction","detail":"{read_only:false; response_revision:104; number_of_response:1; }","duration":"413.709996ms","start":"2026-05-30T09:43:47.952907Z","end":"2026-05-30T09:43:48.366617Z","steps":["trace[1910877005] 'process raft request' (duration: 413.531309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:48.366659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.599701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18b44ea3ecb6e286\" ","response":"range_response_count:1 size:650"} {"level":"warn","ts":"2026-05-30T09:43:48.366715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:47.952899Z","time spent":"413.774838ms","remote":"127.0.0.1:43086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T09:43:48.366716Z","caller":"traceutil/trace.go:171","msg":"trace[727733365] range","detail":"{range_begin:/registry/events/default/instance.18b44ea3ecb6e286; range_end:; response_count:1; response_revision:104; }","duration":"416.680153ms","start":"2026-05-30T09:43:47.950019Z","end":"2026-05-30T09:43:48.366699Z","steps":["trace[727733365] 'agreement among raft nodes before linearized reading' (duration: 416.579749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:48.366759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:47.95001Z","time spent":"416.738236ms","remote":"127.0.0.1:42982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":673,"request content":"key:\"/registry/events/default/instance.18b44ea3ecb6e286\" "} {"level":"warn","ts":"2026-05-30T09:43:49.131989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.323057ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-30T09:43:49.13213Z","caller":"traceutil/trace.go:171","msg":"trace[1566215638] linearizableReadLoop","detail":"{readStateIndex:132; appliedIndex:131; }","duration":"460.676858ms","start":"2026-05-30T09:43:48.671432Z","end":"2026-05-30T09:43:49.132109Z","steps":["trace[1566215638] 'read index received' (duration: 306.215507ms)","trace[1566215638] 'applied index is now lower than readState.Index' (duration: 154.459821ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:49.132208Z","caller":"traceutil/trace.go:171","msg":"trace[785705405] transaction","detail":"{read_only:false; response_revision:127; number_of_response:1; }","duration":"465.085081ms","start":"2026-05-30T09:43:48.667067Z","end":"2026-05-30T09:43:49.132152Z","steps":["trace[785705405] 'process raft request' (duration: 310.509465ms)","trace[785705405] 'compare' (duration: 154.1489ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:49.132517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:48.667055Z","time spent":"465.343091ms","remote":"127.0.0.1:42982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":799,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:49.132503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.020641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-30T09:43:49.132621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.091348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3465"} {"level":"info","ts":"2026-05-30T09:43:49.132657Z","caller":"traceutil/trace.go:171","msg":"trace[666963989] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient; range_end:; response_count:0; response_revision:127; }","duration":"461.25095ms","start":"2026-05-30T09:43:48.671359Z","end":"2026-05-30T09:43:49.13261Z","steps":["trace[666963989] 'agreement among raft nodes before linearized reading' (duration: 460.922168ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:49.13271Z","caller":"traceutil/trace.go:171","msg":"trace[817828592] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:127; }","duration":"369.249834ms","start":"2026-05-30T09:43:48.763415Z","end":"2026-05-30T09:43:49.132665Z","steps":["trace[817828592] 'agreement among raft nodes before linearized reading' (duration: 368.88914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:49.132725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:48.671332Z","time spent":"461.382315ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:selfnodeclient\" "} {"level":"warn","ts":"2026-05-30T09:43:49.132523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.53306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-30T09:43:49.132798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:48.76338Z","time spent":"369.378289ms","remote":"127.0.0.1:43086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3488,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"info","ts":"2026-05-30T09:43:49.132872Z","caller":"traceutil/trace.go:171","msg":"trace[166054012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:127; }","duration":"323.911815ms","start":"2026-05-30T09:43:48.808887Z","end":"2026-05-30T09:43:49.132799Z","steps":["trace[166054012] 'agreement among raft nodes before linearized reading' (duration: 323.499539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:49.133691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:48.808861Z","time spent":"324.8022ms","remote":"127.0.0.1:42892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T09:43:49.787151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.188863ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:43:49.78736Z","caller":"traceutil/trace.go:171","msg":"trace[12620419] linearizableReadLoop","detail":"{readStateIndex:142; appliedIndex:140; }","duration":"379.085505ms","start":"2026-05-30T09:43:49.408255Z","end":"2026-05-30T09:43:49.78734Z","steps":["trace[12620419] 'read index received' (duration: 86.638631ms)","trace[12620419] 'applied index is now lower than readState.Index' (duration: 292.445214ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:49.787504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.250781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:49.787533Z","caller":"traceutil/trace.go:171","msg":"trace[165972231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:137; }","duration":"379.337024ms","start":"2026-05-30T09:43:49.408187Z","end":"2026-05-30T09:43:49.787524Z","steps":["trace[165972231] 'agreement among raft nodes before linearized reading' (duration: 379.214599ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:49.787618Z","caller":"traceutil/trace.go:171","msg":"trace[1017766364] transaction","detail":"{read_only:false; response_revision:136; number_of_response:1; }","duration":"503.674168ms","start":"2026-05-30T09:43:49.283897Z","end":"2026-05-30T09:43:49.787571Z","steps":["trace[1017766364] 'process raft request' (duration: 210.988655ms)","trace[1017766364] 'compare' (duration: 291.973685ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:49.787668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:49.408157Z","time spent":"379.502451ms","remote":"127.0.0.1:42890","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-30T09:43:49.78752Z","caller":"traceutil/trace.go:171","msg":"trace[1401491622] transaction","detail":"{read_only:false; response_revision:137; number_of_response:1; }","duration":"503.074454ms","start":"2026-05-30T09:43:49.284383Z","end":"2026-05-30T09:43:49.787457Z","steps":["trace[1401491622] 'process raft request' (duration: 502.897997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:49.78776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:49.284357Z","time spent":"503.360455ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":669,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:49.787785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:49.283881Z","time spent":"503.825553ms","remote":"127.0.0.1:42982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":676,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:50.216644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.439015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:43:50.216858Z","caller":"traceutil/trace.go:171","msg":"trace[237991967] linearizableReadLoop","detail":"{readStateIndex:144; appliedIndex:142; }","duration":"308.014379ms","start":"2026-05-30T09:43:49.908825Z","end":"2026-05-30T09:43:50.21684Z","steps":["trace[237991967] 'read index received' (duration: 73.354476ms)","trace[237991967] 'applied index is now lower than readState.Index' (duration: 234.658483ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:50.216888Z","caller":"traceutil/trace.go:171","msg":"trace[1269589171] transaction","detail":"{read_only:false; response_revision:138; number_of_response:1; }","duration":"423.418656ms","start":"2026-05-30T09:43:49.793408Z","end":"2026-05-30T09:43:50.216827Z","steps":["trace[1269589171] 'process raft request' (duration: 188.725811ms)","trace[1269589171] 'compare' (duration: 234.27996ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:50.217006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.189495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:50.216991Z","caller":"traceutil/trace.go:171","msg":"trace[618179217] transaction","detail":"{read_only:false; response_revision:139; number_of_response:1; }","duration":"423.025651ms","start":"2026-05-30T09:43:49.793915Z","end":"2026-05-30T09:43:50.216941Z","steps":["trace[618179217] 'process raft request' (duration: 422.862494ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:50.217044Z","caller":"traceutil/trace.go:171","msg":"trace[718751110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:139; }","duration":"308.271879ms","start":"2026-05-30T09:43:49.908764Z","end":"2026-05-30T09:43:50.217036Z","steps":["trace[718751110] 'agreement among raft nodes before linearized reading' (duration: 308.133794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:50.217083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:49.908739Z","time spent":"308.336872ms","remote":"127.0.0.1:42892","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-30T09:43:50.217097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:49.793392Z","time spent":"423.597102ms","remote":"127.0.0.1:42982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:50.217158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:49.793888Z","time spent":"423.189997ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:50.487598Z","caller":"traceutil/trace.go:171","msg":"trace[1116798555] linearizableReadLoop","detail":"{readStateIndex:145; appliedIndex:144; }","duration":"266.777075ms","start":"2026-05-30T09:43:50.220761Z","end":"2026-05-30T09:43:50.487538Z","steps":["trace[1116798555] 'read index received' (duration: 251.140455ms)","trace[1116798555] 'applied index is now lower than readState.Index' (duration: 15.63502ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:50.487642Z","caller":"traceutil/trace.go:171","msg":"trace[1448388824] transaction","detail":"{read_only:false; response_revision:140; number_of_response:1; }","duration":"294.286681ms","start":"2026-05-30T09:43:50.193306Z","end":"2026-05-30T09:43:50.487593Z","steps":["trace[1448388824] 'process raft request' (duration: 278.468614ms)","trace[1448388824] 'compare' (duration: 15.589688ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:50.48785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.052395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:50.487905Z","caller":"traceutil/trace.go:171","msg":"trace[1851098349] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:kube-apiserver-client-kubelet-approver; range_end:; response_count:0; response_revision:140; }","duration":"267.16669ms","start":"2026-05-30T09:43:50.220722Z","end":"2026-05-30T09:43:50.487888Z","steps":["trace[1851098349] 'agreement among raft nodes before linearized reading' (duration: 267.011274ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:50.582992Z","caller":"traceutil/trace.go:171","msg":"trace[1090025685] transaction","detail":"{read_only:false; response_revision:141; number_of_response:1; }","duration":"361.024981ms","start":"2026-05-30T09:43:50.221912Z","end":"2026-05-30T09:43:50.582937Z","steps":["trace[1090025685] 'process raft request' (duration: 360.775691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:50.583061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.953475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-30T09:43:50.583147Z","caller":"traceutil/trace.go:171","msg":"trace[829150252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:141; }","duration":"167.103201ms","start":"2026-05-30T09:43:50.416023Z","end":"2026-05-30T09:43:50.583126Z","steps":["trace[829150252] 'agreement among raft nodes before linearized reading' (duration: 166.895763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:50.583157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.399763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-30T09:43:50.583202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:50.221894Z","time spent":"361.208608ms","remote":"127.0.0.1:42982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":726,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:43:50.583245Z","caller":"traceutil/trace.go:171","msg":"trace[1629406678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:141; }","duration":"203.54419ms","start":"2026-05-30T09:43:50.37968Z","end":"2026-05-30T09:43:50.583224Z","steps":["trace[1629406678] 'agreement among raft nodes before linearized reading' (duration: 203.256939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:51.118236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.848409ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:43:51.118399Z","caller":"traceutil/trace.go:171","msg":"trace[1083834305] linearizableReadLoop","detail":"{readStateIndex:147; appliedIndex:146; }","duration":"535.490721ms","start":"2026-05-30T09:43:50.582881Z","end":"2026-05-30T09:43:51.118372Z","steps":["trace[1083834305] 'read index received' (duration: 63.423464ms)","trace[1083834305] 'applied index is now lower than readState.Index' (duration: 472.065606ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:51.118462Z","caller":"traceutil/trace.go:171","msg":"trace[25110805] transaction","detail":"{read_only:false; response_revision:142; number_of_response:1; }","duration":"625.984512ms","start":"2026-05-30T09:43:50.492397Z","end":"2026-05-30T09:43:51.118382Z","steps":["trace[25110805] 'process raft request' (duration: 153.893814ms)","trace[25110805] 'compare' (duration: 471.655312ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:51.118706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:50.492378Z","time spent":"626.20393ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:51.118733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.160105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:51.118793Z","caller":"traceutil/trace.go:171","msg":"trace[618559145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:142; }","duration":"610.26519ms","start":"2026-05-30T09:43:50.508508Z","end":"2026-05-30T09:43:51.118773Z","steps":["trace[618559145] 'agreement among raft nodes before linearized reading' (duration: 609.964988ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:51.118846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:50.508495Z","time spent":"610.337182ms","remote":"127.0.0.1:42890","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-30T09:43:51.204544Z","caller":"traceutil/trace.go:171","msg":"trace[362692489] transaction","detail":"{read_only:false; response_revision:145; number_of_response:1; }","duration":"615.341349ms","start":"2026-05-30T09:43:50.589169Z","end":"2026-05-30T09:43:51.204511Z","steps":["trace[362692489] 'process raft request' (duration: 615.279137ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:51.204728Z","caller":"traceutil/trace.go:171","msg":"trace[1514781994] transaction","detail":"{read_only:false; response_revision:144; number_of_response:1; }","duration":"615.758186ms","start":"2026-05-30T09:43:50.588952Z","end":"2026-05-30T09:43:51.20471Z","steps":["trace[1514781994] 'process raft request' (duration: 615.428824ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:51.204598Z","caller":"traceutil/trace.go:171","msg":"trace[749528967] transaction","detail":"{read_only:false; response_revision:143; number_of_response:1; }","duration":"616.974652ms","start":"2026-05-30T09:43:50.5876Z","end":"2026-05-30T09:43:51.204575Z","steps":["trace[749528967] 'process raft request' (duration: 616.586847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:51.204939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:50.588941Z","time spent":"615.909741ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:43:51.205002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:50.587534Z","time spent":"617.433189ms","remote":"127.0.0.1:42982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":676,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:51.204766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:50.589136Z","time spent":"615.505356ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:43:51.404958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.151815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:43:51.405193Z","caller":"traceutil/trace.go:171","msg":"trace[1203721628] transaction","detail":"{read_only:false; response_revision:147; number_of_response:1; }","duration":"195.969949ms","start":"2026-05-30T09:43:51.209203Z","end":"2026-05-30T09:43:51.405173Z","steps":["trace[1203721628] 'process raft request' (duration: 195.900707ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:51.40532Z","caller":"traceutil/trace.go:171","msg":"trace[1750835455] linearizableReadLoop","detail":"{readStateIndex:151; appliedIndex:147; }","duration":"286.833889ms","start":"2026-05-30T09:43:51.11844Z","end":"2026-05-30T09:43:51.405274Z","steps":["trace[1750835455] 'read index received' (duration: 85.719604ms)","trace[1750835455] 'applied index is now lower than readState.Index' (duration: 201.109045ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:51.405299Z","caller":"traceutil/trace.go:171","msg":"trace[440499643] transaction","detail":"{read_only:false; response_revision:146; number_of_response:1; }","duration":"362.584774ms","start":"2026-05-30T09:43:51.042633Z","end":"2026-05-30T09:43:51.405218Z","steps":["trace[440499643] 'process raft request' (duration: 219.062625ms)","trace[440499643] 'compare' (duration: 142.949028ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:51.40561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.975269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-05-30T09:43:51.40567Z","caller":"traceutil/trace.go:171","msg":"trace[370039700] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:147; }","duration":"576.093304ms","start":"2026-05-30T09:43:50.829561Z","end":"2026-05-30T09:43:51.405654Z","steps":["trace[370039700] 'agreement among raft nodes before linearized reading' (duration: 575.949358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:51.405713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:51.042596Z","time spent":"362.923389ms","remote":"127.0.0.1:43086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:51.405776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.65438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:service-account-issuer-discovery\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:51.405827Z","caller":"traceutil/trace.go:171","msg":"trace[897179581] range","detail":"{range_begin:/registry/clusterroles/system:service-account-issuer-discovery; range_end:; response_count:0; response_revision:147; }","duration":"283.716802ms","start":"2026-05-30T09:43:51.122091Z","end":"2026-05-30T09:43:51.405808Z","steps":["trace[897179581] 'agreement among raft nodes before linearized reading' (duration: 283.66366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:51.405589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.670681ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:51.405959Z","caller":"traceutil/trace.go:171","msg":"trace[226167419] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:147; }","duration":"367.065555ms","start":"2026-05-30T09:43:51.038875Z","end":"2026-05-30T09:43:51.40594Z","steps":["trace[226167419] 'agreement among raft nodes before linearized reading' (duration: 366.496114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:51.405725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:50.829533Z","time spent":"576.178437ms","remote":"127.0.0.1:43086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5536,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-05-30T09:43:51.405728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.721107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:51.406916Z","caller":"traceutil/trace.go:171","msg":"trace[833290014] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:147; }","duration":"286.935903ms","start":"2026-05-30T09:43:51.119935Z","end":"2026-05-30T09:43:51.406871Z","steps":["trace[833290014] 'agreement among raft nodes before linearized reading' (duration: 285.740898ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:51.651001Z","caller":"traceutil/trace.go:171","msg":"trace[2002720799] linearizableReadLoop","detail":"{readStateIndex:157; appliedIndex:156; }","duration":"177.59724ms","start":"2026-05-30T09:43:51.473374Z","end":"2026-05-30T09:43:51.650972Z","steps":["trace[2002720799] 'read index received' (duration: 86.089298ms)","trace[2002720799] 'applied index is now lower than readState.Index' (duration: 91.506272ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:51.65104Z","caller":"traceutil/trace.go:171","msg":"trace[163615510] transaction","detail":"{read_only:false; response_revision:152; number_of_response:1; }","duration":"198.888539ms","start":"2026-05-30T09:43:51.45212Z","end":"2026-05-30T09:43:51.651009Z","steps":["trace[163615510] 'process raft request' (duration: 107.182878ms)","trace[163615510] 'compare' (duration: 91.509503ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:51.651209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.812008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:51.651258Z","caller":"traceutil/trace.go:171","msg":"trace[1295691685] range","detail":"{range_begin:/registry/clusterroles/system:kube-scheduler; range_end:; response_count:0; response_revision:152; }","duration":"177.909292ms","start":"2026-05-30T09:43:51.473337Z","end":"2026-05-30T09:43:51.651246Z","steps":["trace[1295691685] 'agreement among raft nodes before linearized reading' (duration: 177.753866ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:51.671166Z","caller":"traceutil/trace.go:171","msg":"trace[944295850] transaction","detail":"{read_only:false; response_revision:153; number_of_response:1; }","duration":"192.831428ms","start":"2026-05-30T09:43:51.478307Z","end":"2026-05-30T09:43:51.671139Z","steps":["trace[944295850] 'process raft request' (duration: 192.488985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:52.161372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.543272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:43:52.161504Z","caller":"traceutil/trace.go:171","msg":"trace[310305026] linearizableReadLoop","detail":"{readStateIndex:161; appliedIndex:160; }","duration":"329.489615ms","start":"2026-05-30T09:43:51.831991Z","end":"2026-05-30T09:43:52.161481Z","steps":["trace[310305026] 'read index received' (duration: 104.650712ms)","trace[310305026] 'applied index is now lower than readState.Index' (duration: 224.837093ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:52.161619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.627821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-05-30T09:43:52.161643Z","caller":"traceutil/trace.go:171","msg":"trace[1771871236] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:156; }","duration":"329.710444ms","start":"2026-05-30T09:43:51.831924Z","end":"2026-05-30T09:43:52.161634Z","steps":["trace[1771871236] 'agreement among raft nodes before linearized reading' (duration: 329.61017ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:52.161693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:51.831897Z","time spent":"329.787858ms","remote":"127.0.0.1:43086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5349,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"info","ts":"2026-05-30T09:43:52.161878Z","caller":"traceutil/trace.go:171","msg":"trace[415432994] transaction","detail":"{read_only:false; response_revision:156; number_of_response:1; }","duration":"464.905277ms","start":"2026-05-30T09:43:51.696927Z","end":"2026-05-30T09:43:52.161833Z","steps":["trace[415432994] 'process raft request' (duration: 239.818813ms)","trace[415432994] 'compare' (duration: 224.344265ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:52.162156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:51.696912Z","time spent":"465.066122ms","remote":"127.0.0.1:58236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":937,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:43:52.41393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.571953ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:43:52.41423Z","caller":"traceutil/trace.go:171","msg":"trace[1768772583] linearizableReadLoop","detail":"{readStateIndex:163; appliedIndex:161; }","duration":"206.429774ms","start":"2026-05-30T09:43:52.207776Z","end":"2026-05-30T09:43:52.414205Z","steps":["trace[1768772583] 'read index received' (duration: 62.458046ms)","trace[1768772583] 'applied index is now lower than readState.Index' (duration: 143.970258ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:52.414345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.551448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:52.414378Z","caller":"traceutil/trace.go:171","msg":"trace[56421802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:158; }","duration":"206.616171ms","start":"2026-05-30T09:43:52.207751Z","end":"2026-05-30T09:43:52.414367Z","steps":["trace[56421802] 'agreement among raft nodes before linearized reading' (duration: 206.523797ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:52.414547Z","caller":"traceutil/trace.go:171","msg":"trace[2060318173] transaction","detail":"{read_only:false; response_revision:158; number_of_response:1; }","duration":"243.286537ms","start":"2026-05-30T09:43:52.171221Z","end":"2026-05-30T09:43:52.414508Z","steps":["trace[2060318173] 'process raft request' (duration: 242.857401ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:52.414564Z","caller":"traceutil/trace.go:171","msg":"trace[1913666163] transaction","detail":"{read_only:false; response_revision:157; number_of_response:1; }","duration":"245.507391ms","start":"2026-05-30T09:43:52.16902Z","end":"2026-05-30T09:43:52.414528Z","steps":["trace[1913666163] 'process raft request' (duration: 101.238022ms)","trace[1913666163] 'compare' (duration: 143.231139ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:52.638394Z","caller":"traceutil/trace.go:171","msg":"trace[184600820] transaction","detail":"{read_only:false; response_revision:159; number_of_response:1; }","duration":"217.446817ms","start":"2026-05-30T09:43:52.420897Z","end":"2026-05-30T09:43:52.638344Z","steps":["trace[184600820] 'process raft request' (duration: 131.913654ms)","trace[184600820] 'compare' (duration: 85.151248ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:53.016433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.639968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:43:53.016549Z","caller":"traceutil/trace.go:171","msg":"trace[1318086869] linearizableReadLoop","detail":"{readStateIndex:166; appliedIndex:165; }","duration":"137.466849ms","start":"2026-05-30T09:43:52.879063Z","end":"2026-05-30T09:43:53.01653Z","steps":["trace[1318086869] 'read index received' (duration: 39.952µs)","trace[1318086869] 'applied index is now lower than readState.Index' (duration: 137.425417ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:53.016679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.613404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:53.016679Z","caller":"traceutil/trace.go:171","msg":"trace[1634702060] transaction","detail":"{read_only:false; response_revision:161; number_of_response:1; }","duration":"296.874955ms","start":"2026-05-30T09:43:52.719674Z","end":"2026-05-30T09:43:53.016549Z","steps":["trace[1634702060] 'process raft request' (duration: 70.04247ms)","trace[1634702060] 'compare' (duration: 226.439381ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:53.016721Z","caller":"traceutil/trace.go:171","msg":"trace[1290539300] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:161; }","duration":"137.707457ms","start":"2026-05-30T09:43:52.879Z","end":"2026-05-30T09:43:53.016707Z","steps":["trace[1290539300] 'agreement among raft nodes before linearized reading' (duration: 137.584373ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:55.565368Z","caller":"traceutil/trace.go:171","msg":"trace[1509750124] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"104.134339ms","start":"2026-05-30T09:43:55.461195Z","end":"2026-05-30T09:43:55.565329Z","steps":["trace[1509750124] 'process raft request' (duration: 103.942472ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:55.893816Z","caller":"traceutil/trace.go:171","msg":"trace[1956293182] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"320.725318ms","start":"2026-05-30T09:43:55.573022Z","end":"2026-05-30T09:43:55.893748Z","steps":["trace[1956293182] 'process raft request' (duration: 297.671778ms)","trace[1956293182] 'compare' (duration: 22.51475ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:43:55.894564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:43:55.572994Z","time spent":"321.35316ms","remote":"127.0.0.1:43074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T09:43:55.899635Z","caller":"traceutil/trace.go:171","msg":"trace[811728495] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"287.973817ms","start":"2026-05-30T09:43:55.611629Z","end":"2026-05-30T09:43:55.899603Z","steps":["trace[811728495] 'process raft request' (duration: 287.097614ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:56.091616Z","caller":"traceutil/trace.go:171","msg":"trace[1697419459] linearizableReadLoop","detail":"{readStateIndex:290; appliedIndex:289; }","duration":"184.365693ms","start":"2026-05-30T09:43:55.90722Z","end":"2026-05-30T09:43:56.091586Z","steps":["trace[1697419459] 'read index received' (duration: 184.232249ms)","trace[1697419459] 'applied index is now lower than readState.Index' (duration: 131.964µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:56.091832Z","caller":"traceutil/trace.go:171","msg":"trace[1571613785] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"187.913543ms","start":"2026-05-30T09:43:55.903754Z","end":"2026-05-30T09:43:56.091668Z","steps":["trace[1571613785] 'process raft request' (duration: 187.642574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:56.092221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.603622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:43:56.092412Z","caller":"traceutil/trace.go:171","msg":"trace[677409509] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:0; response_revision:284; }","duration":"185.09246ms","start":"2026-05-30T09:43:55.907204Z","end":"2026-05-30T09:43:56.092296Z","steps":["trace[677409509] 'agreement among raft nodes before linearized reading' (duration: 184.503998ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:56.385675Z","caller":"traceutil/trace.go:171","msg":"trace[1320944288] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"134.948788ms","start":"2026-05-30T09:43:56.250646Z","end":"2026-05-30T09:43:56.385595Z","steps":["trace[1320944288] 'process raft request' (duration: 117.451898ms)","trace[1320944288] 'compare' (duration: 17.303463ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:58.773311Z","caller":"traceutil/trace.go:171","msg":"trace[894397973] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"141.929284ms","start":"2026-05-30T09:43:58.631357Z","end":"2026-05-30T09:43:58.773287Z","steps":["trace[894397973] 'process raft request' (duration: 141.754558ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:43:59.373091Z","caller":"traceutil/trace.go:171","msg":"trace[540520431] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:360; }","duration":"113.050586ms","start":"2026-05-30T09:43:59.260022Z","end":"2026-05-30T09:43:59.373072Z","steps":["trace[540520431] 'read index received' (duration: 112.903781ms)","trace[540520431] 'applied index is now lower than readState.Index' (duration: 146.095µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:43:59.373178Z","caller":"traceutil/trace.go:171","msg":"trace[47177901] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"154.857264ms","start":"2026-05-30T09:43:59.218314Z","end":"2026-05-30T09:43:59.373171Z","steps":["trace[47177901] 'process raft request' (duration: 154.653447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:43:59.373494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.46862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-30T09:43:59.373541Z","caller":"traceutil/trace.go:171","msg":"trace[1146943967] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:345; }","duration":"113.529792ms","start":"2026-05-30T09:43:59.260002Z","end":"2026-05-30T09:43:59.373532Z","steps":["trace[1146943967] 'agreement among raft nodes before linearized reading' (duration: 113.451319ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:00.243601Z","caller":"traceutil/trace.go:171","msg":"trace[1671713862] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"116.886307ms","start":"2026-05-30T09:44:00.126601Z","end":"2026-05-30T09:44:00.243487Z","steps":["trace[1671713862] 'process raft request' (duration: 55.296499ms)","trace[1671713862] 'compare' (duration: 61.257756ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:44:00.258598Z","caller":"traceutil/trace.go:171","msg":"trace[41956262] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"127.196804ms","start":"2026-05-30T09:44:00.131374Z","end":"2026-05-30T09:44:00.258571Z","steps":["trace[41956262] 'process raft request' (duration: 127.018728ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:01.114637Z","caller":"traceutil/trace.go:171","msg":"trace[736308574] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"112.731563ms","start":"2026-05-30T09:44:01.001878Z","end":"2026-05-30T09:44:01.11461Z","steps":["trace[736308574] 'process raft request' (duration: 112.534547ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:07.014165Z","caller":"traceutil/trace.go:171","msg":"trace[1180825777] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"179.226745ms","start":"2026-05-30T09:44:06.834908Z","end":"2026-05-30T09:44:07.014135Z","steps":["trace[1180825777] 'process raft request' (duration: 179.04059ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:07.128535Z","caller":"traceutil/trace.go:171","msg":"trace[1935033832] linearizableReadLoop","detail":"{readStateIndex:438; appliedIndex:437; }","duration":"110.354273ms","start":"2026-05-30T09:44:07.018154Z","end":"2026-05-30T09:44:07.128508Z","steps":["trace[1935033832] 'read index received' (duration: 46.334832ms)","trace[1935033832] 'applied index is now lower than readState.Index' (duration: 64.018271ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:44:07.128714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.530869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-05-30T09:44:07.128749Z","caller":"traceutil/trace.go:171","msg":"trace[909966466] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:420; }","duration":"110.59141ms","start":"2026-05-30T09:44:07.018146Z","end":"2026-05-30T09:44:07.128737Z","steps":["trace[909966466] 'agreement among raft nodes before linearized reading' (duration: 110.478217ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:07.128718Z","caller":"traceutil/trace.go:171","msg":"trace[7927846] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"150.044949ms","start":"2026-05-30T09:44:06.978645Z","end":"2026-05-30T09:44:07.12869Z","steps":["trace[7927846] 'process raft request' (duration: 85.875683ms)","trace[7927846] 'compare' (duration: 63.881667ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:44:17.75009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.070663ms","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-30T09:44:17.750173Z","caller":"traceutil/trace.go:171","msg":"trace[1824836387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:475; }","duration":"176.237198ms","start":"2026-05-30T09:44:17.573919Z","end":"2026-05-30T09:44:17.750156Z","steps":["trace[1824836387] 'range keys from in-memory index tree' (duration: 175.927279ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:24.057164Z","caller":"traceutil/trace.go:171","msg":"trace[823979651] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"176.063067ms","start":"2026-05-30T09:44:23.881061Z","end":"2026-05-30T09:44:24.057124Z","steps":["trace[823979651] 'process raft request' (duration: 149.087865ms)","trace[823979651] 'compare' (duration: 26.399576ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:44:24.587027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.196586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-30T09:44:24.587135Z","caller":"traceutil/trace.go:171","msg":"trace[804867509] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:491; }","duration":"277.320269ms","start":"2026-05-30T09:44:24.30979Z","end":"2026-05-30T09:44:24.58711Z","steps":["trace[804867509] 'range keys from in-memory index tree' (duration: 277.053572ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:29.411785Z","caller":"traceutil/trace.go:171","msg":"trace[613505258] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"110.145557ms","start":"2026-05-30T09:44:29.301613Z","end":"2026-05-30T09:44:29.411759Z","steps":["trace[613505258] 'process raft request' (duration: 109.955872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.116419Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.031335778s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T09:44:31.116824Z","caller":"traceutil/trace.go:171","msg":"trace[126078162] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.031850621s","start":"2026-05-30T09:44:30.084937Z","end":"2026-05-30T09:44:31.116787Z","steps":["trace[126078162] 'process raft request' (duration: 1.031681697s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.116994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.0849Z","time spent":"1.031984635s","remote":"127.0.0.1:58142","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-30T09:44:31.293536Z","caller":"traceutil/trace.go:171","msg":"trace[1529135755] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.087575606s","start":"2026-05-30T09:44:30.205916Z","end":"2026-05-30T09:44:31.293492Z","steps":["trace[1529135755] 'process raft request' (duration: 1.087277118s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.293656Z","caller":"traceutil/trace.go:171","msg":"trace[1601953066] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"1.082902244s","start":"2026-05-30T09:44:30.210709Z","end":"2026-05-30T09:44:31.293611Z","steps":["trace[1601953066] 'process raft request' (duration: 1.082713509s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.29379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.205892Z","time spent":"1.087778791s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:44:31.293832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.210683Z","time spent":"1.083059888s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:44:31.293997Z","caller":"traceutil/trace.go:171","msg":"trace[359673315] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.061920507s","start":"2026-05-30T09:44:30.232061Z","end":"2026-05-30T09:44:31.293981Z","steps":["trace[359673315] 'process raft request' (duration: 1.061509407s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.294039Z","caller":"traceutil/trace.go:171","msg":"trace[882317111] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"1.074087744s","start":"2026-05-30T09:44:30.219931Z","end":"2026-05-30T09:44:31.294019Z","steps":["trace[882317111] 'process raft request' (duration: 1.073572031s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.294053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.232036Z","time spent":"1.061991098s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:44:31.294126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.219908Z","time spent":"1.074173587s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:44:31.294162Z","caller":"traceutil/trace.go:171","msg":"trace[982912055] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.056195998s","start":"2026-05-30T09:44:30.237917Z","end":"2026-05-30T09:44:31.294113Z","steps":["trace[982912055] 'process raft request' (duration: 1.05590703s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.294384Z","caller":"traceutil/trace.go:171","msg":"trace[51472346] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.050998292s","start":"2026-05-30T09:44:30.243273Z","end":"2026-05-30T09:44:31.294271Z","steps":["trace[51472346] 'process raft request' (duration: 1.050702954s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.294407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.237888Z","time spent":"1.056388173s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:44:31.294447Z","caller":"traceutil/trace.go:171","msg":"trace[276107212] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"1.042346808s","start":"2026-05-30T09:44:30.252085Z","end":"2026-05-30T09:44:31.294432Z","steps":["trace[276107212] 'process raft request' (duration: 1.042047729s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.29455Z","caller":"traceutil/trace.go:171","msg":"trace[346844876] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.037761867s","start":"2026-05-30T09:44:30.256774Z","end":"2026-05-30T09:44:31.294536Z","steps":["trace[346844876] 'process raft request' (duration: 1.037557411s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.294557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.25206Z","time spent":"1.04245507s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:44:31.294617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.256767Z","time spent":"1.037819419s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:44:31.294735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.243248Z","time spent":"1.051205758s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:44:31.295452Z","caller":"traceutil/trace.go:171","msg":"trace[1228051073] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.032762757s","start":"2026-05-30T09:44:30.262661Z","end":"2026-05-30T09:44:31.295423Z","steps":["trace[1228051073] 'process raft request' (duration: 1.031753331s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.295565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.262646Z","time spent":"1.032856429s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:44:31.300099Z","caller":"traceutil/trace.go:171","msg":"trace[91161276] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:563; }","duration":"283.590856ms","start":"2026-05-30T09:44:31.016491Z","end":"2026-05-30T09:44:31.300082Z","steps":["trace[91161276] 'read index received' (duration: 100.702374ms)","trace[91161276] 'applied index is now lower than readState.Index' (duration: 182.887422ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:44:31.300332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.829523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:44:31.302507Z","caller":"traceutil/trace.go:171","msg":"trace[691638694] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"286.06089ms","start":"2026-05-30T09:44:31.016435Z","end":"2026-05-30T09:44:31.302496Z","steps":["trace[691638694] 'agreement among raft nodes before linearized reading' (duration: 283.749381ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.300639Z","caller":"traceutil/trace.go:171","msg":"trace[1854104071] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.030547988s","start":"2026-05-30T09:44:30.270074Z","end":"2026-05-30T09:44:31.300622Z","steps":["trace[1854104071] 'process raft request' (duration: 1.029806428s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.302694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.270056Z","time spent":"1.03259771s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:44:31.301434Z","caller":"traceutil/trace.go:171","msg":"trace[631987408] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"1.015069013s","start":"2026-05-30T09:44:30.286343Z","end":"2026-05-30T09:44:31.301412Z","steps":["trace[631987408] 'process raft request' (duration: 1.013623915s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.302798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.286329Z","time spent":"1.016450129s","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:44:31.301523Z","caller":"traceutil/trace.go:171","msg":"trace[1897091802] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"904.411607ms","start":"2026-05-30T09:44:30.39707Z","end":"2026-05-30T09:44:31.301481Z","steps":["trace[1897091802] 'process raft request' (duration: 902.95883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.302859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:30.39704Z","time spent":"905.808164ms","remote":"127.0.0.1:42942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:44:31.492598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.668721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:44:31.492993Z","caller":"traceutil/trace.go:171","msg":"trace[489693708] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"128.013121ms","start":"2026-05-30T09:44:31.364934Z","end":"2026-05-30T09:44:31.492947Z","steps":["trace[489693708] 'process raft request' (duration: 18.627232ms)","trace[489693708] 'compare' (duration: 108.432605ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:44:31.493111Z","caller":"traceutil/trace.go:171","msg":"trace[2091128831] transaction","detail":"{read_only:false; number_of_response:0; response_revision:563; }","duration":"125.198838ms","start":"2026-05-30T09:44:31.3679Z","end":"2026-05-30T09:44:31.493098Z","steps":["trace[2091128831] 'process raft request' (duration: 124.850369ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.493278Z","caller":"traceutil/trace.go:171","msg":"trace[587563103] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"124.943132ms","start":"2026-05-30T09:44:31.368272Z","end":"2026-05-30T09:44:31.493215Z","steps":["trace[587563103] 'process raft request' (duration: 124.635964ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.493357Z","caller":"traceutil/trace.go:171","msg":"trace[427215465] transaction","detail":"{read_only:false; number_of_response:0; response_revision:564; }","duration":"124.624844ms","start":"2026-05-30T09:44:31.368722Z","end":"2026-05-30T09:44:31.493347Z","steps":["trace[427215465] 'process raft request' (duration: 124.348606ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.493334Z","caller":"traceutil/trace.go:171","msg":"trace[2146214881] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"121.287988ms","start":"2026-05-30T09:44:31.372021Z","end":"2026-05-30T09:44:31.493309Z","steps":["trace[2146214881] 'process raft request' (duration: 121.197845ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.503608Z","caller":"traceutil/trace.go:171","msg":"trace[693795947] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"115.723223ms","start":"2026-05-30T09:44:31.387867Z","end":"2026-05-30T09:44:31.503591Z","steps":["trace[693795947] 'process raft request' (duration: 115.507188ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.503898Z","caller":"traceutil/trace.go:171","msg":"trace[1518882534] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"117.068459ms","start":"2026-05-30T09:44:31.386801Z","end":"2026-05-30T09:44:31.503869Z","steps":["trace[1518882534] 'process raft request' (duration: 116.433812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:31.951456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.266491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:44:31.952011Z","caller":"traceutil/trace.go:171","msg":"trace[292681881] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"250.312394ms","start":"2026-05-30T09:44:31.701676Z","end":"2026-05-30T09:44:31.951989Z","steps":["trace[292681881] 'process raft request' (duration: 129.410476ms)","trace[292681881] 'compare' (duration: 120.119608ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:44:31.972298Z","caller":"traceutil/trace.go:171","msg":"trace[1738285415] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"248.884706ms","start":"2026-05-30T09:44:31.72331Z","end":"2026-05-30T09:44:31.972195Z","steps":["trace[1738285415] 'process raft request' (duration: 248.446265ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:31.972965Z","caller":"traceutil/trace.go:171","msg":"trace[1560644227] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"241.806055ms","start":"2026-05-30T09:44:31.731126Z","end":"2026-05-30T09:44:31.972932Z","steps":["trace[1560644227] 'process raft request' (duration: 240.961192ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:32.088446Z","caller":"traceutil/trace.go:171","msg":"trace[1167296248] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"101.577859ms","start":"2026-05-30T09:44:31.986837Z","end":"2026-05-30T09:44:32.088414Z","steps":["trace[1167296248] 'process raft request' (duration: 65.407651ms)","trace[1167296248] 'compare' (duration: 35.808889ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:44:34.680872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.098302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:44:34.680998Z","caller":"traceutil/trace.go:171","msg":"trace[1000156306] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:623; }","duration":"277.261225ms","start":"2026-05-30T09:44:34.403694Z","end":"2026-05-30T09:44:34.680955Z","steps":["trace[1000156306] 'range keys from in-memory index tree' (duration: 276.970148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:39.461463Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393699071041122,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T09:44:39.613084Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.043353909s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T09:44:39.614721Z","caller":"traceutil/trace.go:171","msg":"trace[28773257] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"653.966918ms","start":"2026-05-30T09:44:38.960721Z","end":"2026-05-30T09:44:39.614688Z","steps":["trace[28773257] 'read index received' (duration: 652.534012ms)","trace[28773257] 'applied index is now lower than readState.Index' (duration: 1.431826ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:44:39.614753Z","caller":"traceutil/trace.go:171","msg":"trace[2115420394] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"1.046775284s","start":"2026-05-30T09:44:38.567946Z","end":"2026-05-30T09:44:39.614721Z","steps":["trace[2115420394] 'process raft request' (duration: 1.046095936s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:39.615591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:38.567909Z","time spent":"1.047500991s","remote":"127.0.0.1:43000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:44:39.615692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.893861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nrxb5\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-30T09:44:39.615839Z","caller":"traceutil/trace.go:171","msg":"trace[305420107] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nrxb5; range_end:; response_count:1; response_revision:653; }","duration":"655.061465ms","start":"2026-05-30T09:44:38.960713Z","end":"2026-05-30T09:44:39.615775Z","steps":["trace[305420107] 'agreement among raft nodes before linearized reading' (duration: 654.105952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:39.616059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:38.960634Z","time spent":"655.411492ms","remote":"127.0.0.1:43086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-nrxb5\" "} {"level":"warn","ts":"2026-05-30T09:44:39.616445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.56724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:44:39.616553Z","caller":"traceutil/trace.go:171","msg":"trace[263510954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"601.752224ms","start":"2026-05-30T09:44:39.014753Z","end":"2026-05-30T09:44:39.616505Z","steps":["trace[263510954] 'agreement among raft nodes before linearized reading' (duration: 601.488438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:39.616613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:39.014732Z","time spent":"601.868006ms","remote":"127.0.0.1:42892","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-30T09:44:39.617675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.597404ms","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-30T09:44:39.617731Z","caller":"traceutil/trace.go:171","msg":"trace[488104769] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:653; }","duration":"439.684736ms","start":"2026-05-30T09:44:39.178019Z","end":"2026-05-30T09:44:39.617704Z","steps":["trace[488104769] 'agreement among raft nodes before linearized reading' (duration: 439.495491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:39.617764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:39.177997Z","time spent":"439.758668ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T09:44:40.516991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393699071041125,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T09:44:40.752151Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.127455033s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T09:44:40.752759Z","caller":"traceutil/trace.go:171","msg":"trace[990316563] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"1.128156799s","start":"2026-05-30T09:44:39.624572Z","end":"2026-05-30T09:44:40.752729Z","steps":["trace[990316563] 'process raft request' (duration: 1.127860342s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:40.752979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:39.624549Z","time spent":"1.128274192s","remote":"127.0.0.1:58142","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-30T09:44:40.796086Z","caller":"traceutil/trace.go:171","msg":"trace[425445100] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"1.169036621s","start":"2026-05-30T09:44:39.627029Z","end":"2026-05-30T09:44:40.796066Z","steps":["trace[425445100] 'process raft request' (duration: 1.168853477s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:40.796423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:39.626999Z","time spent":"1.169145874s","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T09:44:40.796576Z","caller":"traceutil/trace.go:171","msg":"trace[1188764809] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"1.124401939s","start":"2026-05-30T09:44:39.672119Z","end":"2026-05-30T09:44:40.796521Z","steps":["trace[1188764809] 'process raft request' (duration: 1.124143783s)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:44:40.796654Z","caller":"traceutil/trace.go:171","msg":"trace[653248771] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"1.164310436s","start":"2026-05-30T09:44:39.632259Z","end":"2026-05-30T09:44:40.796569Z","steps":["trace[653248771] 'process raft request' (duration: 1.163757443s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:40.796781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:39.672084Z","time spent":"1.124619516s","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:44:40.797143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:39.632221Z","time spent":"1.164660316s","remote":"127.0.0.1:43086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:44:42.016745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000175763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-30T09:44:42.016868Z","caller":"traceutil/trace.go:171","msg":"trace[833904623] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000385318s","start":"2026-05-30T09:44:40.016457Z","end":"2026-05-30T09:44:42.016843Z","steps":["trace[833904623] 'agreement among raft nodes before linearized reading' (duration: 2.000221934s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:42.016921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:40.016432Z","time spent":"2.000479181s","remote":"127.0.0.1:42890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T09:44:42.260222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.463827567s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-30T09:44:42.260343Z","caller":"traceutil/trace.go:171","msg":"trace[2144456966] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:680; }","duration":"2.243794081s","start":"2026-05-30T09:44:40.016526Z","end":"2026-05-30T09:44:42.26032Z","steps":["trace[2144456966] 'read index received' (duration: 735.876485ms)","trace[2144456966] 'applied index is now lower than readState.Index' (duration: 1.507915906s)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:44:42.260689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.457903194s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-30T09:44:42.260786Z","caller":"traceutil/trace.go:171","msg":"trace[39814579] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:657; }","duration":"1.458035167s","start":"2026-05-30T09:44:40.802727Z","end":"2026-05-30T09:44:42.260762Z","steps":["trace[39814579] 'agreement among raft nodes before linearized reading' (duration: 1.457890493s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:42.260838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:40.802701Z","time spent":"1.458127529s","remote":"127.0.0.1:43110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-05-30T09:44:42.260906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.153887299s","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-30T09:44:42.261113Z","caller":"traceutil/trace.go:171","msg":"trace[1669876078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"2.154249587s","start":"2026-05-30T09:44:40.106793Z","end":"2026-05-30T09:44:42.261043Z","steps":["trace[1669876078] 'agreement among raft nodes before linearized reading' (duration: 2.153760386s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:42.26127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:40.106767Z","time spent":"2.154486103s","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T09:44:42.260687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.140095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T09:44:42.261477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.143586851s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-30T09:44:42.261692Z","caller":"traceutil/trace.go:171","msg":"trace[241658629] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:657; }","duration":"181.063176ms","start":"2026-05-30T09:44:42.080453Z","end":"2026-05-30T09:44:42.261516Z","steps":["trace[241658629] 'agreement among raft nodes before linearized reading' (duration: 180.130555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:42.260681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.433684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:44:42.261883Z","caller":"traceutil/trace.go:171","msg":"trace[159723011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:657; }","duration":"2.143757985s","start":"2026-05-30T09:44:40.117768Z","end":"2026-05-30T09:44:42.261526Z","steps":["trace[159723011] 'agreement among raft nodes before linearized reading' (duration: 2.142908315s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:42.261957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:40.117727Z","time spent":"2.144214226s","remote":"127.0.0.1:58142","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-30T09:44:42.261966Z","caller":"traceutil/trace.go:171","msg":"trace[528773941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"244.765786ms","start":"2026-05-30T09:44:42.017162Z","end":"2026-05-30T09:44:42.261927Z","steps":["trace[528773941] 'agreement among raft nodes before linearized reading' (duration: 243.407833ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:42.771243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393699071041133,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T09:44:43.271717Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393699071041133,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T09:44:43.772921Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393699071041133,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T09:44:44.083615Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.816535937s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T09:44:44.084167Z","caller":"traceutil/trace.go:171","msg":"trace[594602540] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"1.817148401s","start":"2026-05-30T09:44:42.266981Z","end":"2026-05-30T09:44:44.084129Z","steps":["trace[594602540] 'process raft request' (duration: 1.816895555s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:44.084379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:42.266966Z","time spent":"1.817307085s","remote":"127.0.0.1:42982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T09:44:44.231622Z","caller":"traceutil/trace.go:171","msg":"trace[287792080] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"1.962990691s","start":"2026-05-30T09:44:42.268592Z","end":"2026-05-30T09:44:44.231582Z","steps":["trace[287792080] 'process raft request' (duration: 1.955114527s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:44.231842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:42.268581Z","time spent":"1.963145465s","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T09:44:44.232263Z","caller":"traceutil/trace.go:171","msg":"trace[889536416] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"1.963534554s","start":"2026-05-30T09:44:42.268708Z","end":"2026-05-30T09:44:44.232243Z","steps":["trace[889536416] 'process raft request' (duration: 1.962556811s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:44.232361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:42.268677Z","time spent":"1.963635205s","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:44:44.232459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.961568917s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:44:44.232583Z","caller":"traceutil/trace.go:171","msg":"trace[2034438655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:660; }","duration":"1.9617148s","start":"2026-05-30T09:44:42.270838Z","end":"2026-05-30T09:44:44.232553Z","steps":["trace[2034438655] 'agreement among raft nodes before linearized reading' (duration: 1.961497885s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:44.232658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:42.270802Z","time spent":"1.961842303s","remote":"127.0.0.1:42890","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-30T09:44:44.232751Z","caller":"traceutil/trace.go:171","msg":"trace[2010945258] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:685; }","duration":"1.96125824s","start":"2026-05-30T09:44:42.270851Z","end":"2026-05-30T09:44:44.232109Z","steps":["trace[2010945258] 'read index received' (duration: 1.812993883s)","trace[2010945258] 'applied index is now lower than readState.Index' (duration: 148.262887ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:44:44.232936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.96042295s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:44:44.232998Z","caller":"traceutil/trace.go:171","msg":"trace[991096060] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:660; }","duration":"1.960498472s","start":"2026-05-30T09:44:42.27248Z","end":"2026-05-30T09:44:44.232979Z","steps":["trace[991096060] 'agreement among raft nodes before linearized reading' (duration: 1.960402999s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:44.23305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:42.272475Z","time spent":"1.960561723s","remote":"127.0.0.1:43042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-05-30T09:44:44.233181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057393261s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:44:44.233313Z","caller":"traceutil/trace.go:171","msg":"trace[983467833] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:660; }","duration":"1.057533134s","start":"2026-05-30T09:44:43.175767Z","end":"2026-05-30T09:44:44.2333Z","steps":["trace[983467833] 'agreement among raft nodes before linearized reading' (duration: 1.05736821s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:44.233401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.476449271s","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-30T09:44:44.233451Z","caller":"traceutil/trace.go:171","msg":"trace[2106775644] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:660; }","duration":"1.476550213s","start":"2026-05-30T09:44:42.756889Z","end":"2026-05-30T09:44:44.233439Z","steps":["trace[2106775644] 'agreement among raft nodes before linearized reading' (duration: 1.476327128s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:44.233489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:42.756866Z","time spent":"1.476615705s","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T09:44:44.233539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.431141988s","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-30T09:44:44.233598Z","caller":"traceutil/trace.go:171","msg":"trace[399993376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:660; }","duration":"1.431203891s","start":"2026-05-30T09:44:42.802381Z","end":"2026-05-30T09:44:44.233584Z","steps":["trace[399993376] 'agreement among raft nodes before linearized reading' (duration: 1.431017076s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:44.233421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:43.175658Z","time spent":"1.057747068s","remote":"127.0.0.1:58162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-30T09:44:44.233644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:42.802279Z","time spent":"1.431355104s","remote":"127.0.0.1:58142","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-30T09:44:47.723623Z","caller":"traceutil/trace.go:171","msg":"trace[591916343] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"537.858292ms","start":"2026-05-30T09:44:47.185731Z","end":"2026-05-30T09:44:47.723589Z","steps":["trace[591916343] 'process raft request' (duration: 537.611426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:44:47.723826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:44:47.185703Z","time spent":"538.013886ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T09:45:01.668516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393699071041552,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-30T09:45:01.931397Z","caller":"traceutil/trace.go:171","msg":"trace[1947516823] linearizableReadLoop","detail":"{readStateIndex:857; appliedIndex:856; }","duration":"763.212161ms","start":"2026-05-30T09:45:01.168154Z","end":"2026-05-30T09:45:01.931367Z","steps":["trace[1947516823] 'read index received' (duration: 762.931936ms)","trace[1947516823] 'applied index is now lower than readState.Index' (duration: 278.785µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:45:01.931534Z","caller":"traceutil/trace.go:171","msg":"trace[1126133506] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"820.412004ms","start":"2026-05-30T09:45:01.111075Z","end":"2026-05-30T09:45:01.931487Z","steps":["trace[1126133506] 'process raft request' (duration: 820.042266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:01.93174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:45:01.11105Z","time spent":"820.598518ms","remote":"127.0.0.1:58102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:45:01.931767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.59126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-6knx4\" ","response":"range_response_count:1 size:5049"} {"level":"info","ts":"2026-05-30T09:45:01.931806Z","caller":"traceutil/trace.go:171","msg":"trace[1304048623] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-6knx4; range_end:; response_count:1; response_revision:823; }","duration":"763.700842ms","start":"2026-05-30T09:45:01.168093Z","end":"2026-05-30T09:45:01.931794Z","steps":["trace[1304048623] 'agreement among raft nodes before linearized reading' (duration: 763.520518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:01.931847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:45:01.168059Z","time spent":"763.780583ms","remote":"127.0.0.1:43086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5072,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-6knx4\" "} {"level":"warn","ts":"2026-05-30T09:45:01.93175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.905804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:45:01.931937Z","caller":"traceutil/trace.go:171","msg":"trace[2005219077] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:823; }","duration":"511.111469ms","start":"2026-05-30T09:45:01.420807Z","end":"2026-05-30T09:45:01.931919Z","steps":["trace[2005219077] 'agreement among raft nodes before linearized reading' (duration: 510.861013ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:01.932004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:45:01.420726Z","time spent":"511.265911ms","remote":"127.0.0.1:58168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-05-30T09:45:04.230149Z","caller":"traceutil/trace.go:171","msg":"trace[2069098448] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"111.061982ms","start":"2026-05-30T09:45:04.119064Z","end":"2026-05-30T09:45:04.230126Z","steps":["trace[2069098448] 'process raft request' (duration: 110.606733ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:06.171604Z","caller":"traceutil/trace.go:171","msg":"trace[993432120] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"164.837711ms","start":"2026-05-30T09:45:06.006735Z","end":"2026-05-30T09:45:06.171573Z","steps":["trace[993432120] 'process raft request' (duration: 164.629366ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:06.346371Z","caller":"traceutil/trace.go:171","msg":"trace[1186767941] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"274.841234ms","start":"2026-05-30T09:45:06.071476Z","end":"2026-05-30T09:45:06.346317Z","steps":["trace[1186767941] 'process raft request' (duration: 272.962696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:06.673795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.663799ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:45:06.674006Z","caller":"traceutil/trace.go:171","msg":"trace[642881474] linearizableReadLoop","detail":"{readStateIndex:912; appliedIndex:910; }","duration":"207.135179ms","start":"2026-05-30T09:45:06.466851Z","end":"2026-05-30T09:45:06.673986Z","steps":["trace[642881474] 'read index received' (duration: 11.193164ms)","trace[642881474] 'applied index is now lower than readState.Index' (duration: 195.940755ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:45:06.674098Z","caller":"traceutil/trace.go:171","msg":"trace[625930013] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"233.477856ms","start":"2026-05-30T09:45:06.440609Z","end":"2026-05-30T09:45:06.674087Z","steps":["trace[625930013] 'process raft request' (duration: 233.313953ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:06.674201Z","caller":"traceutil/trace.go:171","msg":"trace[1755862981] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"250.278782ms","start":"2026-05-30T09:45:06.42384Z","end":"2026-05-30T09:45:06.674119Z","steps":["trace[1755862981] 'process raft request' (duration: 54.189095ms)","trace[1755862981] 'compare' (duration: 195.488426ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:45:06.674297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.886334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-30T09:45:06.674402Z","caller":"traceutil/trace.go:171","msg":"trace[776263022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:877; }","duration":"206.018217ms","start":"2026-05-30T09:45:06.468362Z","end":"2026-05-30T09:45:06.67438Z","steps":["trace[776263022] 'agreement among raft nodes before linearized reading' (duration: 205.764192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:06.674591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.869543ms","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-30T09:45:06.674679Z","caller":"traceutil/trace.go:171","msg":"trace[1537682093] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:877; }","duration":"205.008696ms","start":"2026-05-30T09:45:06.469647Z","end":"2026-05-30T09:45:06.674655Z","steps":["trace[1537682093] 'agreement among raft nodes before linearized reading' (duration: 204.71237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:06.674759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.904194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050260"} {"level":"info","ts":"2026-05-30T09:45:06.674802Z","caller":"traceutil/trace.go:171","msg":"trace[743788658] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:877; }","duration":"208.012846ms","start":"2026-05-30T09:45:06.466775Z","end":"2026-05-30T09:45:06.674788Z","steps":["trace[743788658] 'agreement among raft nodes before linearized reading' (duration: 207.559707ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:06.867892Z","caller":"traceutil/trace.go:171","msg":"trace[1418639684] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"187.459654ms","start":"2026-05-30T09:45:06.680405Z","end":"2026-05-30T09:45:06.867865Z","steps":["trace[1418639684] 'process raft request' (duration: 101.178246ms)","trace[1418639684] 'compare' (duration: 86.085234ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:45:06.868241Z","caller":"traceutil/trace.go:171","msg":"trace[202060985] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"185.432743ms","start":"2026-05-30T09:45:06.68275Z","end":"2026-05-30T09:45:06.868183Z","steps":["trace[202060985] 'process raft request' (duration: 185.315141ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:06.868295Z","caller":"traceutil/trace.go:171","msg":"trace[724281504] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"187.78711ms","start":"2026-05-30T09:45:06.680498Z","end":"2026-05-30T09:45:06.868286Z","steps":["trace[724281504] 'process raft request' (duration: 187.327521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:07.191704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.390421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:45:07.191829Z","caller":"traceutil/trace.go:171","msg":"trace[412742244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:880; }","duration":"177.545124ms","start":"2026-05-30T09:45:07.014258Z","end":"2026-05-30T09:45:07.191803Z","steps":["trace[412742244] 'range keys from in-memory index tree' (duration: 177.298129ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:10.663506Z","caller":"traceutil/trace.go:171","msg":"trace[885144292] linearizableReadLoop","detail":"{readStateIndex:947; appliedIndex:946; }","duration":"231.858011ms","start":"2026-05-30T09:45:10.431622Z","end":"2026-05-30T09:45:10.66348Z","steps":["trace[885144292] 'read index received' (duration: 231.752669ms)","trace[885144292] 'applied index is now lower than readState.Index' (duration: 104.132µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:45:10.663651Z","caller":"traceutil/trace.go:171","msg":"trace[1700690310] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"252.947773ms","start":"2026-05-30T09:45:10.410694Z","end":"2026-05-30T09:45:10.663642Z","steps":["trace[1700690310] 'process raft request' (duration: 252.648788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:10.664078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.435392ms","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-30T09:45:10.664131Z","caller":"traceutil/trace.go:171","msg":"trace[942647372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:911; }","duration":"232.523455ms","start":"2026-05-30T09:45:10.431595Z","end":"2026-05-30T09:45:10.664118Z","steps":["trace[942647372] 'agreement among raft nodes before linearized reading' (duration: 232.342011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:10.954213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.696117ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:45:10.954519Z","caller":"traceutil/trace.go:171","msg":"trace[2045056682] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"286.150512ms","start":"2026-05-30T09:45:10.66835Z","end":"2026-05-30T09:45:10.954501Z","steps":["trace[2045056682] 'process raft request' (duration: 286.088531ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:10.954617Z","caller":"traceutil/trace.go:171","msg":"trace[2134912474] linearizableReadLoop","detail":"{readStateIndex:948; appliedIndex:947; }","duration":"290.966596ms","start":"2026-05-30T09:45:10.663618Z","end":"2026-05-30T09:45:10.954584Z","steps":["trace[2134912474] 'read index received' (duration: 76.75915ms)","trace[2134912474] 'applied index is now lower than readState.Index' (duration: 214.204346ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:45:10.95473Z","caller":"traceutil/trace.go:171","msg":"trace[864558880] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"287.086011ms","start":"2026-05-30T09:45:10.667633Z","end":"2026-05-30T09:45:10.954719Z","steps":["trace[864558880] 'process raft request' (duration: 286.700774ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:10.954899Z","caller":"traceutil/trace.go:171","msg":"trace[1472884604] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"407.83655ms","start":"2026-05-30T09:45:10.547004Z","end":"2026-05-30T09:45:10.954841Z","steps":["trace[1472884604] 'process raft request' (duration: 193.374789ms)","trace[1472884604] 'compare' (duration: 213.515813ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:45:10.955185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:45:10.546975Z","time spent":"407.998894ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:45:10.955253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.939959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T09:45:10.955303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.120999ms","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-30T09:45:10.955377Z","caller":"traceutil/trace.go:171","msg":"trace[834249151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:914; }","duration":"269.220921ms","start":"2026-05-30T09:45:10.686139Z","end":"2026-05-30T09:45:10.95536Z","steps":["trace[834249151] 'agreement among raft nodes before linearized reading' (duration: 269.023718ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:10.955321Z","caller":"traceutil/trace.go:171","msg":"trace[1475166025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:914; }","duration":"349.03076ms","start":"2026-05-30T09:45:10.606273Z","end":"2026-05-30T09:45:10.955303Z","steps":["trace[1475166025] 'agreement among raft nodes before linearized reading' (duration: 348.929398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:10.955486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:45:10.606257Z","time spent":"349.215573ms","remote":"127.0.0.1:42890","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-30T09:45:11.121107Z","caller":"traceutil/trace.go:171","msg":"trace[1534791004] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:951; }","duration":"106.752084ms","start":"2026-05-30T09:45:11.014327Z","end":"2026-05-30T09:45:11.121079Z","steps":["trace[1534791004] 'read index received' (duration: 89.276865ms)","trace[1534791004] 'applied index is now lower than readState.Index' (duration: 17.474419ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:45:11.121298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.928617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:45:11.12131Z","caller":"traceutil/trace.go:171","msg":"trace[1643700325] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"161.476291ms","start":"2026-05-30T09:45:10.959805Z","end":"2026-05-30T09:45:11.121281Z","steps":["trace[1643700325] 'process raft request' (duration: 161.195385ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:11.12131Z","caller":"traceutil/trace.go:171","msg":"trace[968473297] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"161.42887ms","start":"2026-05-30T09:45:10.959852Z","end":"2026-05-30T09:45:11.121281Z","steps":["trace[968473297] 'process raft request' (duration: 161.188915ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:11.121341Z","caller":"traceutil/trace.go:171","msg":"trace[992481350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:918; }","duration":"107.030609ms","start":"2026-05-30T09:45:11.0143Z","end":"2026-05-30T09:45:11.12133Z","steps":["trace[992481350] 'agreement among raft nodes before linearized reading' (duration: 106.888146ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:11.121722Z","caller":"traceutil/trace.go:171","msg":"trace[1460567382] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"161.961212ms","start":"2026-05-30T09:45:10.959738Z","end":"2026-05-30T09:45:11.121699Z","steps":["trace[1460567382] 'process raft request' (duration: 143.973822ms)","trace[1460567382] 'compare' (duration: 17.104892ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:45:25.366815Z","caller":"traceutil/trace.go:171","msg":"trace[1708411908] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"109.716222ms","start":"2026-05-30T09:45:25.257058Z","end":"2026-05-30T09:45:25.366774Z","steps":["trace[1708411908] 'process raft request' (duration: 62.432433ms)","trace[1708411908] 'compare' (duration: 46.862121ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:45:25.631912Z","caller":"traceutil/trace.go:171","msg":"trace[412597043] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"260.589554ms","start":"2026-05-30T09:45:25.371288Z","end":"2026-05-30T09:45:25.631878Z","steps":["trace[412597043] 'process raft request' (duration: 260.399931ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:29.190434Z","caller":"traceutil/trace.go:171","msg":"trace[166358357] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"131.509187ms","start":"2026-05-30T09:45:29.0589Z","end":"2026-05-30T09:45:29.190409Z","steps":["trace[166358357] 'process raft request' (duration: 131.371524ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:29.207915Z","caller":"traceutil/trace.go:171","msg":"trace[1908768674] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"145.417022ms","start":"2026-05-30T09:45:29.062473Z","end":"2026-05-30T09:45:29.20789Z","steps":["trace[1908768674] 'process raft request' (duration: 145.105477ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:29.208112Z","caller":"traceutil/trace.go:171","msg":"trace[1157083024] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1083; }","duration":"102.614568ms","start":"2026-05-30T09:45:29.105463Z","end":"2026-05-30T09:45:29.208078Z","steps":["trace[1157083024] 'read index received' (duration: 85.0591ms)","trace[1157083024] 'applied index is now lower than readState.Index' (duration: 17.553288ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:45:29.208277Z","caller":"traceutil/trace.go:171","msg":"trace[1405964726] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"144.060268ms","start":"2026-05-30T09:45:29.064196Z","end":"2026-05-30T09:45:29.208256Z","steps":["trace[1405964726] 'process raft request' (duration: 143.644211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:29.208492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.934754ms","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-30T09:45:29.208548Z","caller":"traceutil/trace.go:171","msg":"trace[487851211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1045; }","duration":"103.099236ms","start":"2026-05-30T09:45:29.105433Z","end":"2026-05-30T09:45:29.208532Z","steps":["trace[487851211] 'agreement among raft nodes before linearized reading' (duration: 102.810451ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:29.965029Z","caller":"traceutil/trace.go:171","msg":"trace[1130864321] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"313.411051ms","start":"2026-05-30T09:45:29.651586Z","end":"2026-05-30T09:45:29.964997Z","steps":["trace[1130864321] 'process raft request' (duration: 313.270908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:29.965178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:45:29.651537Z","time spent":"313.571624ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T09:45:36.170643Z","caller":"traceutil/trace.go:171","msg":"trace[1590873928] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1114; }","duration":"154.446461ms","start":"2026-05-30T09:45:36.016168Z","end":"2026-05-30T09:45:36.170615Z","steps":["trace[1590873928] 'read index received' (duration: 154.291499ms)","trace[1590873928] 'applied index is now lower than readState.Index' (duration: 153.922µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:45:36.170764Z","caller":"traceutil/trace.go:171","msg":"trace[631632188] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"175.694512ms","start":"2026-05-30T09:45:35.995034Z","end":"2026-05-30T09:45:36.170729Z","steps":["trace[631632188] 'process raft request' (duration: 175.398327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:36.170803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.621144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T09:45:36.170954Z","caller":"traceutil/trace.go:171","msg":"trace[717786048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1073; }","duration":"154.817198ms","start":"2026-05-30T09:45:36.016108Z","end":"2026-05-30T09:45:36.170925Z","steps":["trace[717786048] 'agreement among raft nodes before linearized reading' (duration: 154.616974ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:45.458595Z","caller":"traceutil/trace.go:171","msg":"trace[99741294] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"117.540096ms","start":"2026-05-30T09:45:45.34103Z","end":"2026-05-30T09:45:45.45857Z","steps":["trace[99741294] 'process raft request' (duration: 117.421804ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:45:48.37331Z","caller":"traceutil/trace.go:171","msg":"trace[661116989] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"133.970208ms","start":"2026-05-30T09:45:48.239311Z","end":"2026-05-30T09:45:48.373281Z","steps":["trace[661116989] 'process raft request' (duration: 133.771815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:45:48.751717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.555823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-30T09:45:48.751818Z","caller":"traceutil/trace.go:171","msg":"trace[495084386] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1112; }","duration":"151.733806ms","start":"2026-05-30T09:45:48.600061Z","end":"2026-05-30T09:45:48.751795Z","steps":["trace[495084386] 'range keys from in-memory index tree' (duration: 151.307989ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:46:03.943909Z","caller":"traceutil/trace.go:171","msg":"trace[447832204] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"194.820245ms","start":"2026-05-30T09:46:03.749044Z","end":"2026-05-30T09:46:03.943864Z","steps":["trace[447832204] 'process raft request' (duration: 194.653172ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:46:27.174487Z","caller":"traceutil/trace.go:171","msg":"trace[970992571] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"106.888238ms","start":"2026-05-30T09:46:27.067572Z","end":"2026-05-30T09:46:27.17446Z","steps":["trace[970992571] 'read index received' (duration: 106.629305ms)","trace[970992571] 'applied index is now lower than readState.Index' (duration: 257.633µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:46:27.174567Z","caller":"traceutil/trace.go:171","msg":"trace[249107360] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"108.718865ms","start":"2026-05-30T09:46:27.06581Z","end":"2026-05-30T09:46:27.174528Z","steps":["trace[249107360] 'process raft request' (duration: 108.490362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:46:27.174851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.250324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329956"} {"level":"info","ts":"2026-05-30T09:46:27.17493Z","caller":"traceutil/trace.go:171","msg":"trace[2024859395] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1239; }","duration":"107.373006ms","start":"2026-05-30T09:46:27.067536Z","end":"2026-05-30T09:46:27.174909Z","steps":["trace[2024859395] 'agreement among raft nodes before linearized reading' (duration: 107.037581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:46:28.052229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.114451ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T09:46:28.052409Z","caller":"traceutil/trace.go:171","msg":"trace[1494287905] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1292; }","duration":"217.073004ms","start":"2026-05-30T09:46:27.835313Z","end":"2026-05-30T09:46:28.052386Z","steps":["trace[1494287905] 'read index received' (duration: 95.595017ms)","trace[1494287905] 'applied index is now lower than readState.Index' (duration: 121.476377ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:46:28.052432Z","caller":"traceutil/trace.go:171","msg":"trace[162627247] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"235.346425ms","start":"2026-05-30T09:46:27.817052Z","end":"2026-05-30T09:46:28.052399Z","steps":["trace[162627247] 'process raft request' (duration: 113.913409ms)","trace[162627247] 'compare' (duration: 120.36852ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T09:46:28.052598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.275407ms","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-30T09:46:28.052725Z","caller":"traceutil/trace.go:171","msg":"trace[1363333855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1241; }","duration":"217.400729ms","start":"2026-05-30T09:46:27.835311Z","end":"2026-05-30T09:46:28.052711Z","steps":["trace[1363333855] 'agreement among raft nodes before linearized reading' (duration: 217.133905ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T09:46:49.040362Z","caller":"traceutil/trace.go:171","msg":"trace[1691889986] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"194.434949ms","start":"2026-05-30T09:46:48.845901Z","end":"2026-05-30T09:46:49.040336Z","steps":["trace[1691889986] 'process raft request' (duration: 194.053963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:46:54.810607Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393699071042833,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-30T09:46:54.825419Z","caller":"traceutil/trace.go:171","msg":"trace[1564720229] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"632.572173ms","start":"2026-05-30T09:46:54.192814Z","end":"2026-05-30T09:46:54.825386Z","steps":["trace[1564720229] 'process raft request' (duration: 632.35643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:46:54.82566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:46:54.192799Z","time spent":"632.709825ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T09:46:54.834355Z","caller":"traceutil/trace.go:171","msg":"trace[1691969267] linearizableReadLoop","detail":"{readStateIndex:1426; appliedIndex:1424; }","duration":"523.78035ms","start":"2026-05-30T09:46:54.310556Z","end":"2026-05-30T09:46:54.834336Z","steps":["trace[1691969267] 'read index received' (duration: 514.623167ms)","trace[1691969267] 'applied index is now lower than readState.Index' (duration: 9.156393ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T09:46:54.834671Z","caller":"traceutil/trace.go:171","msg":"trace[715259494] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"641.002027ms","start":"2026-05-30T09:46:54.193659Z","end":"2026-05-30T09:46:54.834661Z","steps":["trace[715259494] 'process raft request' (duration: 640.572922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:46:54.834775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:46:54.193649Z","time spent":"641.054798ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T09:46:54.83519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.88734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-30T09:46:54.83523Z","caller":"traceutil/trace.go:171","msg":"trace[1009245191] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:1367; }","duration":"517.944811ms","start":"2026-05-30T09:46:54.317277Z","end":"2026-05-30T09:46:54.835222Z","steps":["trace[1009245191] 'agreement among raft nodes before linearized reading' (duration: 517.825309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:46:54.835253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:46:54.317268Z","time spent":"517.979562ms","remote":"127.0.0.1:42926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.74\" "} {"level":"warn","ts":"2026-05-30T09:46:54.835357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.761583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-30T09:46:54.835469Z","caller":"traceutil/trace.go:171","msg":"trace[1292601095] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1367; }","duration":"524.992026ms","start":"2026-05-30T09:46:54.310457Z","end":"2026-05-30T09:46:54.835449Z","steps":["trace[1292601095] 'agreement among raft nodes before linearized reading' (duration: 524.55836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:46:54.835562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:46:54.310433Z","time spent":"525.119937ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T09:46:54.835688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.739606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T09:46:54.835826Z","caller":"traceutil/trace.go:171","msg":"trace[881739997] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1367; }","duration":"511.964919ms","start":"2026-05-30T09:46:54.323823Z","end":"2026-05-30T09:46:54.835788Z","steps":["trace[881739997] 'agreement among raft nodes before linearized reading' (duration: 511.645655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T09:46:54.835899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T09:46:54.323791Z","time spent":"512.08586ms","remote":"127.0.0.1:58158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-05-30T09:47:25.904668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.936861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nrxb5\" ","response":"range_response_count:1 size:18521"} {"level":"info","ts":"2026-05-30T09:47:25.904761Z","caller":"traceutil/trace.go:171","msg":"trace[1540053583] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nrxb5; range_end:; response_count:1; response_revision:1475; }","duration":"270.092763ms","start":"2026-05-30T09:47:25.634647Z","end":"2026-05-30T09:47:25.90474Z","steps":["trace[1540053583] 'range keys from in-memory index tree' (duration: 269.721179ms)"],"step_count":1}