{"level":"warn","ts":"2026-04-04T10:10:03.868145Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-04T10:10:03.868247Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-04T10:10:03.868307Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-04T10:10:03.868315Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-04-04T10:10:03.868341Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-04T10:10:03.869027Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-04-04T10:10:03.869098Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-04T10:10:03.883009Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"13.71326ms"} {"level":"info","ts":"2026-04-04T10:10:04.008967Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-04-04T10:10:04.009125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-04-04T10:10:04.009172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-04-04T10:10:04.009192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-04T10:10:04.009216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-04-04T10:10:04.009292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-04-04T10:10:04.05987Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-04T10:10:04.084596Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-04T10:10:04.09916Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-04T10:10:04.109252Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-04T10:10:04.111023Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-04T10:10:04.111163Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-04T10:10:04.111208Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-04T10:10:04.111231Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-04T10:10:04.111719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-04-04T10:10:04.114357Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-04-04T10:10:04.118031Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-04T10:10:04.118243Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-04T10:10:04.118274Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-04T10:10:04.118345Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-04-04T10:10:04.118352Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-04-04T10:10:04.310911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-04-04T10:10:04.310973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-04T10:10:04.311016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-04-04T10:10:04.311089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-04-04T10:10:04.311102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-04-04T10:10:04.31116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-04-04T10:10:04.311216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-04-04T10:10:04.319087Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-04-04T10:10:04.319223Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-04T10:10:04.319301Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-04T10:10:04.319641Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-04T10:10:04.321913Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-04-04T10:10:04.322186Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-04T10:10:04.322269Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-04T10:10:04.324771Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-04T10:10:04.364474Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-04-04T10:10:04.364633Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-04T10:10:04.364705Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-04T10:10:06.481536Z","caller":"traceutil/trace.go:171","msg":"trace[1057316152] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"109.022727ms","start":"2026-04-04T10:10:06.372474Z","end":"2026-04-04T10:10:06.481497Z","steps":["trace[1057316152] 'process raft request' (duration: 108.804129ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:06.481649Z","caller":"traceutil/trace.go:171","msg":"trace[1356998476] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"109.063899ms","start":"2026-04-04T10:10:06.37255Z","end":"2026-04-04T10:10:06.481614Z","steps":["trace[1356998476] 'process raft request' (duration: 108.924293ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:06.481591Z","caller":"traceutil/trace.go:171","msg":"trace[1104243032] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"109.015717ms","start":"2026-04-04T10:10:06.372533Z","end":"2026-04-04T10:10:06.481549Z","steps":["trace[1104243032] 'process raft request' (duration: 108.883072ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:06.481883Z","caller":"traceutil/trace.go:171","msg":"trace[1651658273] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"109.187843ms","start":"2026-04-04T10:10:06.372679Z","end":"2026-04-04T10:10:06.481867Z","steps":["trace[1651658273] 'process raft request' (duration: 108.84445ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:06.482012Z","caller":"traceutil/trace.go:171","msg":"trace[776536069] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"108.662054ms","start":"2026-04-04T10:10:06.37333Z","end":"2026-04-04T10:10:06.481992Z","steps":["trace[776536069] 'process raft request' (duration: 108.246499ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:06.482174Z","caller":"traceutil/trace.go:171","msg":"trace[983800939] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"106.994354ms","start":"2026-04-04T10:10:06.375111Z","end":"2026-04-04T10:10:06.482105Z","steps":["trace[983800939] 'process raft request' (duration: 106.560519ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:06.482632Z","caller":"traceutil/trace.go:171","msg":"trace[1048070931] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"107.159489ms","start":"2026-04-04T10:10:06.374781Z","end":"2026-04-04T10:10:06.481941Z","steps":["trace[1048070931] 'process raft request' (duration: 106.830078ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:06.656232Z","caller":"traceutil/trace.go:171","msg":"trace[6261891] linearizableReadLoop","detail":"{readStateIndex:43; appliedIndex:41; }","duration":"169.807894ms","start":"2026-04-04T10:10:06.486403Z","end":"2026-04-04T10:10:06.656211Z","steps":["trace[6261891] 'read index received' (duration: 68.341281ms)","trace[6261891] 'applied index is now lower than readState.Index' (duration: 101.465663ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:06.6564Z","caller":"traceutil/trace.go:171","msg":"trace[607472536] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"170.206098ms","start":"2026-04-04T10:10:06.486173Z","end":"2026-04-04T10:10:06.656379Z","steps":["trace[607472536] 'process raft request' (duration: 114.814187ms)","trace[607472536] 'compare' (duration: 55.108101ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:06.656456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.99638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-04T10:10:06.656517Z","caller":"traceutil/trace.go:171","msg":"trace[1793211093] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:39; }","duration":"170.129835ms","start":"2026-04-04T10:10:06.486375Z","end":"2026-04-04T10:10:06.656504Z","steps":["trace[1793211093] 'agreement among raft nodes before linearized reading' (duration: 169.919758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:08.923097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.464637ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:08.923221Z","caller":"traceutil/trace.go:171","msg":"trace[1756038140] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"203.205548ms","start":"2026-04-04T10:10:08.719997Z","end":"2026-04-04T10:10:08.923203Z","steps":["trace[1756038140] 'process raft request' (duration: 84.126089ms)","trace[1756038140] 'compare' (duration: 118.292231ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:09.742906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.203553ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:09.743105Z","caller":"traceutil/trace.go:171","msg":"trace[1797514539] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"173.720048ms","start":"2026-04-04T10:10:09.569364Z","end":"2026-04-04T10:10:09.743084Z","steps":["trace[1797514539] 'process raft request' (duration: 173.648546ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:09.74324Z","caller":"traceutil/trace.go:171","msg":"trace[1667897446] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"174.009728ms","start":"2026-04-04T10:10:09.56919Z","end":"2026-04-04T10:10:09.743199Z","steps":["trace[1667897446] 'process raft request' (duration: 14.426892ms)","trace[1667897446] 'compare' (duration: 159.034477ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:10.586094Z","caller":"traceutil/trace.go:171","msg":"trace[1615002547] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"100.098808ms","start":"2026-04-04T10:10:10.485969Z","end":"2026-04-04T10:10:10.586068Z","steps":["trace[1615002547] 'process raft request' (duration: 29.108396ms)","trace[1615002547] 'compare' (duration: 70.605399ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:10.755836Z","caller":"traceutil/trace.go:171","msg":"trace[1242183685] linearizableReadLoop","detail":"{readStateIndex:249; appliedIndex:247; }","duration":"260.841545ms","start":"2026-04-04T10:10:10.494973Z","end":"2026-04-04T10:10:10.755815Z","steps":["trace[1242183685] 'read index received' (duration: 20.087648ms)","trace[1242183685] 'applied index is now lower than readState.Index' (duration: 240.752987ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:10.755916Z","caller":"traceutil/trace.go:171","msg":"trace[10789230] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"260.813124ms","start":"2026-04-04T10:10:10.495063Z","end":"2026-04-04T10:10:10.755876Z","steps":["trace[10789230] 'process raft request' (duration: 260.70726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:10.755986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.99546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-04T10:10:10.756019Z","caller":"traceutil/trace.go:171","msg":"trace[43138976] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:244; }","duration":"261.061853ms","start":"2026-04-04T10:10:10.494948Z","end":"2026-04-04T10:10:10.75601Z","steps":["trace[43138976] 'agreement among raft nodes before linearized reading' (duration: 260.970089ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:10.755906Z","caller":"traceutil/trace.go:171","msg":"trace[496695317] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"264.607107ms","start":"2026-04-04T10:10:10.491267Z","end":"2026-04-04T10:10:10.755874Z","steps":["trace[496695317] 'process raft request' (duration: 204.471717ms)","trace[496695317] 'compare' (duration: 59.776787ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:10.837203Z","caller":"traceutil/trace.go:171","msg":"trace[1186385191] transaction","detail":"{read_only:false; number_of_response:0; response_revision:244; }","duration":"242.578071ms","start":"2026-04-04T10:10:10.594603Z","end":"2026-04-04T10:10:10.837181Z","steps":["trace[1186385191] 'process raft request' (duration: 242.416216ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:10.837285Z","caller":"traceutil/trace.go:171","msg":"trace[676481521] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"230.34666ms","start":"2026-04-04T10:10:10.606913Z","end":"2026-04-04T10:10:10.837259Z","steps":["trace[676481521] 'process raft request' (duration: 230.189454ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:10.837321Z","caller":"traceutil/trace.go:171","msg":"trace[100810751] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"227.83259ms","start":"2026-04-04T10:10:10.609474Z","end":"2026-04-04T10:10:10.837306Z","steps":["trace[100810751] 'process raft request' (duration: 227.776408ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:10.837345Z","caller":"traceutil/trace.go:171","msg":"trace[552772143] transaction","detail":"{read_only:false; number_of_response:0; response_revision:246; }","duration":"228.790875ms","start":"2026-04-04T10:10:10.608534Z","end":"2026-04-04T10:10:10.837325Z","steps":["trace[552772143] 'process raft request' (duration: 228.699342ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:10.837478Z","caller":"traceutil/trace.go:171","msg":"trace[240795608] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"230.250856ms","start":"2026-04-04T10:10:10.607222Z","end":"2026-04-04T10:10:10.837473Z","steps":["trace[240795608] 'process raft request' (duration: 229.953316ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:10.837484Z","caller":"traceutil/trace.go:171","msg":"trace[235546594] transaction","detail":"{read_only:false; number_of_response:0; response_revision:246; }","duration":"229.870802ms","start":"2026-04-04T10:10:10.607606Z","end":"2026-04-04T10:10:10.837477Z","steps":["trace[235546594] 'process raft request' (duration: 229.597263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:10.838176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.798855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:10.838264Z","caller":"traceutil/trace.go:171","msg":"trace[2056709820] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:247; }","duration":"205.906988ms","start":"2026-04-04T10:10:10.632321Z","end":"2026-04-04T10:10:10.838228Z","steps":["trace[2056709820] 'agreement among raft nodes before linearized reading' (duration: 205.191043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:10.838528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.551707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-04T10:10:10.838565Z","caller":"traceutil/trace.go:171","msg":"trace[920293677] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:247; }","duration":"249.6466ms","start":"2026-04-04T10:10:10.588905Z","end":"2026-04-04T10:10:10.838552Z","steps":["trace[920293677] 'agreement among raft nodes before linearized reading' (duration: 248.628484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:10.839752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.756003ms","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-04-04T10:10:10.839807Z","caller":"traceutil/trace.go:171","msg":"trace[1934007658] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:247; }","duration":"344.814055ms","start":"2026-04-04T10:10:10.494967Z","end":"2026-04-04T10:10:10.839781Z","steps":["trace[1934007658] 'agreement among raft nodes before linearized reading' (duration: 342.567225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:10.839846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:10.49496Z","time spent":"344.872357ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-04-04T10:10:10.906265Z","caller":"traceutil/trace.go:171","msg":"trace[1722919994] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"146.178702ms","start":"2026-04-04T10:10:10.760041Z","end":"2026-04-04T10:10:10.90622Z","steps":["trace[1722919994] 'process raft request' (duration: 103.356543ms)","trace[1722919994] 'compare' (duration: 42.683524ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:10.90645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.452178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-04T10:10:10.906519Z","caller":"traceutil/trace.go:171","msg":"trace[1996919750] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:249; }","duration":"147.561672ms","start":"2026-04-04T10:10:10.758941Z","end":"2026-04-04T10:10:10.906503Z","steps":["trace[1996919750] 'agreement among raft nodes before linearized reading' (duration: 147.413057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:10.907173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.999957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115"} {"level":"info","ts":"2026-04-04T10:10:10.907276Z","caller":"traceutil/trace.go:171","msg":"trace[433905627] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:249; }","duration":"144.826845ms","start":"2026-04-04T10:10:10.762422Z","end":"2026-04-04T10:10:10.907249Z","steps":["trace[433905627] 'agreement among raft nodes before linearized reading' (duration: 143.896112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:11.146671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.340062ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:11.146938Z","caller":"traceutil/trace.go:171","msg":"trace[349894184] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"139.74365ms","start":"2026-04-04T10:10:11.007159Z","end":"2026-04-04T10:10:11.146903Z","steps":["trace[349894184] 'process raft request' (duration: 139.689899ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:11.146983Z","caller":"traceutil/trace.go:171","msg":"trace[417212254] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"186.466587ms","start":"2026-04-04T10:10:10.960478Z","end":"2026-04-04T10:10:11.146945Z","steps":["trace[417212254] 'process raft request' (duration: 186.302941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:11.147285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.716695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:11.147334Z","caller":"traceutil/trace.go:171","msg":"trace[1517259461] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:0; response_revision:260; }","duration":"140.803127ms","start":"2026-04-04T10:10:11.006518Z","end":"2026-04-04T10:10:11.147321Z","steps":["trace[1517259461] 'agreement among raft nodes before linearized reading' (duration: 140.661273ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:11.147133Z","caller":"traceutil/trace.go:171","msg":"trace[669641031] linearizableReadLoop","detail":"{readStateIndex:268; appliedIndex:266; }","duration":"140.476005ms","start":"2026-04-04T10:10:11.006569Z","end":"2026-04-04T10:10:11.147045Z","steps":["trace[669641031] 'read index received' (duration: 29.579474ms)","trace[669641031] 'applied index is now lower than readState.Index' (duration: 110.893901ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:11.147489Z","caller":"traceutil/trace.go:171","msg":"trace[1102477531] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"189.009087ms","start":"2026-04-04T10:10:10.958447Z","end":"2026-04-04T10:10:11.147456Z","steps":["trace[1102477531] 'process raft request' (duration: 77.64698ms)","trace[1102477531] 'compare' (duration: 110.196736ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:14.945425Z","caller":"traceutil/trace.go:171","msg":"trace[1902062385] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"260.342631ms","start":"2026-04-04T10:10:14.68507Z","end":"2026-04-04T10:10:14.945413Z","steps":["trace[1902062385] 'process raft request' (duration: 218.521857ms)","trace[1902062385] 'compare' (duration: 41.474511ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:14.945912Z","caller":"traceutil/trace.go:171","msg":"trace[1371435603] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:321; }","duration":"215.314358ms","start":"2026-04-04T10:10:14.72985Z","end":"2026-04-04T10:10:14.945164Z","steps":["trace[1371435603] 'read index received' (duration: 173.688431ms)","trace[1371435603] 'applied index is now lower than readState.Index' (duration: 41.625187ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:14.946318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.070196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-29ghl8\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-04-04T10:10:14.946446Z","caller":"traceutil/trace.go:171","msg":"trace[315208091] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-29ghl8; range_end:; response_count:1; response_revision:310; }","duration":"214.19992ms","start":"2026-04-04T10:10:14.732206Z","end":"2026-04-04T10:10:14.946406Z","steps":["trace[315208091] 'agreement among raft nodes before linearized reading' (duration: 214.074096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:14.946916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.324705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-04-04T10:10:14.946946Z","caller":"traceutil/trace.go:171","msg":"trace[1530704167] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:310; }","duration":"118.381747ms","start":"2026-04-04T10:10:14.828556Z","end":"2026-04-04T10:10:14.946938Z","steps":["trace[1530704167] 'agreement among raft nodes before linearized reading' (duration: 118.338645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:14.947002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.575112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-04T10:10:14.94702Z","caller":"traceutil/trace.go:171","msg":"trace[678171010] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:310; }","duration":"167.635644ms","start":"2026-04-04T10:10:14.779379Z","end":"2026-04-04T10:10:14.947015Z","steps":["trace[678171010] 'agreement among raft nodes before linearized reading' (duration: 167.606193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:14.94724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.068404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-04T10:10:14.947336Z","caller":"traceutil/trace.go:171","msg":"trace[523117904] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:310; }","duration":"217.550044ms","start":"2026-04-04T10:10:14.729776Z","end":"2026-04-04T10:10:14.947326Z","steps":["trace[523117904] 'agreement among raft nodes before linearized reading' (duration: 216.093615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.261374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.137952ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:15.261475Z","caller":"traceutil/trace.go:171","msg":"trace[1792860908] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"227.748529ms","start":"2026-04-04T10:10:15.03371Z","end":"2026-04-04T10:10:15.261458Z","steps":["trace[1792860908] 'process raft request' (duration: 74.463834ms)","trace[1792860908] 'compare' (duration: 153.013457ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:15.287618Z","caller":"traceutil/trace.go:171","msg":"trace[1601779213] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:329; }","duration":"251.613923ms","start":"2026-04-04T10:10:15.035984Z","end":"2026-04-04T10:10:15.287598Z","steps":["trace[1601779213] 'read index received' (duration: 72.242428ms)","trace[1601779213] 'applied index is now lower than readState.Index' (duration: 179.370515ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:15.287783Z","caller":"traceutil/trace.go:171","msg":"trace[2129998841] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"253.993763ms","start":"2026-04-04T10:10:15.033775Z","end":"2026-04-04T10:10:15.287769Z","steps":["trace[2129998841] 'process raft request' (duration: 253.550688ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.287657Z","caller":"traceutil/trace.go:171","msg":"trace[1683162529] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"252.076707ms","start":"2026-04-04T10:10:15.035545Z","end":"2026-04-04T10:10:15.287622Z","steps":["trace[1683162529] 'process raft request' (duration: 251.980204ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.287847Z","caller":"traceutil/trace.go:171","msg":"trace[1906252090] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"250.266845ms","start":"2026-04-04T10:10:15.03754Z","end":"2026-04-04T10:10:15.287807Z","steps":["trace[1906252090] 'process raft request' (duration: 250.022257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.287887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.884331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4425"} {"level":"info","ts":"2026-04-04T10:10:15.28765Z","caller":"traceutil/trace.go:171","msg":"trace[1413398791] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"252.510293ms","start":"2026-04-04T10:10:15.035091Z","end":"2026-04-04T10:10:15.287602Z","steps":["trace[1413398791] 'process raft request' (duration: 252.339816ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.287956Z","caller":"traceutil/trace.go:171","msg":"trace[745314812] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:323; }","duration":"251.977125ms","start":"2026-04-04T10:10:15.03596Z","end":"2026-04-04T10:10:15.287937Z","steps":["trace[745314812] 'agreement among raft nodes before linearized reading' (duration: 251.84434ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.287744Z","caller":"traceutil/trace.go:171","msg":"trace[804838385] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"252.322487ms","start":"2026-04-04T10:10:15.03541Z","end":"2026-04-04T10:10:15.287732Z","steps":["trace[804838385] 'process raft request' (duration: 252.076969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.31902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.83571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-04T10:10:15.319088Z","caller":"traceutil/trace.go:171","msg":"trace[1475838270] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:324; }","duration":"189.924794ms","start":"2026-04-04T10:10:15.129147Z","end":"2026-04-04T10:10:15.319072Z","steps":["trace[1475838270] 'agreement among raft nodes before linearized reading' (duration: 189.814159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.319097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.022054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-04T10:10:15.319175Z","caller":"traceutil/trace.go:171","msg":"trace[384496086] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:324; }","duration":"157.132927ms","start":"2026-04-04T10:10:15.16202Z","end":"2026-04-04T10:10:15.319153Z","steps":["trace[384496086] 'agreement among raft nodes before linearized reading' (duration: 156.897909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.319052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.543709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-04T10:10:15.319702Z","caller":"traceutil/trace.go:171","msg":"trace[372604038] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:324; }","duration":"232.196791ms","start":"2026-04-04T10:10:15.087471Z","end":"2026-04-04T10:10:15.319667Z","steps":["trace[372604038] 'agreement among raft nodes before linearized reading' (duration: 231.376492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.319492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.501214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-proxy-54xf4.18a31f97b8ada4f0\" ","response":"range_response_count:1 size:769"} {"level":"info","ts":"2026-04-04T10:10:15.320014Z","caller":"traceutil/trace.go:171","msg":"trace[421234538] range","detail":"{range_begin:/registry/events/kube-system/kube-proxy-54xf4.18a31f97b8ada4f0; range_end:; response_count:1; response_revision:324; }","duration":"194.093614ms","start":"2026-04-04T10:10:15.125906Z","end":"2026-04-04T10:10:15.32Z","steps":["trace[421234538] 'agreement among raft nodes before linearized reading' (duration: 193.113931ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.449441Z","caller":"traceutil/trace.go:171","msg":"trace[136486457] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"150.532422ms","start":"2026-04-04T10:10:15.298883Z","end":"2026-04-04T10:10:15.449416Z","steps":["trace[136486457] 'process raft request' (duration: 150.450869ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.449562Z","caller":"traceutil/trace.go:171","msg":"trace[928883927] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"155.75416ms","start":"2026-04-04T10:10:15.293781Z","end":"2026-04-04T10:10:15.449536Z","steps":["trace[928883927] 'process raft request' (duration: 126.028039ms)","trace[928883927] 'compare' (duration: 29.303736ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:15.511413Z","caller":"traceutil/trace.go:171","msg":"trace[912173015] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"187.369575ms","start":"2026-04-04T10:10:15.324019Z","end":"2026-04-04T10:10:15.511388Z","steps":["trace[912173015] 'process raft request' (duration: 187.144638ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.511425Z","caller":"traceutil/trace.go:171","msg":"trace[985959898] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"187.310183ms","start":"2026-04-04T10:10:15.32409Z","end":"2026-04-04T10:10:15.5114Z","steps":["trace[985959898] 'process raft request' (duration: 187.177199ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.511476Z","caller":"traceutil/trace.go:171","msg":"trace[497034123] linearizableReadLoop","detail":"{readStateIndex:339; appliedIndex:336; }","duration":"187.409286ms","start":"2026-04-04T10:10:15.324042Z","end":"2026-04-04T10:10:15.511451Z","steps":["trace[497034123] 'read index received' (duration: 95.585252ms)","trace[497034123] 'applied index is now lower than readState.Index' (duration: 91.822884ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:15.511498Z","caller":"traceutil/trace.go:171","msg":"trace[1029235140] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"181.581218ms","start":"2026-04-04T10:10:15.329877Z","end":"2026-04-04T10:10:15.511458Z","steps":["trace[1029235140] 'process raft request' (duration: 181.483125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.511608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.542091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-04-04T10:10:15.51164Z","caller":"traceutil/trace.go:171","msg":"trace[510266464] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:331; }","duration":"187.597663ms","start":"2026-04-04T10:10:15.324035Z","end":"2026-04-04T10:10:15.511633Z","steps":["trace[510266464] 'agreement among raft nodes before linearized reading' (duration: 187.49714ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.51171Z","caller":"traceutil/trace.go:171","msg":"trace[342703000] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"181.121713ms","start":"2026-04-04T10:10:15.330576Z","end":"2026-04-04T10:10:15.511698Z","steps":["trace[342703000] 'process raft request' (duration: 180.824392ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.512056Z","caller":"traceutil/trace.go:171","msg":"trace[1274980812] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"185.888125ms","start":"2026-04-04T10:10:15.326141Z","end":"2026-04-04T10:10:15.51203Z","steps":["trace[1274980812] 'process raft request' (duration: 185.177921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.732178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.969573ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:15.732365Z","caller":"traceutil/trace.go:171","msg":"trace[683660975] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"214.332253ms","start":"2026-04-04T10:10:15.518011Z","end":"2026-04-04T10:10:15.732343Z","steps":["trace[683660975] 'process raft request' (duration: 84.106912ms)","trace[683660975] 'compare' (duration: 129.680862ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:15.732499Z","caller":"traceutil/trace.go:171","msg":"trace[595059709] linearizableReadLoop","detail":"{readStateIndex:346; appliedIndex:343; }","duration":"211.813247ms","start":"2026-04-04T10:10:15.520671Z","end":"2026-04-04T10:10:15.732484Z","steps":["trace[595059709] 'read index received' (duration: 81.460631ms)","trace[595059709] 'applied index is now lower than readState.Index' (duration: 130.351816ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:15.732727Z","caller":"traceutil/trace.go:171","msg":"trace[1054477053] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"211.074112ms","start":"2026-04-04T10:10:15.521642Z","end":"2026-04-04T10:10:15.732716Z","steps":["trace[1054477053] 'process raft request' (duration: 210.799003ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.732764Z","caller":"traceutil/trace.go:171","msg":"trace[1210286424] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"213.549997ms","start":"2026-04-04T10:10:15.519205Z","end":"2026-04-04T10:10:15.732755Z","steps":["trace[1210286424] 'process raft request' (duration: 213.102011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.732936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.252952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-04T10:10:15.732977Z","caller":"traceutil/trace.go:171","msg":"trace[1104481664] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:335; }","duration":"212.312854ms","start":"2026-04-04T10:10:15.520655Z","end":"2026-04-04T10:10:15.732967Z","steps":["trace[1104481664] 'agreement among raft nodes before linearized reading' (duration: 212.238902ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.732985Z","caller":"traceutil/trace.go:171","msg":"trace[333915518] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"213.605869ms","start":"2026-04-04T10:10:15.519371Z","end":"2026-04-04T10:10:15.732977Z","steps":["trace[333915518] 'process raft request' (duration: 213.022149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:15.73313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.530393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:15.733165Z","caller":"traceutil/trace.go:171","msg":"trace[1218935624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:335; }","duration":"200.590905ms","start":"2026-04-04T10:10:15.532566Z","end":"2026-04-04T10:10:15.733157Z","steps":["trace[1218935624] 'agreement among raft nodes before linearized reading' (duration: 200.542053ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:15.994786Z","caller":"traceutil/trace.go:171","msg":"trace[360832646] linearizableReadLoop","detail":"{readStateIndex:349; appliedIndex:348; }","duration":"196.821327ms","start":"2026-04-04T10:10:15.797936Z","end":"2026-04-04T10:10:15.994758Z","steps":["trace[360832646] 'read index received' (duration: 169.328972ms)","trace[360832646] 'applied index is now lower than readState.Index' (duration: 27.491135ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:15.994945Z","caller":"traceutil/trace.go:171","msg":"trace[1577048602] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"251.192138ms","start":"2026-04-04T10:10:15.743715Z","end":"2026-04-04T10:10:15.994908Z","steps":["trace[1577048602] 'process raft request' (duration: 223.471634ms)","trace[1577048602] 'compare' (duration: 27.435335ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:15.994991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.35174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-04T10:10:15.99507Z","caller":"traceutil/trace.go:171","msg":"trace[930990103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:337; }","duration":"218.475584ms","start":"2026-04-04T10:10:15.776581Z","end":"2026-04-04T10:10:15.995057Z","steps":["trace[930990103] 'agreement among raft nodes before linearized reading' (duration: 218.34089ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:16.036028Z","caller":"traceutil/trace.go:171","msg":"trace[1270210447] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"232.514365ms","start":"2026-04-04T10:10:15.803475Z","end":"2026-04-04T10:10:16.035989Z","steps":["trace[1270210447] 'process raft request' (duration: 232.275226ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:16.036439Z","caller":"traceutil/trace.go:171","msg":"trace[1340190581] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"230.943761ms","start":"2026-04-04T10:10:15.805456Z","end":"2026-04-04T10:10:16.0364Z","steps":["trace[1340190581] 'process raft request' (duration: 230.476676ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:16.036537Z","caller":"traceutil/trace.go:171","msg":"trace[418706285] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"232.831145ms","start":"2026-04-04T10:10:15.803689Z","end":"2026-04-04T10:10:16.036521Z","steps":["trace[418706285] 'process raft request' (duration: 232.203855ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:16.03675Z","caller":"traceutil/trace.go:171","msg":"trace[717452367] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"231.051105ms","start":"2026-04-04T10:10:15.805626Z","end":"2026-04-04T10:10:16.036677Z","steps":["trace[717452367] 'process raft request' (duration: 230.373682ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:16.036801Z","caller":"traceutil/trace.go:171","msg":"trace[1147034171] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"227.35137ms","start":"2026-04-04T10:10:15.809432Z","end":"2026-04-04T10:10:16.036783Z","steps":["trace[1147034171] 'process raft request' (duration: 226.618695ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:27.676469Z","caller":"traceutil/trace.go:171","msg":"trace[873989781] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"115.713491ms","start":"2026-04-04T10:10:27.560723Z","end":"2026-04-04T10:10:27.676436Z","steps":["trace[873989781] 'process raft request' (duration: 115.583446ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:28.733438Z","caller":"traceutil/trace.go:171","msg":"trace[1321946866] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"222.328812ms","start":"2026-04-04T10:10:28.511081Z","end":"2026-04-04T10:10:28.73341Z","steps":["trace[1321946866] 'process raft request' (duration: 222.193128ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:33.868463Z","caller":"traceutil/trace.go:171","msg":"trace[566929736] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"137.306117ms","start":"2026-04-04T10:10:33.731124Z","end":"2026-04-04T10:10:33.86843Z","steps":["trace[566929736] 'process raft request' (duration: 137.172073ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:34.807487Z","caller":"traceutil/trace.go:171","msg":"trace[4130174] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"191.160698ms","start":"2026-04-04T10:10:34.616289Z","end":"2026-04-04T10:10:34.80745Z","steps":["trace[4130174] 'process raft request' (duration: 190.58518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:35.013514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.949361ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:35.013849Z","caller":"traceutil/trace.go:171","msg":"trace[924937664] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"183.494445ms","start":"2026-04-04T10:10:34.830315Z","end":"2026-04-04T10:10:35.01381Z","steps":["trace[924937664] 'process raft request' (duration: 46.017529ms)","trace[924937664] 'compare' (duration: 136.776025ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:35.013878Z","caller":"traceutil/trace.go:171","msg":"trace[1000599865] linearizableReadLoop","detail":"{readStateIndex:455; appliedIndex:453; }","duration":"154.862611ms","start":"2026-04-04T10:10:34.858993Z","end":"2026-04-04T10:10:35.013855Z","steps":["trace[1000599865] 'read index received' (duration: 17.365304ms)","trace[1000599865] 'applied index is now lower than readState.Index' (duration: 137.495967ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:35.013968Z","caller":"traceutil/trace.go:171","msg":"trace[1724973116] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"183.375851ms","start":"2026-04-04T10:10:34.830551Z","end":"2026-04-04T10:10:35.013927Z","steps":["trace[1724973116] 'process raft request' (duration: 183.140495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:35.014103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.101858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:35.014228Z","caller":"traceutil/trace.go:171","msg":"trace[1042194108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:437; }","duration":"155.228162ms","start":"2026-04-04T10:10:34.85895Z","end":"2026-04-04T10:10:35.014178Z","steps":["trace[1042194108] 'agreement among raft nodes before linearized reading' (duration: 155.028416ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:35.179695Z","caller":"traceutil/trace.go:171","msg":"trace[917291911] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"159.867396ms","start":"2026-04-04T10:10:35.019794Z","end":"2026-04-04T10:10:35.179662Z","steps":["trace[917291911] 'process raft request' (duration: 147.814114ms)","trace[917291911] 'compare' (duration: 11.853566ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:35.341372Z","caller":"traceutil/trace.go:171","msg":"trace[2105908272] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"103.261058ms","start":"2026-04-04T10:10:35.238081Z","end":"2026-04-04T10:10:35.341342Z","steps":["trace[2105908272] 'process raft request' (duration: 68.69296ms)","trace[2105908272] 'compare' (duration: 34.382603ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:35.579762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.32214ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:35.579888Z","caller":"traceutil/trace.go:171","msg":"trace[1414621116] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"156.64714ms","start":"2026-04-04T10:10:35.423221Z","end":"2026-04-04T10:10:35.579868Z","steps":["trace[1414621116] 'process raft request' (duration: 35.127303ms)","trace[1414621116] 'compare' (duration: 121.142705ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:35.765355Z","caller":"traceutil/trace.go:171","msg":"trace[2072335019] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"176.125424ms","start":"2026-04-04T10:10:35.589199Z","end":"2026-04-04T10:10:35.765324Z","steps":["trace[2072335019] 'process raft request' (duration: 135.487394ms)","trace[2072335019] 'compare' (duration: 39.9701ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:35.947898Z","caller":"traceutil/trace.go:171","msg":"trace[1041906097] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"120.731871ms","start":"2026-04-04T10:10:35.827135Z","end":"2026-04-04T10:10:35.947867Z","steps":["trace[1041906097] 'process raft request' (duration: 112.087112ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:35.956301Z","caller":"traceutil/trace.go:171","msg":"trace[1866666503] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"126.420733ms","start":"2026-04-04T10:10:35.829853Z","end":"2026-04-04T10:10:35.956274Z","steps":["trace[1866666503] 'process raft request' (duration: 126.253478ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:35.956524Z","caller":"traceutil/trace.go:171","msg":"trace[1312846753] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"126.736804ms","start":"2026-04-04T10:10:35.82974Z","end":"2026-04-04T10:10:35.956477Z","steps":["trace[1312846753] 'process raft request' (duration: 126.30466ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:35.956822Z","caller":"traceutil/trace.go:171","msg":"trace[1688523820] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"125.056893ms","start":"2026-04-04T10:10:35.831748Z","end":"2026-04-04T10:10:35.956804Z","steps":["trace[1688523820] 'process raft request' (duration: 124.387493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:37.042999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.17381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:37.043071Z","caller":"traceutil/trace.go:171","msg":"trace[1477663286] linearizableReadLoop","detail":"{readStateIndex:486; appliedIndex:485; }","duration":"781.603641ms","start":"2026-04-04T10:10:36.261457Z","end":"2026-04-04T10:10:37.043061Z","steps":["trace[1477663286] 'read index received' (duration: 316.245685ms)","trace[1477663286] 'applied index is now lower than readState.Index' (duration: 465.357306ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:37.043123Z","caller":"traceutil/trace.go:171","msg":"trace[1107812816] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"867.633187ms","start":"2026-04-04T10:10:36.175483Z","end":"2026-04-04T10:10:37.043117Z","steps":["trace[1107812816] 'process raft request' (duration: 402.308102ms)","trace[1107812816] 'compare' (duration: 464.439228ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:37.043151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:36.175462Z","time spent":"867.673618ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:10:37.04322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.499913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-04T10:10:37.043269Z","caller":"traceutil/trace.go:171","msg":"trace[1023161749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:468; }","duration":"214.592225ms","start":"2026-04-04T10:10:36.828662Z","end":"2026-04-04T10:10:37.043255Z","steps":["trace[1023161749] 'agreement among raft nodes before linearized reading' (duration: 214.506173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:37.04348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.751515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-04T10:10:37.043548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.082704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-04T10:10:37.043571Z","caller":"traceutil/trace.go:171","msg":"trace[1686534837] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:468; }","duration":"181.89507ms","start":"2026-04-04T10:10:36.861657Z","end":"2026-04-04T10:10:37.043552Z","steps":["trace[1686534837] 'agreement among raft nodes before linearized reading' (duration: 181.731175ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:37.043612Z","caller":"traceutil/trace.go:171","msg":"trace[150146903] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:468; }","duration":"782.189437ms","start":"2026-04-04T10:10:36.261406Z","end":"2026-04-04T10:10:37.043595Z","steps":["trace[150146903] 'agreement among raft nodes before linearized reading' (duration: 782.004812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:37.043713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:36.261381Z","time spent":"782.258539ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-04T10:10:37.730857Z","caller":"traceutil/trace.go:171","msg":"trace[1797160318] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"243.355849ms","start":"2026-04-04T10:10:37.487472Z","end":"2026-04-04T10:10:37.730827Z","steps":["trace[1797160318] 'process raft request' (duration: 243.115392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.043894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.323351ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:38.044021Z","caller":"traceutil/trace.go:171","msg":"trace[1239551417] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:474; }","duration":"129.473205ms","start":"2026-04-04T10:10:37.914529Z","end":"2026-04-04T10:10:38.044002Z","steps":["trace[1239551417] 'range keys from in-memory index tree' (duration: 129.30603ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.055116Z","caller":"traceutil/trace.go:171","msg":"trace[1770794129] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"567.487055ms","start":"2026-04-04T10:10:37.487609Z","end":"2026-04-04T10:10:38.055096Z","steps":["trace[1770794129] 'process raft request' (duration: 567.142455ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.055185Z","caller":"traceutil/trace.go:171","msg":"trace[1114665254] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"552.057168ms","start":"2026-04-04T10:10:37.503097Z","end":"2026-04-04T10:10:38.055154Z","steps":["trace[1114665254] 'process raft request' (duration: 551.897493ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.055245Z","caller":"traceutil/trace.go:171","msg":"trace[887321965] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"544.02266ms","start":"2026-04-04T10:10:37.511186Z","end":"2026-04-04T10:10:38.055208Z","steps":["trace[887321965] 'process raft request' (duration: 543.861766ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.055292Z","caller":"traceutil/trace.go:171","msg":"trace[11666985] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"543.981089ms","start":"2026-04-04T10:10:37.511248Z","end":"2026-04-04T10:10:38.055229Z","steps":["trace[11666985] 'process raft request' (duration: 543.839645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.055335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.503078Z","time spent":"552.179212ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:38.055465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.511244Z","time spent":"544.127444ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-04T10:10:38.055465Z","caller":"traceutil/trace.go:171","msg":"trace[1404704817] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"536.531808ms","start":"2026-04-04T10:10:37.518898Z","end":"2026-04-04T10:10:38.05543Z","steps":["trace[1404704817] 'process raft request' (duration: 536.298361ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.055467Z","caller":"traceutil/trace.go:171","msg":"trace[1306842841] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"532.302913ms","start":"2026-04-04T10:10:37.523142Z","end":"2026-04-04T10:10:38.055445Z","steps":["trace[1306842841] 'process raft request' (duration: 532.122807ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.055625Z","caller":"traceutil/trace.go:171","msg":"trace[1720416060] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"522.721989ms","start":"2026-04-04T10:10:37.532863Z","end":"2026-04-04T10:10:38.055585Z","steps":["trace[1720416060] 'process raft request' (duration: 522.512473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.05566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.511166Z","time spent":"544.206716ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-04T10:10:38.055714Z","caller":"traceutil/trace.go:171","msg":"trace[1725833660] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"518.566015ms","start":"2026-04-04T10:10:37.537131Z","end":"2026-04-04T10:10:38.055697Z","steps":["trace[1725833660] 'process raft request' (duration: 518.305698ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.055744Z","caller":"traceutil/trace.go:171","msg":"trace[381281585] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"494.413768ms","start":"2026-04-04T10:10:37.561316Z","end":"2026-04-04T10:10:38.05573Z","steps":["trace[381281585] 'process raft request' (duration: 494.191062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.05572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.518872Z","time spent":"536.725623ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:38.055812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.561294Z","time spent":"494.489ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-04T10:10:38.055438Z","caller":"traceutil/trace.go:171","msg":"trace[1937003758] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"536.484816ms","start":"2026-04-04T10:10:37.518844Z","end":"2026-04-04T10:10:38.055329Z","steps":["trace[1937003758] 'process raft request' (duration: 536.29342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.055662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.523131Z","time spent":"532.489848ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:38.05583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.53711Z","time spent":"518.674488ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:38.0559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.518825Z","time spent":"537.059733ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:38.055799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.532812Z","time spent":"522.908784ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-04T10:10:38.055759Z","caller":"traceutil/trace.go:171","msg":"trace[423178625] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"398.922736ms","start":"2026-04-04T10:10:37.656804Z","end":"2026-04-04T10:10:38.055727Z","steps":["trace[423178625] 'process raft request' (duration: 398.819353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.056107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.656779Z","time spent":"399.209234ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:38.056161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.487598Z","time spent":"567.574308ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:38.398498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.64506ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:38.39871Z","caller":"traceutil/trace.go:171","msg":"trace[734855772] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"661.693244ms","start":"2026-04-04T10:10:37.73699Z","end":"2026-04-04T10:10:38.398683Z","steps":["trace[734855772] 'process raft request' (duration: 501.789646ms)","trace[734855772] 'compare' (duration: 159.476305ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:38.39879Z","caller":"traceutil/trace.go:171","msg":"trace[1597639666] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"659.316914ms","start":"2026-04-04T10:10:37.739415Z","end":"2026-04-04T10:10:38.398732Z","steps":["trace[1597639666] 'process raft request' (duration: 659.17733ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.398728Z","caller":"traceutil/trace.go:171","msg":"trace[11174088] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:492; }","duration":"535.900733ms","start":"2026-04-04T10:10:37.862814Z","end":"2026-04-04T10:10:38.398715Z","steps":["trace[11174088] 'read index received' (duration: 191.994428ms)","trace[11174088] 'applied index is now lower than readState.Index' (duration: 343.905535ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:38.39882Z","caller":"traceutil/trace.go:171","msg":"trace[1385241560] transaction","detail":"{read_only:false; number_of_response:1; response_revision:487; }","duration":"659.349455ms","start":"2026-04-04T10:10:37.739437Z","end":"2026-04-04T10:10:38.398786Z","steps":["trace[1385241560] 'process raft request' (duration: 659.232922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.398822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.030266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:38.398923Z","caller":"traceutil/trace.go:171","msg":"trace[1829251313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:487; }","duration":"536.15481ms","start":"2026-04-04T10:10:37.862758Z","end":"2026-04-04T10:10:38.398913Z","steps":["trace[1829251313] 'agreement among raft nodes before linearized reading' (duration: 535.994306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.398833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.736964Z","time spent":"661.827598ms","remote":"127.0.0.1:51102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:38.399073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.739398Z","time spent":"659.466928ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:10:38.398958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.862743Z","time spent":"536.207241ms","remote":"127.0.0.1:50558","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-04-04T10:10:38.399127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.739418Z","time spent":"659.476459ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7365,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:38.408779Z","caller":"traceutil/trace.go:171","msg":"trace[1234802115] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"343.165093ms","start":"2026-04-04T10:10:38.065593Z","end":"2026-04-04T10:10:38.408758Z","steps":["trace[1234802115] 'process raft request' (duration: 342.953857ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.408903Z","caller":"traceutil/trace.go:171","msg":"trace[1512495636] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"343.153423ms","start":"2026-04-04T10:10:38.065736Z","end":"2026-04-04T10:10:38.408889Z","steps":["trace[1512495636] 'process raft request' (duration: 342.925066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.408904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.065567Z","time spent":"343.294027ms","remote":"127.0.0.1:51102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-04T10:10:38.409Z","caller":"traceutil/trace.go:171","msg":"trace[1105060648] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"338.727372ms","start":"2026-04-04T10:10:38.070262Z","end":"2026-04-04T10:10:38.408989Z","steps":["trace[1105060648] 'process raft request' (duration: 338.469774ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.409195Z","caller":"traceutil/trace.go:171","msg":"trace[1725148238] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"336.197578ms","start":"2026-04-04T10:10:38.072986Z","end":"2026-04-04T10:10:38.409183Z","steps":["trace[1725148238] 'process raft request' (duration: 335.951681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.409265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.072962Z","time spent":"336.279349ms","remote":"127.0.0.1:51102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-04T10:10:38.409275Z","caller":"traceutil/trace.go:171","msg":"trace[424150638] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"336.164467ms","start":"2026-04-04T10:10:38.073093Z","end":"2026-04-04T10:10:38.409257Z","steps":["trace[424150638] 'process raft request' (duration: 336.004682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.409389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.073086Z","time spent":"336.257579ms","remote":"127.0.0.1:51102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-04T10:10:38.409487Z","caller":"traceutil/trace.go:171","msg":"trace[1202419260] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"321.152163ms","start":"2026-04-04T10:10:38.088326Z","end":"2026-04-04T10:10:38.409478Z","steps":["trace[1202419260] 'process raft request' (duration: 321.03495ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.409495Z","caller":"traceutil/trace.go:171","msg":"trace[2120532915] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"334.343612ms","start":"2026-04-04T10:10:38.075137Z","end":"2026-04-04T10:10:38.409481Z","steps":["trace[2120532915] 'process raft request' (duration: 334.130666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.409589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.088302Z","time spent":"321.215115ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:10:38.409634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.075101Z","time spent":"334.472427ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:38.40977Z","caller":"traceutil/trace.go:171","msg":"trace[1429475082] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"281.182055ms","start":"2026-04-04T10:10:38.12858Z","end":"2026-04-04T10:10:38.409762Z","steps":["trace[1429475082] 'process raft request' (duration: 281.102773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.409821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.555889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-04T10:10:38.409837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.705348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-04T10:10:38.409862Z","caller":"traceutil/trace.go:171","msg":"trace[119104553] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:496; }","duration":"418.634462ms","start":"2026-04-04T10:10:37.991216Z","end":"2026-04-04T10:10:38.409851Z","steps":["trace[119104553] 'agreement among raft nodes before linearized reading' (duration: 418.5472ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.409893Z","caller":"traceutil/trace.go:171","msg":"trace[1003965832] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:496; }","duration":"468.79076ms","start":"2026-04-04T10:10:37.941093Z","end":"2026-04-04T10:10:38.409884Z","steps":["trace[1003965832] 'agreement among raft nodes before linearized reading' (duration: 468.700498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.409897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.991189Z","time spent":"418.701004ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-04T10:10:38.409922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:37.941073Z","time spent":"468.842501ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.116\" "} {"level":"info","ts":"2026-04-04T10:10:38.409907Z","caller":"traceutil/trace.go:171","msg":"trace[120912824] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"319.895917ms","start":"2026-04-04T10:10:38.089948Z","end":"2026-04-04T10:10:38.409844Z","steps":["trace[120912824] 'process raft request' (duration: 319.475304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:38.410088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.089941Z","time spent":"320.110453ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:10:38.409808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.065705Z","time spent":"343.233096ms","remote":"127.0.0.1:51102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:38.410106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.07025Z","time spent":"338.774073ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:38.630935Z","caller":"traceutil/trace.go:171","msg":"trace[1243802348] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"217.516037ms","start":"2026-04-04T10:10:38.413382Z","end":"2026-04-04T10:10:38.630898Z","steps":["trace[1243802348] 'process raft request' (duration: 217.188197ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.631462Z","caller":"traceutil/trace.go:171","msg":"trace[1962078791] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"216.541097ms","start":"2026-04-04T10:10:38.414778Z","end":"2026-04-04T10:10:38.631319Z","steps":["trace[1962078791] 'process raft request' (duration: 215.977ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.631469Z","caller":"traceutil/trace.go:171","msg":"trace[1487030155] transaction","detail":"{read_only:false; number_of_response:1; response_revision:500; }","duration":"210.623803ms","start":"2026-04-04T10:10:38.420821Z","end":"2026-04-04T10:10:38.631445Z","steps":["trace[1487030155] 'process raft request' (duration: 210.040056ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.632016Z","caller":"traceutil/trace.go:171","msg":"trace[27191152] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"210.893811ms","start":"2026-04-04T10:10:38.421101Z","end":"2026-04-04T10:10:38.631995Z","steps":["trace[27191152] 'process raft request' (duration: 209.82986ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.632064Z","caller":"traceutil/trace.go:171","msg":"trace[48635317] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"200.175415ms","start":"2026-04-04T10:10:38.431876Z","end":"2026-04-04T10:10:38.632051Z","steps":["trace[48635317] 'process raft request' (duration: 200.031311ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:38.632159Z","caller":"traceutil/trace.go:171","msg":"trace[1563313297] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"203.236046ms","start":"2026-04-04T10:10:38.428914Z","end":"2026-04-04T10:10:38.63215Z","steps":["trace[1563313297] 'process raft request' (duration: 202.085592ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:39.159994Z","caller":"traceutil/trace.go:171","msg":"trace[1245725328] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"685.630691ms","start":"2026-04-04T10:10:38.474337Z","end":"2026-04-04T10:10:39.159968Z","steps":["trace[1245725328] 'process raft request' (duration: 685.535749ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:39.160039Z","caller":"traceutil/trace.go:171","msg":"trace[2060761452] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"689.765263ms","start":"2026-04-04T10:10:38.470233Z","end":"2026-04-04T10:10:39.159998Z","steps":["trace[2060761452] 'process raft request' (duration: 644.32984ms)","trace[2060761452] 'compare' (duration: 45.106044ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:39.160206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.474289Z","time spent":"685.791305ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:39.160321Z","caller":"traceutil/trace.go:171","msg":"trace[1398646708] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"677.223283ms","start":"2026-04-04T10:10:38.48307Z","end":"2026-04-04T10:10:39.160293Z","steps":["trace[1398646708] 'process raft request' (duration: 677.074759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:39.160402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.470204Z","time spent":"689.940269ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:39.160412Z","caller":"traceutil/trace.go:171","msg":"trace[1747462150] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"685.727315ms","start":"2026-04-04T10:10:38.474618Z","end":"2026-04-04T10:10:39.160345Z","steps":["trace[1747462150] 'process raft request' (duration: 685.309202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:39.160494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.483014Z","time spent":"677.381898ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:10:39.160683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.474604Z","time spent":"685.92978ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:39.483646Z","caller":"traceutil/trace.go:171","msg":"trace[1763200329] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:524; }","duration":"436.132095ms","start":"2026-04-04T10:10:39.047486Z","end":"2026-04-04T10:10:39.483618Z","steps":["trace[1763200329] 'read index received' (duration: 67.031146ms)","trace[1763200329] 'applied index is now lower than readState.Index' (duration: 369.099809ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:39.483734Z","caller":"traceutil/trace.go:171","msg":"trace[1287867386] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"850.792101ms","start":"2026-04-04T10:10:38.632917Z","end":"2026-04-04T10:10:39.483709Z","steps":["trace[1287867386] 'process raft request' (duration: 813.132876ms)","trace[1287867386] 'compare' (duration: 37.290594ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:39.483763Z","caller":"traceutil/trace.go:171","msg":"trace[724807117] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"837.449217ms","start":"2026-04-04T10:10:38.646304Z","end":"2026-04-04T10:10:39.483753Z","steps":["trace[724807117] 'process raft request' (duration: 837.23711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:39.483874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.632901Z","time spent":"850.887924ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:10:39.483951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:38.646279Z","time spent":"837.512359ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:10:39.484346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.836666ms","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-04-04T10:10:39.48443Z","caller":"traceutil/trace.go:171","msg":"trace[1068912375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:509; }","duration":"436.99259ms","start":"2026-04-04T10:10:39.047416Z","end":"2026-04-04T10:10:39.484409Z","steps":["trace[1068912375] 'agreement among raft nodes before linearized reading' (duration: 436.639369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:39.484525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:39.04739Z","time spent":"437.078224ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-04T10:10:39.489778Z","caller":"traceutil/trace.go:171","msg":"trace[712742124] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"318.164733ms","start":"2026-04-04T10:10:39.171601Z","end":"2026-04-04T10:10:39.489766Z","steps":["trace[712742124] 'process raft request' (duration: 317.836594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:39.489847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:39.171574Z","time spent":"318.236186ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:39.489918Z","caller":"traceutil/trace.go:171","msg":"trace[1483303248] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"273.789491ms","start":"2026-04-04T10:10:39.216122Z","end":"2026-04-04T10:10:39.489912Z","steps":["trace[1483303248] 'process raft request' (duration: 273.698588ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:39.489904Z","caller":"traceutil/trace.go:171","msg":"trace[1677086223] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"300.029503ms","start":"2026-04-04T10:10:39.189855Z","end":"2026-04-04T10:10:39.489884Z","steps":["trace[1677086223] 'process raft request' (duration: 299.770204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:39.490008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:39.189826Z","time spent":"300.134895ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:10:39.490049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.335805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-04T10:10:39.490124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.519668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-04T10:10:39.490167Z","caller":"traceutil/trace.go:171","msg":"trace[1443099301] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"430.481749ms","start":"2026-04-04T10:10:39.059657Z","end":"2026-04-04T10:10:39.490139Z","steps":["trace[1443099301] 'agreement among raft nodes before linearized reading' (duration: 430.275303ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:39.490215Z","caller":"traceutil/trace.go:171","msg":"trace[614794148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:512; }","duration":"434.658961ms","start":"2026-04-04T10:10:39.055537Z","end":"2026-04-04T10:10:39.490196Z","steps":["trace[614794148] 'agreement among raft nodes before linearized reading' (duration: 434.430465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:39.490221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:39.059648Z","time spent":"430.560842ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-04T10:10:39.490306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:39.055509Z","time spent":"434.737004ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-04T10:10:39.892946Z","caller":"traceutil/trace.go:171","msg":"trace[1448430673] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"221.065776ms","start":"2026-04-04T10:10:39.671859Z","end":"2026-04-04T10:10:39.892924Z","steps":["trace[1448430673] 'process raft request' (duration: 150.928618ms)","trace[1448430673] 'compare' (duration: 69.908612ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:39.893376Z","caller":"traceutil/trace.go:171","msg":"trace[2110030585] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"221.235481ms","start":"2026-04-04T10:10:39.671999Z","end":"2026-04-04T10:10:39.893235Z","steps":["trace[2110030585] 'process raft request' (duration: 220.86397ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:40.494997Z","caller":"traceutil/trace.go:171","msg":"trace[73103276] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"320.602224ms","start":"2026-04-04T10:10:40.174375Z","end":"2026-04-04T10:10:40.494977Z","steps":["trace[73103276] 'process raft request' (duration: 320.413149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:40.495136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:40.174349Z","time spent":"320.717498ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:40.51457Z","caller":"traceutil/trace.go:171","msg":"trace[1544078198] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"276.446896ms","start":"2026-04-04T10:10:40.238101Z","end":"2026-04-04T10:10:40.514548Z","steps":["trace[1544078198] 'process raft request' (duration: 276.391365ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:40.514697Z","caller":"traceutil/trace.go:171","msg":"trace[726150481] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"331.880673ms","start":"2026-04-04T10:10:40.182785Z","end":"2026-04-04T10:10:40.514666Z","steps":["trace[726150481] 'process raft request' (duration: 331.454172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:40.51485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:40.182768Z","time spent":"331.991096ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:10:41.198185Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969589409705591,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-04T10:10:41.361325Z","caller":"traceutil/trace.go:171","msg":"trace[1667770364] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"709.924618ms","start":"2026-04-04T10:10:40.651366Z","end":"2026-04-04T10:10:41.361291Z","steps":["trace[1667770364] 'process raft request' (duration: 620.76384ms)","trace[1667770364] 'compare' (duration: 88.970192ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:41.361491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:40.651348Z","time spent":"710.060242ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:41.369898Z","caller":"traceutil/trace.go:171","msg":"trace[1977202470] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"691.946362ms","start":"2026-04-04T10:10:40.67793Z","end":"2026-04-04T10:10:41.369876Z","steps":["trace[1977202470] 'process raft request' (duration: 691.680764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:41.370009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:40.677902Z","time spent":"692.046846ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:41.370131Z","caller":"traceutil/trace.go:171","msg":"trace[2092952829] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:565; }","duration":"672.526175ms","start":"2026-04-04T10:10:40.697593Z","end":"2026-04-04T10:10:41.370119Z","steps":["trace[2092952829] 'read index received' (duration: 574.486039ms)","trace[2092952829] 'applied index is now lower than readState.Index' (duration: 98.039546ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:41.370484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.864216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-04T10:10:41.370546Z","caller":"traceutil/trace.go:171","msg":"trace[79523276] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"590.74286ms","start":"2026-04-04T10:10:40.77978Z","end":"2026-04-04T10:10:41.370523Z","steps":["trace[79523276] 'process raft request' (duration: 590.022469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:41.370637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:40.779749Z","time spent":"590.852033ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:10:41.370638Z","caller":"traceutil/trace.go:171","msg":"trace[230992471] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:547; }","duration":"673.03461ms","start":"2026-04-04T10:10:40.697552Z","end":"2026-04-04T10:10:41.370586Z","steps":["trace[230992471] 'agreement among raft nodes before linearized reading' (duration: 672.788654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:41.370751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:40.697533Z","time spent":"673.203705ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":7730,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-04T10:10:41.370829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.83689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:41.370971Z","caller":"traceutil/trace.go:171","msg":"trace[1543162846] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"508.16663ms","start":"2026-04-04T10:10:40.862754Z","end":"2026-04-04T10:10:41.37092Z","steps":["trace[1543162846] 'agreement among raft nodes before linearized reading' (duration: 507.772339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:41.371075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:40.862732Z","time spent":"508.329936ms","remote":"127.0.0.1:50558","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-04-04T10:10:41.850729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.127649ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:41.850864Z","caller":"traceutil/trace.go:171","msg":"trace[282949967] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"384.840949ms","start":"2026-04-04T10:10:41.465977Z","end":"2026-04-04T10:10:41.850818Z","steps":["trace[282949967] 'read index received' (duration: 244.572098ms)","trace[282949967] 'applied index is now lower than readState.Index' (duration: 140.267561ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:41.851072Z","caller":"traceutil/trace.go:171","msg":"trace[1305753970] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"387.089824ms","start":"2026-04-04T10:10:41.463969Z","end":"2026-04-04T10:10:41.851059Z","steps":["trace[1305753970] 'process raft request' (duration: 248.543953ms)","trace[1305753970] 'compare' (duration: 137.872801ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:41.851133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:41.463946Z","time spent":"387.153536ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:10:41.85143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.450237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-04-04T10:10:41.85147Z","caller":"traceutil/trace.go:171","msg":"trace[724481591] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:550; }","duration":"385.527099ms","start":"2026-04-04T10:10:41.465932Z","end":"2026-04-04T10:10:41.851459Z","steps":["trace[724481591] 'agreement among raft nodes before linearized reading' (duration: 385.354804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:41.8515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:41.465913Z","time spent":"385.57965ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":65458,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-04-04T10:10:41.878321Z","caller":"traceutil/trace.go:171","msg":"trace[1783425883] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"274.762094ms","start":"2026-04-04T10:10:41.603519Z","end":"2026-04-04T10:10:41.878281Z","steps":["trace[1783425883] 'process raft request' (duration: 274.29117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:41.878475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.670531ms","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-04-04T10:10:41.878565Z","caller":"traceutil/trace.go:171","msg":"trace[353655034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"375.834736ms","start":"2026-04-04T10:10:41.50271Z","end":"2026-04-04T10:10:41.878545Z","steps":["trace[353655034] 'agreement among raft nodes before linearized reading' (duration: 375.578499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:41.878616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:41.502693Z","time spent":"375.91454ms","remote":"127.0.0.1:50808","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":"warn","ts":"2026-04-04T10:10:41.878938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.280244ms","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-04-04T10:10:41.879001Z","caller":"traceutil/trace.go:171","msg":"trace[1242552388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"382.396707ms","start":"2026-04-04T10:10:41.496589Z","end":"2026-04-04T10:10:41.878986Z","steps":["trace[1242552388] 'agreement among raft nodes before linearized reading' (duration: 382.240943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:41.87901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.653697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-04T10:10:41.879034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:41.496565Z","time spent":"382.462809ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-04T10:10:41.879041Z","caller":"traceutil/trace.go:171","msg":"trace[417379531] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:552; }","duration":"370.697147ms","start":"2026-04-04T10:10:41.508335Z","end":"2026-04-04T10:10:41.879032Z","steps":["trace[417379531] 'agreement among raft nodes before linearized reading' (duration: 370.642246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:41.879069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:41.508326Z","time spent":"370.736148ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-04T10:10:41.878951Z","caller":"traceutil/trace.go:171","msg":"trace[2021405544] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"193.402173ms","start":"2026-04-04T10:10:41.685536Z","end":"2026-04-04T10:10:41.878938Z","steps":["trace[2021405544] 'process raft request' (duration: 192.652161ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:47.586629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.789251ms","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-04-04T10:10:47.586727Z","caller":"traceutil/trace.go:171","msg":"trace[173602955] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"193.947615ms","start":"2026-04-04T10:10:47.392757Z","end":"2026-04-04T10:10:47.586705Z","steps":["trace[173602955] 'range keys from in-memory index tree' (duration: 193.569795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:48.026557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.402487ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:48.026653Z","caller":"traceutil/trace.go:171","msg":"trace[160119413] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:595; }","duration":"113.51352ms","start":"2026-04-04T10:10:47.913127Z","end":"2026-04-04T10:10:48.02664Z","steps":["trace[160119413] 'range keys from in-memory index tree' (duration: 113.378596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:48.026943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.816544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-04T10:10:48.02707Z","caller":"traceutil/trace.go:171","msg":"trace[2104844262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"105.952018ms","start":"2026-04-04T10:10:47.921069Z","end":"2026-04-04T10:10:48.027021Z","steps":["trace[2104844262] 'range keys from in-memory index tree' (duration: 105.540995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:48.027168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.352086ms","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-04-04T10:10:48.027204Z","caller":"traceutil/trace.go:171","msg":"trace[939319458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"107.424828ms","start":"2026-04-04T10:10:47.919772Z","end":"2026-04-04T10:10:48.027197Z","steps":["trace[939319458] 'range keys from in-memory index tree' (duration: 107.239033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:48.027525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.509431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-04T10:10:48.027609Z","caller":"traceutil/trace.go:171","msg":"trace[1672231749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"107.609834ms","start":"2026-04-04T10:10:47.919987Z","end":"2026-04-04T10:10:48.027597Z","steps":["trace[1672231749] 'range keys from in-memory index tree' (duration: 107.375707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:49.181802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.187787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:49.181894Z","caller":"traceutil/trace.go:171","msg":"trace[1654407807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"320.332701ms","start":"2026-04-04T10:10:48.861543Z","end":"2026-04-04T10:10:49.181875Z","steps":["trace[1654407807] 'range keys from in-memory index tree' (duration: 320.054733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:49.181935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:10:48.861523Z","time spent":"320.402512ms","remote":"127.0.0.1:50558","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-04-04T10:10:51.020534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.42305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:51.020645Z","caller":"traceutil/trace.go:171","msg":"trace[1893135090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"157.597715ms","start":"2026-04-04T10:10:50.863028Z","end":"2026-04-04T10:10:51.020626Z","steps":["trace[1893135090] 'range keys from in-memory index tree' (duration: 157.331278ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:51.022955Z","caller":"traceutil/trace.go:171","msg":"trace[2058261831] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"117.940405ms","start":"2026-04-04T10:10:50.904993Z","end":"2026-04-04T10:10:51.022933Z","steps":["trace[2058261831] 'process raft request' (duration: 117.819312ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:52.813935Z","caller":"traceutil/trace.go:171","msg":"trace[1937507206] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"158.102949ms","start":"2026-04-04T10:10:52.65581Z","end":"2026-04-04T10:10:52.813913Z","steps":["trace[1937507206] 'process raft request' (duration: 155.859238ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:52.830727Z","caller":"traceutil/trace.go:171","msg":"trace[1026350475] linearizableReadLoop","detail":"{readStateIndex:684; appliedIndex:682; }","duration":"130.853851ms","start":"2026-04-04T10:10:52.699857Z","end":"2026-04-04T10:10:52.830711Z","steps":["trace[1026350475] 'read index received' (duration: 111.829489ms)","trace[1026350475] 'applied index is now lower than readState.Index' (duration: 19.023362ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:52.830858Z","caller":"traceutil/trace.go:171","msg":"trace[1972377047] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"162.336284ms","start":"2026-04-04T10:10:52.668499Z","end":"2026-04-04T10:10:52.830835Z","steps":["trace[1972377047] 'process raft request' (duration: 162.117029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:52.831309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.448658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-04-04T10:10:52.831348Z","caller":"traceutil/trace.go:171","msg":"trace[396481643] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:661; }","duration":"131.54042ms","start":"2026-04-04T10:10:52.699797Z","end":"2026-04-04T10:10:52.831338Z","steps":["trace[396481643] 'agreement among raft nodes before linearized reading' (duration: 130.977745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:53.060611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.030558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-04-04T10:10:53.060767Z","caller":"traceutil/trace.go:171","msg":"trace[1372384705] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:661; }","duration":"159.236194ms","start":"2026-04-04T10:10:52.901505Z","end":"2026-04-04T10:10:53.060741Z","steps":["trace[1372384705] 'range keys from in-memory index tree' (duration: 158.8046ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:10:54.701121Z","caller":"traceutil/trace.go:171","msg":"trace[228893640] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"161.523402ms","start":"2026-04-04T10:10:54.539565Z","end":"2026-04-04T10:10:54.701088Z","steps":["trace[228893640] 'process raft request' (duration: 107.426461ms)","trace[228893640] 'compare' (duration: 53.506204ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:10:54.975386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.679301ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:10:54.975525Z","caller":"traceutil/trace.go:171","msg":"trace[156381519] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"259.217907ms","start":"2026-04-04T10:10:54.716287Z","end":"2026-04-04T10:10:54.975505Z","steps":["trace[156381519] 'process raft request' (duration: 149.283299ms)","trace[156381519] 'compare' (duration: 109.571458ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:55.056904Z","caller":"traceutil/trace.go:171","msg":"trace[1707879516] linearizableReadLoop","detail":"{readStateIndex:703; appliedIndex:701; }","duration":"194.201583ms","start":"2026-04-04T10:10:54.862682Z","end":"2026-04-04T10:10:55.056883Z","steps":["trace[1707879516] 'read index received' (duration: 2.977471ms)","trace[1707879516] 'applied index is now lower than readState.Index' (duration: 191.223362ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:10:55.056997Z","caller":"traceutil/trace.go:171","msg":"trace[1154783328] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"291.128149ms","start":"2026-04-04T10:10:54.765819Z","end":"2026-04-04T10:10:55.056947Z","steps":["trace[1154783328] 'process raft request' (duration: 290.563554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:55.057143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.456849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:10:55.0572Z","caller":"traceutil/trace.go:171","msg":"trace[636736114] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:679; }","duration":"194.576574ms","start":"2026-04-04T10:10:54.862614Z","end":"2026-04-04T10:10:55.057191Z","steps":["trace[636736114] 'agreement among raft nodes before linearized reading' (duration: 194.43096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:55.057347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.225556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-04-04T10:10:55.057392Z","caller":"traceutil/trace.go:171","msg":"trace[445629130] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:679; }","duration":"158.309208ms","start":"2026-04-04T10:10:54.89907Z","end":"2026-04-04T10:10:55.05738Z","steps":["trace[445629130] 'agreement among raft nodes before linearized reading' (duration: 158.060801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:10:55.32809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.529964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-04-04T10:10:55.328188Z","caller":"traceutil/trace.go:171","msg":"trace[452903987] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:681; }","duration":"102.670759ms","start":"2026-04-04T10:10:55.225495Z","end":"2026-04-04T10:10:55.328165Z","steps":["trace[452903987] 'range keys from in-memory index tree' (duration: 102.406091ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:11:02.913327Z","caller":"traceutil/trace.go:171","msg":"trace[2046198920] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"337.225167ms","start":"2026-04-04T10:11:02.576074Z","end":"2026-04-04T10:11:02.9133Z","steps":["trace[2046198920] 'process raft request' (duration: 337.041602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:11:02.913531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:11:02.576047Z","time spent":"337.366901ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:11:06.260291Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969589409706074,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-04T10:11:06.58214Z","caller":"traceutil/trace.go:171","msg":"trace[1279351331] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:779; }","duration":"822.226459ms","start":"2026-04-04T10:11:05.759891Z","end":"2026-04-04T10:11:06.582118Z","steps":["trace[1279351331] 'read index received' (duration: 822.108246ms)","trace[1279351331] 'applied index is now lower than readState.Index' (duration: 117.313µs)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:11:06.582154Z","caller":"traceutil/trace.go:171","msg":"trace[270585213] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"855.079511ms","start":"2026-04-04T10:11:05.727053Z","end":"2026-04-04T10:11:06.582132Z","steps":["trace[270585213] 'process raft request' (duration: 854.909976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:11:06.582788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.881986ms","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-04-04T10:11:06.582866Z","caller":"traceutil/trace.go:171","msg":"trace[808247837] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:753; }","duration":"822.974939ms","start":"2026-04-04T10:11:05.759864Z","end":"2026-04-04T10:11:06.582839Z","steps":["trace[808247837] 'agreement among raft nodes before linearized reading' (duration: 822.343053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:11:06.582925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:11:05.759849Z","time spent":"823.060582ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-04T10:11:06.583063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.162645ms","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-04-04T10:11:06.583158Z","caller":"traceutil/trace.go:171","msg":"trace[1191999774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:753; }","duration":"438.262648ms","start":"2026-04-04T10:11:06.144857Z","end":"2026-04-04T10:11:06.58312Z","steps":["trace[1191999774] 'agreement among raft nodes before linearized reading' (duration: 438.129714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:11:06.583214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:11:06.144829Z","time spent":"438.37104ms","remote":"127.0.0.1:50808","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":"warn","ts":"2026-04-04T10:11:06.583483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.466495ms","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-04-04T10:11:06.583593Z","caller":"traceutil/trace.go:171","msg":"trace[1828291217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:753; }","duration":"440.600388ms","start":"2026-04-04T10:11:06.142955Z","end":"2026-04-04T10:11:06.583555Z","steps":["trace[1828291217] 'agreement among raft nodes before linearized reading' (duration: 440.053624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:11:06.583553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:11:05.727033Z","time spent":"855.213425ms","remote":"127.0.0.1:50732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:11:06.583648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:11:06.142938Z","time spent":"440.699231ms","remote":"127.0.0.1:50808","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-04-04T10:11:06.584055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.524307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-04T10:11:06.584179Z","caller":"traceutil/trace.go:171","msg":"trace[1172346573] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:753; }","duration":"447.69059ms","start":"2026-04-04T10:11:06.136464Z","end":"2026-04-04T10:11:06.584155Z","steps":["trace[1172346573] 'agreement among raft nodes before linearized reading' (duration: 446.48779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:11:06.584253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:11:06.136445Z","time spent":"447.778223ms","remote":"127.0.0.1:50808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-04T10:12:46.177275Z","caller":"traceutil/trace.go:171","msg":"trace[1233551137] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"106.456843ms","start":"2026-04-04T10:12:46.070602Z","end":"2026-04-04T10:12:46.177058Z","steps":["trace[1233551137] 'process raft request' (duration: 106.153527ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:12:46.559219Z","caller":"traceutil/trace.go:171","msg":"trace[121375122] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"158.786336ms","start":"2026-04-04T10:12:46.400394Z","end":"2026-04-04T10:12:46.559181Z","steps":["trace[121375122] 'process raft request' (duration: 94.014468ms)","trace[121375122] 'compare' (duration: 64.614935ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:12:47.409213Z","caller":"traceutil/trace.go:171","msg":"trace[2123726147] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"119.16676ms","start":"2026-04-04T10:12:47.290019Z","end":"2026-04-04T10:12:47.409185Z","steps":["trace[2123726147] 'process raft request' (duration: 105.418809ms)","trace[2123726147] 'compare' (duration: 13.635439ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:12:49.481229Z","caller":"traceutil/trace.go:171","msg":"trace[1260542927] linearizableReadLoop","detail":"{readStateIndex:1311; appliedIndex:1310; }","duration":"187.977623ms","start":"2026-04-04T10:12:49.293226Z","end":"2026-04-04T10:12:49.481203Z","steps":["trace[1260542927] 'read index received' (duration: 185.354779ms)","trace[1260542927] 'applied index is now lower than readState.Index' (duration: 2.621734ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:12:49.48137Z","caller":"traceutil/trace.go:171","msg":"trace[974528044] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"189.610606ms","start":"2026-04-04T10:12:49.291729Z","end":"2026-04-04T10:12:49.48134Z","steps":["trace[974528044] 'process raft request' (duration: 186.84521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:12:49.481474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.232058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-04T10:12:49.481509Z","caller":"traceutil/trace.go:171","msg":"trace[1158516548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1259; }","duration":"188.326899ms","start":"2026-04-04T10:12:49.293173Z","end":"2026-04-04T10:12:49.4815Z","steps":["trace[1158516548] 'agreement among raft nodes before linearized reading' (duration: 188.172916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:12:49.481737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.411668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-04T10:12:49.481805Z","caller":"traceutil/trace.go:171","msg":"trace[1962391902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1259; }","duration":"180.50967ms","start":"2026-04-04T10:12:49.301278Z","end":"2026-04-04T10:12:49.481788Z","steps":["trace[1962391902] 'agreement among raft nodes before linearized reading' (duration: 180.281765ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:13:21.805289Z","caller":"traceutil/trace.go:171","msg":"trace[1414002952] linearizableReadLoop","detail":"{readStateIndex:1439; appliedIndex:1438; }","duration":"109.630893ms","start":"2026-04-04T10:13:21.695635Z","end":"2026-04-04T10:13:21.805266Z","steps":["trace[1414002952] 'read index received' (duration: 109.367368ms)","trace[1414002952] 'applied index is now lower than readState.Index' (duration: 262.275µs)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:13:21.805352Z","caller":"traceutil/trace.go:171","msg":"trace[1756244603] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"121.99293ms","start":"2026-04-04T10:13:21.683331Z","end":"2026-04-04T10:13:21.805323Z","steps":["trace[1756244603] 'process raft request' (duration: 121.750516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:13:21.80548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.822166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-54xf4\" ","response":"range_response_count:1 size:4482"} {"level":"info","ts":"2026-04-04T10:13:21.805727Z","caller":"traceutil/trace.go:171","msg":"trace[298081728] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-54xf4; range_end:; response_count:1; response_revision:1380; }","duration":"110.083733ms","start":"2026-04-04T10:13:21.695608Z","end":"2026-04-04T10:13:21.805692Z","steps":["trace[298081728] 'agreement among raft nodes before linearized reading' (duration: 109.801677ms)"],"step_count":1}