{"level":"warn","ts":"2026-04-09T22:24:10.951173Z","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-09T22:24:10.951294Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-09T22:24:10.951367Z","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-09T22:24:10.951375Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]}
{"level":"info","ts":"2026-04-09T22:24:10.951391Z","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-09T22:24:10.952574Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]}
{"level":"info","ts":"2026-04-09T22:24:10.952668Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-09T22:24:10.958611Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.298742ms"}
{"level":"info","ts":"2026-04-09T22:24:10.970965Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"}
{"level":"info","ts":"2026-04-09T22:24:10.971048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-09T22:24:10.971074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"}
{"level":"info","ts":"2026-04-09T22:24:10.971088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-09T22:24:10.971104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"}
{"level":"info","ts":"2026-04-09T22:24:10.971143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"}
{"level":"warn","ts":"2026-04-09T22:24:10.982107Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-09T22:24:10.98453Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-09T22:24:10.98559Z","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-09T22:24:10.990697Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-09T22:24:10.990831Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-09T22:24:10.991Z","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-09T22:24:10.991061Z","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-09T22:24:10.991072Z","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-09T22:24:10.997283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"}
{"level":"info","ts":"2026-04-09T22:24:10.997579Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]}
{"level":"info","ts":"2026-04-09T22:24:10.999313Z","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-09T22:24:10.999427Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"}
{"level":"info","ts":"2026-04-09T22:24:10.999493Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"}
{"level":"info","ts":"2026-04-09T22:24:10.999545Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-09T22:24:10.999603Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-09T22:24:11.971502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-09T22:24:11.971563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-09T22:24:11.971589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"}
{"level":"info","ts":"2026-04-09T22:24:11.97161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"}
{"level":"info","ts":"2026-04-09T22:24:11.971621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"}
{"level":"info","ts":"2026-04-09T22:24:11.971637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"}
{"level":"info","ts":"2026-04-09T22:24:11.971656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"}
{"level":"info","ts":"2026-04-09T22:24:11.972715Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-09T22:24:11.973581Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-09T22:24:11.973569Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-09T22:24:11.974161Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-09T22:24:11.974174Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-09T22:24:11.974237Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-09T22:24:11.974229Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-09T22:24:11.974374Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-09T22:24:11.974453Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-09T22:24:11.977179Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-09T22:24:11.977527Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"}
{"level":"info","ts":"2026-04-09T22:24:13.450023Z","caller":"traceutil/trace.go:171","msg":"trace[843446357] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"186.301366ms","start":"2026-04-09T22:24:13.263675Z","end":"2026-04-09T22:24:13.449977Z","steps":["trace[843446357] 'process raft request'  (duration: 185.930484ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.450032Z","caller":"traceutil/trace.go:171","msg":"trace[439915053] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"176.339253ms","start":"2026-04-09T22:24:13.273677Z","end":"2026-04-09T22:24:13.450016Z","steps":["trace[439915053] 'process raft request'  (duration: 176.306802ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.450441Z","caller":"traceutil/trace.go:171","msg":"trace[1558584029] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"186.268137ms","start":"2026-04-09T22:24:13.264128Z","end":"2026-04-09T22:24:13.450396Z","steps":["trace[1558584029] 'process raft request'  (duration: 185.700062ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.450123Z","caller":"traceutil/trace.go:171","msg":"trace[420347641] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"186.302176ms","start":"2026-04-09T22:24:13.263808Z","end":"2026-04-09T22:24:13.45011Z","steps":["trace[420347641] 'process raft request'  (duration: 185.915834ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.450205Z","caller":"traceutil/trace.go:171","msg":"trace[1234488307] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"186.227346ms","start":"2026-04-09T22:24:13.26395Z","end":"2026-04-09T22:24:13.450177Z","steps":["trace[1234488307] 'process raft request'  (duration: 185.845173ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.449968Z","caller":"traceutil/trace.go:171","msg":"trace[929357659] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"186.022855ms","start":"2026-04-09T22:24:13.263907Z","end":"2026-04-09T22:24:13.44993Z","steps":["trace[929357659] 'process raft request'  (duration: 185.844734ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.450262Z","caller":"traceutil/trace.go:171","msg":"trace[997868341] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"185.798184ms","start":"2026-04-09T22:24:13.264453Z","end":"2026-04-09T22:24:13.450251Z","steps":["trace[997868341] 'process raft request'  (duration: 185.410061ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.450302Z","caller":"traceutil/trace.go:171","msg":"trace[1764254982] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"178.637331ms","start":"2026-04-09T22:24:13.271648Z","end":"2026-04-09T22:24:13.450285Z","steps":["trace[1764254982] 'process raft request'  (duration: 178.290357ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.450279Z","caller":"traceutil/trace.go:171","msg":"trace[1681437020] transaction","detail":"{read_only:false; number_of_response:0; response_revision:10; }","duration":"185.653903ms","start":"2026-04-09T22:24:13.264612Z","end":"2026-04-09T22:24:13.450266Z","steps":["trace[1681437020] 'process raft request'  (duration: 185.30414ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.451863Z","caller":"traceutil/trace.go:171","msg":"trace[1449317378] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"171.465396ms","start":"2026-04-09T22:24:13.280348Z","end":"2026-04-09T22:24:13.451814Z","steps":["trace[1449317378] 'process raft request'  (duration: 171.068673ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.45197Z","caller":"traceutil/trace.go:171","msg":"trace[1648131403] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:7; }","duration":"167.833789ms","start":"2026-04-09T22:24:13.283678Z","end":"2026-04-09T22:24:13.451512Z","steps":["trace[1648131403] 'read index received'  (duration: 166.009405ms)","trace[1648131403] 'applied index is now lower than readState.Index'  (duration: 1.823494ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:13.452134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.443223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-04-09T22:24:13.452162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.166084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-04-09T22:24:13.452195Z","caller":"traceutil/trace.go:171","msg":"trace[2080789081] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:13; }","duration":"168.554935ms","start":"2026-04-09T22:24:13.283629Z","end":"2026-04-09T22:24:13.452184Z","steps":["trace[2080789081] 'agreement among raft nodes before linearized reading'  (duration: 168.320833ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:13.452218Z","caller":"traceutil/trace.go:171","msg":"trace[1618111840] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"136.240324ms","start":"2026-04-09T22:24:13.315967Z","end":"2026-04-09T22:24:13.452207Z","steps":["trace[1618111840] 'agreement among raft nodes before linearized reading'  (duration: 136.113603ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:13.452452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.24436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-04-09T22:24:13.453242Z","caller":"traceutil/trace.go:171","msg":"trace[1801876289] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"119.009866ms","start":"2026-04-09T22:24:13.334177Z","end":"2026-04-09T22:24:13.453187Z","steps":["trace[1801876289] 'agreement among raft nodes before linearized reading'  (duration: 118.229239ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:13.452516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.140779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-04-09T22:24:13.453456Z","caller":"traceutil/trace.go:171","msg":"trace[1201164783] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"119.140178ms","start":"2026-04-09T22:24:13.334295Z","end":"2026-04-09T22:24:13.453436Z","steps":["trace[1201164783] 'agreement among raft nodes before linearized reading'  (duration: 118.17233ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:13.4525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.26333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-04-09T22:24:13.453499Z","caller":"traceutil/trace.go:171","msg":"trace[145244779] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:13; }","duration":"119.283268ms","start":"2026-04-09T22:24:13.334205Z","end":"2026-04-09T22:24:13.453488Z","steps":["trace[145244779] 'agreement among raft nodes before linearized reading'  (duration: 118.190659ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:15.012791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.856972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-04-09T22:24:15.012888Z","caller":"traceutil/trace.go:171","msg":"trace[206747678] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:194; }","duration":"132.998512ms","start":"2026-04-09T22:24:14.879868Z","end":"2026-04-09T22:24:15.012866Z","steps":["trace[206747678] 'range keys from in-memory index tree'  (duration: 132.73044ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:17.187081Z","caller":"traceutil/trace.go:171","msg":"trace[1195553481] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"169.881539ms","start":"2026-04-09T22:24:17.017171Z","end":"2026-04-09T22:24:17.187052Z","steps":["trace[1195553481] 'process raft request'  (duration: 103.165243ms)","trace[1195553481] 'compare'  (duration: 66.598116ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:24:17.187695Z","caller":"traceutil/trace.go:171","msg":"trace[868198662] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"169.175325ms","start":"2026-04-09T22:24:17.018496Z","end":"2026-04-09T22:24:17.187672Z","steps":["trace[868198662] 'process raft request'  (duration: 168.989034ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:17.18773Z","caller":"traceutil/trace.go:171","msg":"trace[1444802420] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"160.208482ms","start":"2026-04-09T22:24:17.027504Z","end":"2026-04-09T22:24:17.187713Z","steps":["trace[1444802420] 'process raft request'  (duration: 160.079921ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:17.187731Z","caller":"traceutil/trace.go:171","msg":"trace[582404091] linearizableReadLoop","detail":"{readStateIndex:256; appliedIndex:254; }","duration":"168.807363ms","start":"2026-04-09T22:24:17.018903Z","end":"2026-04-09T22:24:17.18771Z","steps":["trace[582404091] 'read index received'  (duration: 101.565942ms)","trace[582404091] 'applied index is now lower than readState.Index'  (duration: 67.240081ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:17.187928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.999494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115"}
{"level":"info","ts":"2026-04-09T22:24:17.188017Z","caller":"traceutil/trace.go:171","msg":"trace[1708626679] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:251; }","duration":"169.091574ms","start":"2026-04-09T22:24:17.018885Z","end":"2026-04-09T22:24:17.187976Z","steps":["trace[1708626679] 'agreement among raft nodes before linearized reading'  (duration: 168.880983ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:18.485752Z","caller":"traceutil/trace.go:171","msg":"trace[656236617] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"158.297383ms","start":"2026-04-09T22:24:18.327429Z","end":"2026-04-09T22:24:18.485727Z","steps":["trace[656236617] 'process raft request'  (duration: 76.88418ms)","trace[656236617] 'compare'  (duration: 81.299252ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:21.964043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.202681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"warn","ts":"2026-04-09T22:24:21.964062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.708182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:21.964128Z","caller":"traceutil/trace.go:171","msg":"trace[1300088590] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:301; }","duration":"736.312462ms","start":"2026-04-09T22:24:21.227791Z","end":"2026-04-09T22:24:21.964103Z","steps":["trace[1300088590] 'range keys from in-memory index tree'  (duration: 736.090641ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:21.964169Z","caller":"traceutil/trace.go:171","msg":"trace[1325806118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:301; }","duration":"589.851553ms","start":"2026-04-09T22:24:21.374293Z","end":"2026-04-09T22:24:21.964144Z","steps":["trace[1325806118] 'range keys from in-memory index tree'  (duration: 589.580812ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:21.96416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:21.227777Z","time spent":"736.376712ms","remote":"127.0.0.1:45542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "}
{"level":"warn","ts":"2026-04-09T22:24:21.964224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:21.374279Z","time spent":"589.932963ms","remote":"127.0.0.1:45316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-09T22:24:21.964319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.001168ms","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-09T22:24:21.964363Z","caller":"traceutil/trace.go:171","msg":"trace[3622218] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:301; }","duration":"837.043078ms","start":"2026-04-09T22:24:21.127313Z","end":"2026-04-09T22:24:21.964356Z","steps":["trace[3622218] 'range keys from in-memory index tree'  (duration: 836.900548ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:21.964382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:21.1273Z","time spent":"837.077008ms","remote":"127.0.0.1:45542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "}
{"level":"warn","ts":"2026-04-09T22:24:21.964455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.810079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"}
{"level":"warn","ts":"2026-04-09T22:24:21.964497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.975577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"}
{"level":"warn","ts":"2026-04-09T22:24:21.964471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.297467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-04-09T22:24:21.964521Z","caller":"traceutil/trace.go:171","msg":"trace[1087673852] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:301; }","duration":"787.034367ms","start":"2026-04-09T22:24:21.177479Z","end":"2026-04-09T22:24:21.964513Z","steps":["trace[1087673852] 'range keys from in-memory index tree'  (duration: 786.874716ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:21.964527Z","caller":"traceutil/trace.go:171","msg":"trace[1868021427] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:301; }","duration":"587.90737ms","start":"2026-04-09T22:24:21.376598Z","end":"2026-04-09T22:24:21.964505Z","steps":["trace[1868021427] 'range keys from in-memory index tree'  (duration: 587.724069ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:21.964544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:21.177461Z","time spent":"787.078167ms","remote":"127.0.0.1:45542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "}
{"level":"info","ts":"2026-04-09T22:24:21.964561Z","caller":"traceutil/trace.go:171","msg":"trace[1674981512] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:301; }","duration":"687.437628ms","start":"2026-04-09T22:24:21.277103Z","end":"2026-04-09T22:24:21.964541Z","steps":["trace[1674981512] 'range keys from in-memory index tree'  (duration: 687.169396ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:21.964583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:21.376584Z","time spent":"587.97521ms","remote":"127.0.0.1:45542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "}
{"level":"warn","ts":"2026-04-09T22:24:21.964612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:21.277088Z","time spent":"687.51402ms","remote":"127.0.0.1:45542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "}
{"level":"warn","ts":"2026-04-09T22:24:21.964512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.148266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-04-09T22:24:21.964755Z","caller":"traceutil/trace.go:171","msg":"trace[1951897900] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:301; }","duration":"637.466618ms","start":"2026-04-09T22:24:21.327275Z","end":"2026-04-09T22:24:21.964741Z","steps":["trace[1951897900] 'range keys from in-memory index tree'  (duration: 637.028636ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:21.964785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:21.32725Z","time spent":"637.526819ms","remote":"127.0.0.1:45542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "}
{"level":"warn","ts":"2026-04-09T22:24:22.514546Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495272139447835,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-09T22:24:23.015393Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495272139447835,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-09T22:24:23.276379Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.26890737s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-09T22:24:23.334839Z","caller":"traceutil/trace.go:171","msg":"trace[1624620066] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"1.327412378s","start":"2026-04-09T22:24:22.00738Z","end":"2026-04-09T22:24:23.334792Z","steps":["trace[1624620066] 'process raft request'  (duration: 1.269214563s)","trace[1624620066] 'compare'  (duration: 57.851642ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:24:23.335594Z","caller":"traceutil/trace.go:171","msg":"trace[2059583929] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:345; }","duration":"1.321968472s","start":"2026-04-09T22:24:22.013595Z","end":"2026-04-09T22:24:23.335564Z","steps":["trace[2059583929] 'read index received'  (duration: 1.263010953s)","trace[2059583929] 'applied index is now lower than readState.Index'  (duration: 58.956599ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:24:23.335756Z","caller":"traceutil/trace.go:171","msg":"trace[1466082724] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"1.325343303s","start":"2026-04-09T22:24:22.010398Z","end":"2026-04-09T22:24:23.335741Z","steps":["trace[1466082724] 'process raft request'  (duration: 1.32479379s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:23.335829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.007352Z","time spent":"1.327719919s","remote":"127.0.0.1:45404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-proxy-hk2vx.18a4d08e2424c587\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-proxy-hk2vx.18a4d08e2424c587\" value_size:607 lease:4082123235284671752 >> failure:<>"}
{"level":"info","ts":"2026-04-09T22:24:23.335977Z","caller":"traceutil/trace.go:171","msg":"trace[959318372] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"1.321155776s","start":"2026-04-09T22:24:22.014782Z","end":"2026-04-09T22:24:23.335938Z","steps":["trace[959318372] 'process raft request'  (duration: 1.320649312s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:23.336052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.01038Z","time spent":"1.325444245s","remote":"127.0.0.1:45404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-7c96b6546b.18a4d08e2481ed06\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-7c96b6546b.18a4d08e2481ed06\" value_size:622 lease:4082123235284671752 >> failure:<>"}
{"level":"info","ts":"2026-04-09T22:24:23.336279Z","caller":"traceutil/trace.go:171","msg":"trace[592738894] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"1.317870255s","start":"2026-04-09T22:24:22.018385Z","end":"2026-04-09T22:24:23.336256Z","steps":["trace[592738894] 'process raft request'  (duration: 1.31710398s)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:23.336383Z","caller":"traceutil/trace.go:171","msg":"trace[1378259205] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"1.317581774s","start":"2026-04-09T22:24:22.01874Z","end":"2026-04-09T22:24:23.336321Z","steps":["trace[1378259205] 'process raft request'  (duration: 1.316790808s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:23.33647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.018374Z","time spent":"1.317995486s","remote":"127.0.0.1:45532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-7c96b6546b-pmgms\" mod_revision:330 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-pmgms\" value_size:3942 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-pmgms\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:23.336587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.280619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-09T22:24:23.336625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081371841s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"warn","ts":"2026-04-09T22:24:23.336638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.018726Z","time spent":"1.317770545s","remote":"127.0.0.1:45532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4451,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-proxy-hk2vx\" mod_revision:327 > success:<request_put:<key:\"/registry/pods/kube-system/kube-proxy-hk2vx\" value_size:4400 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-proxy-hk2vx\" > >"}
{"level":"info","ts":"2026-04-09T22:24:23.336691Z","caller":"traceutil/trace.go:171","msg":"trace[1528859595] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:338; }","duration":"1.081474972s","start":"2026-04-09T22:24:22.25518Z","end":"2026-04-09T22:24:23.336655Z","steps":["trace[1528859595] 'agreement among raft nodes before linearized reading'  (duration: 1.081369571s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:23.336419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085163646s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"}
{"level":"warn","ts":"2026-04-09T22:24:23.336695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.774622ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:23.336745Z","caller":"traceutil/trace.go:171","msg":"trace[1826301528] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"1.323607443s","start":"2026-04-09T22:24:22.013128Z","end":"2026-04-09T22:24:23.336735Z","steps":["trace[1826301528] 'process raft request'  (duration: 1.322263814s)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:23.336756Z","caller":"traceutil/trace.go:171","msg":"trace[749133020] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:338; }","duration":"376.834372ms","start":"2026-04-09T22:24:22.959912Z","end":"2026-04-09T22:24:23.336746Z","steps":["trace[749133020] 'agreement among raft nodes before linearized reading'  (duration: 376.765562ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:23.336761Z","caller":"traceutil/trace.go:171","msg":"trace[524084646] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:338; }","duration":"1.085547528s","start":"2026-04-09T22:24:22.251189Z","end":"2026-04-09T22:24:23.336736Z","steps":["trace[524084646] 'agreement among raft nodes before linearized reading'  (duration: 1.085175186s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:23.336814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.251158Z","time spent":"1.085643399s","remote":"127.0.0.1:45542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":208,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "}
{"level":"info","ts":"2026-04-09T22:24:23.336646Z","caller":"traceutil/trace.go:171","msg":"trace[22394478] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"1.323544843s","start":"2026-04-09T22:24:22.013087Z","end":"2026-04-09T22:24:23.336631Z","steps":["trace[22394478] 'process raft request'  (duration: 1.322251004s)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:23.33666Z","caller":"traceutil/trace.go:171","msg":"trace[481904229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:338; }","duration":"805.40187ms","start":"2026-04-09T22:24:22.531239Z","end":"2026-04-09T22:24:23.336641Z","steps":["trace[481904229] 'agreement among raft nodes before linearized reading'  (duration: 805.285659ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:23.336978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.531213Z","time spent":"805.757382ms","remote":"127.0.0.1:45316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-09T22:24:23.336971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.013066Z","time spent":"1.323846424s","remote":"127.0.0.1:45836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/coredns\" mod_revision:321 > success:<request_put:<key:\"/registry/deployments/kube-system/coredns\" value_size:3953 >> failure:<request_range:<key:\"/registry/deployments/kube-system/coredns\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:23.336738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.255168Z","time spent":"1.081559922s","remote":"127.0.0.1:45610","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-09T22:24:23.336819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.013112Z","time spent":"1.323671974s","remote":"127.0.0.1:45532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-7c96b6546b-rtksc\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-rtksc\" value_size:3468 >> failure:<>"}
{"level":"warn","ts":"2026-04-09T22:24:23.336429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.014773Z","time spent":"1.321295866s","remote":"127.0.0.1:45690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterroles/admin\" mod_revision:326 > success:<request_put:<key:\"/registry/clusterroles/admin\" value_size:3498 >> failure:<request_range:<key:\"/registry/clusterroles/admin\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:23.336296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322686748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"}
{"level":"info","ts":"2026-04-09T22:24:23.33733Z","caller":"traceutil/trace.go:171","msg":"trace[646346085] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:338; }","duration":"1.323734714s","start":"2026-04-09T22:24:22.013552Z","end":"2026-04-09T22:24:23.337287Z","steps":["trace[646346085] 'agreement among raft nodes before linearized reading'  (duration: 1.322619027s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:23.337407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:22.013542Z","time spent":"1.323829044s","remote":"127.0.0.1:45690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":3498,"request content":"key:\"/registry/clusterroles/edit\" "}
{"level":"info","ts":"2026-04-09T22:24:23.534362Z","caller":"traceutil/trace.go:171","msg":"trace[590959187] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"110.510502ms","start":"2026-04-09T22:24:23.423822Z","end":"2026-04-09T22:24:23.534333Z","steps":["trace[590959187] 'process raft request'  (duration: 71.863903ms)","trace[590959187] 'compare'  (duration: 38.431938ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:24:23.534416Z","caller":"traceutil/trace.go:171","msg":"trace[522301298] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"104.066751ms","start":"2026-04-09T22:24:23.430326Z","end":"2026-04-09T22:24:23.534393Z","steps":["trace[522301298] 'process raft request'  (duration: 104.0157ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:23.534807Z","caller":"traceutil/trace.go:171","msg":"trace[951770737] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"106.684837ms","start":"2026-04-09T22:24:23.428099Z","end":"2026-04-09T22:24:23.534784Z","steps":["trace[951770737] 'process raft request'  (duration: 106.175714ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:24.086611Z","caller":"traceutil/trace.go:171","msg":"trace[1682671345] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"101.348015ms","start":"2026-04-09T22:24:23.985236Z","end":"2026-04-09T22:24:24.086584Z","steps":["trace[1682671345] 'process raft request'  (duration: 98.168685ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:24.086661Z","caller":"traceutil/trace.go:171","msg":"trace[1806100736] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"101.252065ms","start":"2026-04-09T22:24:23.985385Z","end":"2026-04-09T22:24:24.086637Z","steps":["trace[1806100736] 'process raft request'  (duration: 101.119914ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:32.321776Z","caller":"traceutil/trace.go:171","msg":"trace[1045419911] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:396; }","duration":"135.381412ms","start":"2026-04-09T22:24:32.186372Z","end":"2026-04-09T22:24:32.321753Z","steps":["trace[1045419911] 'read index received'  (duration: 135.233911ms)","trace[1045419911] 'applied index is now lower than readState.Index'  (duration: 146.661µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:32.321954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.558473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-04-09T22:24:32.321996Z","caller":"traceutil/trace.go:171","msg":"trace[1251597014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:380; }","duration":"135.616103ms","start":"2026-04-09T22:24:32.186369Z","end":"2026-04-09T22:24:32.321985Z","steps":["trace[1251597014] 'agreement among raft nodes before linearized reading'  (duration: 135.478582ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:32.322676Z","caller":"traceutil/trace.go:171","msg":"trace[1037473493] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"144.136132ms","start":"2026-04-09T22:24:32.178526Z","end":"2026-04-09T22:24:32.322662Z","steps":["trace[1037473493] 'process raft request'  (duration: 143.126407ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:36.873005Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495272139448003,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-09T22:24:37.373172Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495272139448003,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-09T22:24:37.704813Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.500157705s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-09T22:24:37.705097Z","caller":"traceutil/trace.go:171","msg":"trace[2002380824] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"1.500519838s","start":"2026-04-09T22:24:36.204557Z","end":"2026-04-09T22:24:37.705077Z","steps":["trace[2002380824] 'process raft request'  (duration: 1.500407657s)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:37.705153Z","caller":"traceutil/trace.go:171","msg":"trace[1134977070] linearizableReadLoop","detail":"{readStateIndex:437; appliedIndex:437; }","duration":"1.33291232s","start":"2026-04-09T22:24:36.372217Z","end":"2026-04-09T22:24:37.705129Z","steps":["trace[1134977070] 'read index received'  (duration: 1.33290168s)","trace[1134977070] 'applied index is now lower than readState.Index'  (duration: 9.02µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:37.705232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:36.204536Z","time spent":"1.500624788s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:414 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:37.705295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.333062611s","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-09T22:24:37.705315Z","caller":"traceutil/trace.go:171","msg":"trace[433929954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"1.333131691s","start":"2026-04-09T22:24:36.372178Z","end":"2026-04-09T22:24:37.70531Z","steps":["trace[433929954] 'agreement among raft nodes before linearized reading'  (duration: 1.3330518s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:37.705336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:36.372162Z","time spent":"1.333170131s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-09T22:24:38.206267Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495272139448006,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-09T22:24:38.484935Z","caller":"traceutil/trace.go:171","msg":"trace[118118229] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"893.403111ms","start":"2026-04-09T22:24:37.591505Z","end":"2026-04-09T22:24:38.484908Z","steps":["trace[118118229] 'process raft request'  (duration: 893.27943ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:38.485096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:37.591479Z","time spent":"893.530251ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:366 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:38.694856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.828354ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495272139448007 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-09T22:24:38.694979Z","caller":"traceutil/trace.go:171","msg":"trace[1211258163] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:437; }","duration":"989.751228ms","start":"2026-04-09T22:24:37.705208Z","end":"2026-04-09T22:24:38.69496Z","steps":["trace[1211258163] 'read index received'  (duration: 779.606267ms)","trace[1211258163] 'applied index is now lower than readState.Index'  (duration: 210.143541ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:38.695096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.314477221s","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-09T22:24:38.695131Z","caller":"traceutil/trace.go:171","msg":"trace[2057366743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:421; }","duration":"2.314527592s","start":"2026-04-09T22:24:36.380594Z","end":"2026-04-09T22:24:38.695121Z","steps":["trace[2057366743] 'agreement among raft nodes before linearized reading'  (duration: 2.314427371s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:38.695167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:36.380588Z","time spent":"2.314569152s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-09T22:24:38.695155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.162567594s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:38.695249Z","caller":"traceutil/trace.go:171","msg":"trace[1212647454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:421; }","duration":"1.162753616s","start":"2026-04-09T22:24:37.53247Z","end":"2026-04-09T22:24:38.695224Z","steps":["trace[1212647454] 'agreement among raft nodes before linearized reading'  (duration: 1.162562185s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:38.695362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195537795s","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-09T22:24:38.695403Z","caller":"traceutil/trace.go:171","msg":"trace[1136078535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:421; }","duration":"1.195613185s","start":"2026-04-09T22:24:37.499781Z","end":"2026-04-09T22:24:38.695394Z","steps":["trace[1136078535] 'agreement among raft nodes before linearized reading'  (duration: 1.195550945s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:38.695432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:37.499759Z","time spent":"1.195666215s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-09T22:24:38.695316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:37.532447Z","time spent":"1.162853466s","remote":"127.0.0.1:45316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-09T22:24:38.695728Z","caller":"traceutil/trace.go:171","msg":"trace[2085562671] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"986.308948ms","start":"2026-04-09T22:24:37.709406Z","end":"2026-04-09T22:24:38.695715Z","steps":["trace[2085562671] 'process raft request'  (duration: 859.3114ms)","trace[2085562671] 'compare'  (duration: 125.490971ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:38.695797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:37.709386Z","time spent":"986.37891ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-09T22:24:43.859008Z","caller":"traceutil/trace.go:171","msg":"trace[1148550436] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:450; }","duration":"102.557662ms","start":"2026-04-09T22:24:43.756423Z","end":"2026-04-09T22:24:43.858981Z","steps":["trace[1148550436] 'read index received'  (duration: 102.366901ms)","trace[1148550436] 'applied index is now lower than readState.Index'  (duration: 189.661µs)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:24:43.859301Z","caller":"traceutil/trace.go:171","msg":"trace[415251528] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"110.594963ms","start":"2026-04-09T22:24:43.748685Z","end":"2026-04-09T22:24:43.85928Z","steps":["trace[415251528] 'process raft request'  (duration: 110.166551ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:43.859594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.134505ms","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-09T22:24:43.85975Z","caller":"traceutil/trace.go:171","msg":"trace[823699508] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:432; }","duration":"103.282815ms","start":"2026-04-09T22:24:43.756393Z","end":"2026-04-09T22:24:43.859676Z","steps":["trace[823699508] 'agreement among raft nodes before linearized reading'  (duration: 102.965664ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:44.3145Z","caller":"traceutil/trace.go:171","msg":"trace[2120473063] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"146.04339ms","start":"2026-04-09T22:24:44.168426Z","end":"2026-04-09T22:24:44.314469Z","steps":["trace[2120473063] 'process raft request'  (duration: 145.665308ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:46.866273Z","caller":"traceutil/trace.go:171","msg":"trace[1581823982] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"121.011062ms","start":"2026-04-09T22:24:46.745231Z","end":"2026-04-09T22:24:46.866242Z","steps":["trace[1581823982] 'process raft request'  (duration: 106.221997ms)","trace[1581823982] 'compare'  (duration: 14.544933ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:24:46.867064Z","caller":"traceutil/trace.go:171","msg":"trace[2058361877] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"118.89403ms","start":"2026-04-09T22:24:46.748101Z","end":"2026-04-09T22:24:46.866995Z","steps":["trace[2058361877] 'process raft request'  (duration: 118.082616ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:46.867835Z","caller":"traceutil/trace.go:171","msg":"trace[1203248937] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"110.77402ms","start":"2026-04-09T22:24:46.757045Z","end":"2026-04-09T22:24:46.867819Z","steps":["trace[1203248937] 'process raft request'  (duration: 110.202517ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:46.86799Z","caller":"traceutil/trace.go:171","msg":"trace[1035209161] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"102.435808ms","start":"2026-04-09T22:24:46.765534Z","end":"2026-04-09T22:24:46.86797Z","steps":["trace[1035209161] 'process raft request'  (duration: 102.222977ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:47.875041Z","caller":"traceutil/trace.go:171","msg":"trace[527457377] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"145.284029ms","start":"2026-04-09T22:24:47.729724Z","end":"2026-04-09T22:24:47.875009Z","steps":["trace[527457377] 'read index received'  (duration: 144.837947ms)","trace[527457377] 'applied index is now lower than readState.Index'  (duration: 444.802µs)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:24:47.875228Z","caller":"traceutil/trace.go:171","msg":"trace[1864897316] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"155.203768ms","start":"2026-04-09T22:24:47.719977Z","end":"2026-04-09T22:24:47.875181Z","steps":["trace[1864897316] 'process raft request'  (duration: 154.525324ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:47.87565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.892482ms","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-09T22:24:47.875751Z","caller":"traceutil/trace.go:171","msg":"trace[1245809406] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:550; }","duration":"146.041193ms","start":"2026-04-09T22:24:47.729686Z","end":"2026-04-09T22:24:47.875727Z","steps":["trace[1245809406] 'agreement among raft nodes before linearized reading'  (duration: 145.62742ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:47.881773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.582265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-04-09T22:24:47.881864Z","caller":"traceutil/trace.go:171","msg":"trace[1008788652] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:551; }","duration":"118.777295ms","start":"2026-04-09T22:24:47.763045Z","end":"2026-04-09T22:24:47.881822Z","steps":["trace[1008788652] 'agreement among raft nodes before linearized reading'  (duration: 118.522964ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:47.881896Z","caller":"traceutil/trace.go:171","msg":"trace[1936920834] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"132.478585ms","start":"2026-04-09T22:24:47.749174Z","end":"2026-04-09T22:24:47.881653Z","steps":["trace[1936920834] 'process raft request'  (duration: 132.201333ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:49.005802Z","caller":"traceutil/trace.go:171","msg":"trace[499431236] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"472.106829ms","start":"2026-04-09T22:24:48.533671Z","end":"2026-04-09T22:24:49.005778Z","steps":["trace[499431236] 'process raft request'  (duration: 471.939748ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:49.00594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:48.533647Z","time spent":"472.217419ms","remote":"127.0.0.1:45372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" value_size:4482 >> failure:<>"}
{"level":"info","ts":"2026-04-09T22:24:49.735491Z","caller":"traceutil/trace.go:171","msg":"trace[389586205] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"1.005311761s","start":"2026-04-09T22:24:48.730161Z","end":"2026-04-09T22:24:49.735473Z","steps":["trace[389586205] 'process raft request'  (duration: 1.005255811s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:49.735598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:48.730138Z","time spent":"1.005413813s","remote":"127.0.0.1:45372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" value_size:3111 >> failure:<>"}
{"level":"info","ts":"2026-04-09T22:24:49.735572Z","caller":"traceutil/trace.go:171","msg":"trace[501575928] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"1.104114834s","start":"2026-04-09T22:24:48.631427Z","end":"2026-04-09T22:24:49.735542Z","steps":["trace[501575928] 'process raft request'  (duration: 1.103826232s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:49.735955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.606528ms","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-09T22:24:49.735974Z","caller":"traceutil/trace.go:171","msg":"trace[1729212668] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"808.498574ms","start":"2026-04-09T22:24:48.927467Z","end":"2026-04-09T22:24:49.735966Z","steps":["trace[1729212668] 'process raft request'  (duration: 807.98563ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:49.736002Z","caller":"traceutil/trace.go:171","msg":"trace[1567605973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"863.700199ms","start":"2026-04-09T22:24:48.872292Z","end":"2026-04-09T22:24:49.735992Z","steps":["trace[1567605973] 'agreement among raft nodes before linearized reading'  (duration: 863.502818ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:49.736035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:48.872271Z","time spent":"863.755979ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-09T22:24:49.736049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:48.927443Z","time spent":"808.557374ms","remote":"127.0.0.1:45372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" value_size:9240 >> failure:<>"}
{"level":"info","ts":"2026-04-09T22:24:49.735758Z","caller":"traceutil/trace.go:171","msg":"trace[233266922] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:594; }","duration":"863.399316ms","start":"2026-04-09T22:24:48.872335Z","end":"2026-04-09T22:24:49.735734Z","steps":["trace[233266922] 'read index received'  (duration: 133.342453ms)","trace[233266922] 'applied index is now lower than readState.Index'  (duration: 730.055373ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:49.736049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:48.631393Z","time spent":"1.104523836s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:420 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-04-09T22:24:49.742725Z","caller":"traceutil/trace.go:171","msg":"trace[1995543346] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"733.091208ms","start":"2026-04-09T22:24:49.009605Z","end":"2026-04-09T22:24:49.742696Z","steps":["trace[1995543346] 'process raft request'  (duration: 732.963478ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:49.742866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:49.009583Z","time spent":"733.210629ms","remote":"127.0.0.1:45372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5562,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" mod_revision:572 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" value_size:5464 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" > >"}
{"level":"info","ts":"2026-04-09T22:24:49.742991Z","caller":"traceutil/trace.go:171","msg":"trace[284283774] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"415.526491ms","start":"2026-04-09T22:24:49.327444Z","end":"2026-04-09T22:24:49.742971Z","steps":["trace[284283774] 'process raft request'  (duration: 415.42258ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:49.74307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:49.327419Z","time spent":"415.611641ms","remote":"127.0.0.1:45372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" value_size:3013 >> failure:<>"}
{"level":"warn","ts":"2026-04-09T22:24:49.743033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.877464ms","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-09T22:24:49.743095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.633869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-09T22:24:49.743166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.389601ms","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-09T22:24:49.743202Z","caller":"traceutil/trace.go:171","msg":"trace[1949844412] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"608.944125ms","start":"2026-04-09T22:24:49.134251Z","end":"2026-04-09T22:24:49.743195Z","steps":["trace[1949844412] 'process raft request'  (duration: 608.415672ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:49.743203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.65944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:49.743215Z","caller":"traceutil/trace.go:171","msg":"trace[111503442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"860.444942ms","start":"2026-04-09T22:24:48.882754Z","end":"2026-04-09T22:24:49.743199Z","steps":["trace[111503442] 'agreement among raft nodes before linearized reading'  (duration: 860.339411ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:49.743235Z","caller":"traceutil/trace.go:171","msg":"trace[1754715674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"212.73535ms","start":"2026-04-09T22:24:49.530491Z","end":"2026-04-09T22:24:49.743226Z","steps":["trace[1754715674] 'agreement among raft nodes before linearized reading'  (duration: 212.684649ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:49.74325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:48.882749Z","time spent":"860.492552ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-09T22:24:49.743289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:49.13423Z","time spent":"609.010086ms","remote":"127.0.0.1:45372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:4142 >> failure:<>"}
{"level":"info","ts":"2026-04-09T22:24:49.743139Z","caller":"traceutil/trace.go:171","msg":"trace[2137728334] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"861.014424ms","start":"2026-04-09T22:24:48.882114Z","end":"2026-04-09T22:24:49.743129Z","steps":["trace[2137728334] 'agreement among raft nodes before linearized reading'  (duration: 860.833363ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:49.743293Z","caller":"traceutil/trace.go:171","msg":"trace[1477066058] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:578; }","duration":"153.77732ms","start":"2026-04-09T22:24:49.589412Z","end":"2026-04-09T22:24:49.743189Z","steps":["trace[1477066058] 'agreement among raft nodes before linearized reading'  (duration: 153.547338ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:49.743383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:48.882101Z","time spent":"861.270875ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-09T22:24:49.743501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.713324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:49.74366Z","caller":"traceutil/trace.go:171","msg":"trace[2010699239] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:578; }","duration":"217.869974ms","start":"2026-04-09T22:24:49.525727Z","end":"2026-04-09T22:24:49.743597Z","steps":["trace[2010699239] 'agreement among raft nodes before linearized reading'  (duration: 217.328752ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:52.923585Z","caller":"traceutil/trace.go:171","msg":"trace[854994471] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"100.575555ms","start":"2026-04-09T22:24:52.822988Z","end":"2026-04-09T22:24:52.923564Z","steps":["trace[854994471] 'read index received'  (duration: 100.457975ms)","trace[854994471] 'applied index is now lower than readState.Index'  (duration: 117.01µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:52.923695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.689427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:52.923659Z","caller":"traceutil/trace.go:171","msg":"trace[637280017] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"122.700261ms","start":"2026-04-09T22:24:52.800914Z","end":"2026-04-09T22:24:52.923614Z","steps":["trace[637280017] 'process raft request'  (duration: 122.527621ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:52.923721Z","caller":"traceutil/trace.go:171","msg":"trace[415330357] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:619; }","duration":"100.755677ms","start":"2026-04-09T22:24:52.822958Z","end":"2026-04-09T22:24:52.923714Z","steps":["trace[415330357] 'agreement among raft nodes before linearized reading'  (duration: 100.699086ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:52.971673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.547237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:52.971837Z","caller":"traceutil/trace.go:171","msg":"trace[2074775757] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:620; }","duration":"148.737438ms","start":"2026-04-09T22:24:52.823078Z","end":"2026-04-09T22:24:52.971816Z","steps":["trace[2074775757] 'agreement among raft nodes before linearized reading'  (duration: 148.511727ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:52.971987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.180916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:52.972081Z","caller":"traceutil/trace.go:171","msg":"trace[1936434212] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:620; }","duration":"121.308087ms","start":"2026-04-09T22:24:52.850754Z","end":"2026-04-09T22:24:52.972062Z","steps":["trace[1936434212] 'agreement among raft nodes before linearized reading'  (duration: 121.105586ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:52.972085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.325531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-09T22:24:52.972084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.551358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:52.972156Z","caller":"traceutil/trace.go:171","msg":"trace[386902678] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:620; }","duration":"120.427361ms","start":"2026-04-09T22:24:52.851711Z","end":"2026-04-09T22:24:52.972138Z","steps":["trace[386902678] 'agreement among raft nodes before linearized reading'  (duration: 120.288821ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:52.972157Z","caller":"traceutil/trace.go:171","msg":"trace[686318067] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:620; }","duration":"121.665458ms","start":"2026-04-09T22:24:52.850478Z","end":"2026-04-09T22:24:52.972144Z","steps":["trace[686318067] 'agreement among raft nodes before linearized reading'  (duration: 121.509528ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:52.972219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.557308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:52.97228Z","caller":"traceutil/trace.go:171","msg":"trace[1191146299] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:620; }","duration":"148.639538ms","start":"2026-04-09T22:24:52.823628Z","end":"2026-04-09T22:24:52.972268Z","steps":["trace[1191146299] 'agreement among raft nodes before linearized reading'  (duration: 148.496567ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:57.798093Z","caller":"traceutil/trace.go:171","msg":"trace[1628896292] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"264.972129ms","start":"2026-04-09T22:24:57.533098Z","end":"2026-04-09T22:24:57.79807Z","steps":["trace[1628896292] 'read index received'  (duration: 264.721757ms)","trace[1628896292] 'applied index is now lower than readState.Index'  (duration: 249.492µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:57.798213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.106179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:57.798242Z","caller":"traceutil/trace.go:171","msg":"trace[871574378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"265.196459ms","start":"2026-04-09T22:24:57.533037Z","end":"2026-04-09T22:24:57.798233Z","steps":["trace[871574378] 'agreement among raft nodes before linearized reading'  (duration: 265.131569ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:57.798422Z","caller":"traceutil/trace.go:171","msg":"trace[1963011326] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"638.199042ms","start":"2026-04-09T22:24:57.160175Z","end":"2026-04-09T22:24:57.798374Z","steps":["trace[1963011326] 'process raft request'  (duration: 637.737209ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:57.798657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:57.160159Z","time spent":"638.392653ms","remote":"127.0.0.1:45532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-jpxr2\" mod_revision:461 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-jpxr2\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-jpxr2\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:58.497171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.208871ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495272139448499 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:640 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-09T22:24:58.497348Z","caller":"traceutil/trace.go:171","msg":"trace[101355403] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:672; }","duration":"390.654414ms","start":"2026-04-09T22:24:58.106676Z","end":"2026-04-09T22:24:58.49733Z","steps":["trace[101355403] 'read index received'  (duration: 82.955765ms)","trace[101355403] 'applied index is now lower than readState.Index'  (duration: 307.697689ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:24:58.497447Z","caller":"traceutil/trace.go:171","msg":"trace[68799856] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"612.537787ms","start":"2026-04-09T22:24:57.884896Z","end":"2026-04-09T22:24:58.497434Z","steps":["trace[68799856] 'process raft request'  (duration: 43.978405ms)","trace[68799856] 'compare'  (duration: 568.08998ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:58.497509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:57.884847Z","time spent":"612.626457ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:640 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:58.497604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.905885ms","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-09T22:24:58.497691Z","caller":"traceutil/trace.go:171","msg":"trace[1143993891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"391.035795ms","start":"2026-04-09T22:24:58.106634Z","end":"2026-04-09T22:24:58.49767Z","steps":["trace[1143993891] 'agreement among raft nodes before linearized reading'  (duration: 390.801954ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:58.497733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:58.106617Z","time spent":"391.108266ms","remote":"127.0.0.1:45610","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-09T22:24:58.49783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.668607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-09T22:24:58.497981Z","caller":"traceutil/trace.go:171","msg":"trace[956322462] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:649; }","duration":"339.856068ms","start":"2026-04-09T22:24:58.158072Z","end":"2026-04-09T22:24:58.497928Z","steps":["trace[956322462] 'agreement among raft nodes before linearized reading'  (duration: 339.569247ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:58.498043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:58.15804Z","time spent":"339.983039ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-09T22:24:58.497986Z","caller":"traceutil/trace.go:171","msg":"trace[777635985] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"612.767268ms","start":"2026-04-09T22:24:57.885167Z","end":"2026-04-09T22:24:58.497934Z","steps":["trace[777635985] 'process raft request'  (duration: 612.113356ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:58.498217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:57.885144Z","time spent":"612.970629ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:639 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:59.756901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.097945247s","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495272139448503 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:641 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-09T22:24:59.756996Z","caller":"traceutil/trace.go:171","msg":"trace[916623798] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.254378797s","start":"2026-04-09T22:24:58.502602Z","end":"2026-04-09T22:24:59.75698Z","steps":["trace[916623798] 'process raft request'  (duration: 156.285242ms)","trace[916623798] 'compare'  (duration: 1.097839392s)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:59.757037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:58.50258Z","time spent":"1.254440329s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:641 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:59.781969Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.123041183s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-09T22:24:59.782499Z","caller":"traceutil/trace.go:171","msg":"trace[1514139025] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:674; }","duration":"1.249334979s","start":"2026-04-09T22:24:58.533121Z","end":"2026-04-09T22:24:59.782456Z","steps":["trace[1514139025] 'read index received'  (duration: 125.78181ms)","trace[1514139025] 'applied index is now lower than readState.Index'  (duration: 1.123551199s)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:24:59.782694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.249540739s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:24:59.782725Z","caller":"traceutil/trace.go:171","msg":"trace[642916070] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"1.279696281s","start":"2026-04-09T22:24:58.502981Z","end":"2026-04-09T22:24:59.782677Z","steps":["trace[642916070] 'process raft request'  (duration: 1.279243278s)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:24:59.782762Z","caller":"traceutil/trace.go:171","msg":"trace[987700041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"1.249661884s","start":"2026-04-09T22:24:58.533079Z","end":"2026-04-09T22:24:59.782741Z","steps":["trace[987700041] 'agreement among raft nodes before linearized reading'  (duration: 1.249507886s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:24:59.782928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:58.502963Z","time spent":"1.279862558s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:642 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-04-09T22:24:59.782981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:58.533059Z","time spent":"1.249901305s","remote":"127.0.0.1:45316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-09T22:25:01.002927Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495272139448508,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-09T22:25:01.50364Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495272139448508,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-09T22:25:01.629197Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.490590018s","expected-duration":"1s"}
{"level":"warn","ts":"2026-04-09T22:25:02.213911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.393558ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13305495272139448510 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:573 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-09T22:25:02.214179Z","caller":"traceutil/trace.go:171","msg":"trace[132610296] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"2.07569118s","start":"2026-04-09T22:25:00.138458Z","end":"2026-04-09T22:25:02.214149Z","steps":["trace[132610296] 'process raft request'  (duration: 1.490942865s)","trace[132610296] 'compare'  (duration: 584.041081ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:25:02.214311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:00.13842Z","time spent":"2.075821017s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:573 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-04-09T22:25:02.232881Z","caller":"traceutil/trace.go:171","msg":"trace[1869764906] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:677; }","duration":"1.730837851s","start":"2026-04-09T22:25:00.50201Z","end":"2026-04-09T22:25:02.232848Z","steps":["trace[1869764906] 'read index received'  (duration: 1.127456068s)","trace[1869764906] 'applied index is now lower than readState.Index'  (duration: 603.379993ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:25:02.233366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.772476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-04-09T22:25:02.233431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.731394117s","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-09T22:25:02.233391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.660965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:25:02.233469Z","caller":"traceutil/trace.go:171","msg":"trace[1193156839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:653; }","duration":"1.731489803s","start":"2026-04-09T22:25:00.501968Z","end":"2026-04-09T22:25:02.233458Z","steps":["trace[1193156839] 'agreement among raft nodes before linearized reading'  (duration: 1.731080093s)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:02.233471Z","caller":"traceutil/trace.go:171","msg":"trace[1326819838] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:653; }","duration":"470.945545ms","start":"2026-04-09T22:25:01.762504Z","end":"2026-04-09T22:25:02.23345Z","steps":["trace[1326819838] 'agreement among raft nodes before linearized reading'  (duration: 470.690953ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:02.233447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.148308536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-09T22:25:02.233505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:00.501949Z","time spent":"1.731548885s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-09T22:25:02.233515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:01.762459Z","time spent":"471.04648ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-09T22:25:02.233509Z","caller":"traceutil/trace.go:171","msg":"trace[1774365076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"700.795122ms","start":"2026-04-09T22:25:01.532687Z","end":"2026-04-09T22:25:02.233482Z","steps":["trace[1774365076] 'agreement among raft nodes before linearized reading'  (duration: 700.582701ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:02.233534Z","caller":"traceutil/trace.go:171","msg":"trace[1419036445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"1.148415431s","start":"2026-04-09T22:25:01.085099Z","end":"2026-04-09T22:25:02.233515Z","steps":["trace[1419036445] 'agreement among raft nodes before linearized reading'  (duration: 1.148232142s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:02.233572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:01.532667Z","time spent":"700.887536ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-09T22:25:02.233581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:01.085047Z","time spent":"1.148523636s","remote":"127.0.0.1:45316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-09T22:25:02.233577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.954088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-04-09T22:25:02.233617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.444217ms","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-09T22:25:02.23367Z","caller":"traceutil/trace.go:171","msg":"trace[543591106] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:653; }","duration":"446.090525ms","start":"2026-04-09T22:25:01.787555Z","end":"2026-04-09T22:25:02.233645Z","steps":["trace[543591106] 'agreement among raft nodes before linearized reading'  (duration: 445.869964ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:02.233707Z","caller":"traceutil/trace.go:171","msg":"trace[732372388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:653; }","duration":"323.590235ms","start":"2026-04-09T22:25:01.910095Z","end":"2026-04-09T22:25:02.233685Z","steps":["trace[732372388] 'agreement among raft nodes before linearized reading'  (duration: 323.305791ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:02.233726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:01.787537Z","time spent":"446.177649ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-09T22:25:02.233756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:01.910073Z","time spent":"323.673779ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-09T22:25:02.234006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.730829789s","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-09T22:25:02.234059Z","caller":"traceutil/trace.go:171","msg":"trace[95868410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:653; }","duration":"1.730921483s","start":"2026-04-09T22:25:00.503126Z","end":"2026-04-09T22:25:02.234047Z","steps":["trace[95868410] 'agreement among raft nodes before linearized reading'  (duration: 1.729931625s)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:02.234089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:00.503116Z","time spent":"1.730964835s","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-09T22:25:06.348457Z","caller":"traceutil/trace.go:171","msg":"trace[2057755614] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"155.681095ms","start":"2026-04-09T22:25:06.192748Z","end":"2026-04-09T22:25:06.348429Z","steps":["trace[2057755614] 'process raft request'  (duration: 155.530878ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:06.46634Z","caller":"traceutil/trace.go:171","msg":"trace[1352389707] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:704; }","duration":"197.183867ms","start":"2026-04-09T22:25:06.269126Z","end":"2026-04-09T22:25:06.46631Z","steps":["trace[1352389707] 'read index received'  (duration: 79.216267ms)","trace[1352389707] 'applied index is now lower than readState.Index'  (duration: 117.96639ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:25:06.46642Z","caller":"traceutil/trace.go:171","msg":"trace[1941271499] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"259.65657ms","start":"2026-04-09T22:25:06.206737Z","end":"2026-04-09T22:25:06.466393Z","steps":["trace[1941271499] 'process raft request'  (duration: 259.413749ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:06.466588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.44811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-09T22:25:06.466622Z","caller":"traceutil/trace.go:171","msg":"trace[223926641] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:679; }","duration":"197.499492ms","start":"2026-04-09T22:25:06.269114Z","end":"2026-04-09T22:25:06.466614Z","steps":["trace[223926641] 'agreement among raft nodes before linearized reading'  (duration: 197.358146ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:06.46665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.739183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"warn","ts":"2026-04-09T22:25:06.466888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.77257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-04-09T22:25:06.466989Z","caller":"traceutil/trace.go:171","msg":"trace[2031132460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:679; }","duration":"189.933838ms","start":"2026-04-09T22:25:06.27704Z","end":"2026-04-09T22:25:06.466974Z","steps":["trace[2031132460] 'agreement among raft nodes before linearized reading'  (duration: 189.700257ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:06.466965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.724961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-04-09T22:25:06.467048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.703949ms","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-09T22:25:06.467099Z","caller":"traceutil/trace.go:171","msg":"trace[359752317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:679; }","duration":"185.882967ms","start":"2026-04-09T22:25:06.281182Z","end":"2026-04-09T22:25:06.467065Z","steps":["trace[359752317] 'agreement among raft nodes before linearized reading'  (duration: 185.486749ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:06.467184Z","caller":"traceutil/trace.go:171","msg":"trace[2000517965] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:679; }","duration":"185.871767ms","start":"2026-04-09T22:25:06.28129Z","end":"2026-04-09T22:25:06.467162Z","steps":["trace[2000517965] 'agreement among raft nodes before linearized reading'  (duration: 185.30298ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:06.466698Z","caller":"traceutil/trace.go:171","msg":"trace[387544211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:679; }","duration":"194.810377ms","start":"2026-04-09T22:25:06.271873Z","end":"2026-04-09T22:25:06.466684Z","steps":["trace[387544211] 'agreement among raft nodes before linearized reading'  (duration: 194.66937ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:07.347018Z","caller":"traceutil/trace.go:171","msg":"trace[545033003] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"131.826661ms","start":"2026-04-09T22:25:07.215166Z","end":"2026-04-09T22:25:07.346993Z","steps":["trace[545033003] 'process raft request'  (duration: 131.670834ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:07.665107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.74669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:25:07.665198Z","caller":"traceutil/trace.go:171","msg":"trace[1861652285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:690; }","duration":"133.896096ms","start":"2026-04-09T22:25:07.531282Z","end":"2026-04-09T22:25:07.665178Z","steps":["trace[1861652285] 'range keys from in-memory index tree'  (duration: 133.670026ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:12.599008Z","caller":"traceutil/trace.go:171","msg":"trace[549881177] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"164.601512ms","start":"2026-04-09T22:25:12.434386Z","end":"2026-04-09T22:25:12.598987Z","steps":["trace[549881177] 'process raft request'  (duration: 164.448285ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:12.667884Z","caller":"traceutil/trace.go:171","msg":"trace[398375197] linearizableReadLoop","detail":"{readStateIndex:744; appliedIndex:742; }","duration":"158.895933ms","start":"2026-04-09T22:25:12.508958Z","end":"2026-04-09T22:25:12.667854Z","steps":["trace[398375197] 'read index received'  (duration: 89.959323ms)","trace[398375197] 'applied index is now lower than readState.Index'  (duration: 68.93536ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:25:12.668259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.660756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:25:12.668314Z","caller":"traceutil/trace.go:171","msg":"trace[1117877470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:715; }","duration":"135.776511ms","start":"2026-04-09T22:25:12.532522Z","end":"2026-04-09T22:25:12.668299Z","steps":["trace[1117877470] 'agreement among raft nodes before linearized reading'  (duration: 135.656436ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:12.668467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.946603ms","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-09T22:25:12.66869Z","caller":"traceutil/trace.go:171","msg":"trace[528330376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:715; }","duration":"155.234586ms","start":"2026-04-09T22:25:12.513433Z","end":"2026-04-09T22:25:12.668667Z","steps":["trace[528330376] 'agreement among raft nodes before linearized reading'  (duration: 154.734004ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:12.668829Z","caller":"traceutil/trace.go:171","msg":"trace[159660623] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"179.037338ms","start":"2026-04-09T22:25:12.489719Z","end":"2026-04-09T22:25:12.668756Z","steps":["trace[159660623] 'process raft request'  (duration: 133.596057ms)","trace[159660623] 'compare'  (duration: 44.403245ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:25:12.668976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.158709ms","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-09T22:25:12.66902Z","caller":"traceutil/trace.go:171","msg":"trace[471793085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:715; }","duration":"154.240982ms","start":"2026-04-09T22:25:12.514767Z","end":"2026-04-09T22:25:12.669008Z","steps":["trace[471793085] 'agreement among raft nodes before linearized reading'  (duration: 154.121226ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:12.668862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.026713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-09T22:25:12.669116Z","caller":"traceutil/trace.go:171","msg":"trace[1146130010] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:715; }","duration":"154.336946ms","start":"2026-04-09T22:25:12.514748Z","end":"2026-04-09T22:25:12.669085Z","steps":["trace[1146130010] 'agreement among raft nodes before linearized reading'  (duration: 153.982041ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:12.669205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.285614ms","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-09T22:25:12.66929Z","caller":"traceutil/trace.go:171","msg":"trace[1191109266] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:715; }","duration":"154.43492ms","start":"2026-04-09T22:25:12.514834Z","end":"2026-04-09T22:25:12.669269Z","steps":["trace[1191109266] 'agreement among raft nodes before linearized reading'  (duration: 154.059044ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:12.669914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.89018ms","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-09T22:25:12.670742Z","caller":"traceutil/trace.go:171","msg":"trace[1120919407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:715; }","duration":"161.903163ms","start":"2026-04-09T22:25:12.508816Z","end":"2026-04-09T22:25:12.670719Z","steps":["trace[1120919407] 'agreement among raft nodes before linearized reading'  (duration: 159.707319ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:18.477153Z","caller":"traceutil/trace.go:171","msg":"trace[558069101] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"215.573946ms","start":"2026-04-09T22:25:18.261553Z","end":"2026-04-09T22:25:18.477127Z","steps":["trace[558069101] 'read index received'  (duration: 215.388498ms)","trace[558069101] 'applied index is now lower than readState.Index'  (duration: 184.318µs)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:25:18.477214Z","caller":"traceutil/trace.go:171","msg":"trace[2113603764] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"535.12732ms","start":"2026-04-09T22:25:17.942052Z","end":"2026-04-09T22:25:18.477179Z","steps":["trace[2113603764] 'process raft request'  (duration: 534.910681ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:25:18.477393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:17.942024Z","time spent":"535.255995ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:725 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4871 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-04-09T22:25:18.478023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.472152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mxfvq\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-04-09T22:25:18.478931Z","caller":"traceutil/trace.go:171","msg":"trace[1707002115] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mxfvq; range_end:; response_count:1; response_revision:767; }","duration":"217.398969ms","start":"2026-04-09T22:25:18.261493Z","end":"2026-04-09T22:25:18.478893Z","steps":["trace[1707002115] 'agreement among raft nodes before linearized reading'  (duration: 215.910069ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:25:41.574006Z","caller":"traceutil/trace.go:171","msg":"trace[383709986] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"155.665683ms","start":"2026-04-09T22:25:41.418287Z","end":"2026-04-09T22:25:41.573952Z","steps":["trace[383709986] 'process raft request'  (duration: 155.497288ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:26:31.370735Z","caller":"traceutil/trace.go:171","msg":"trace[1090750234] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"138.531923ms","start":"2026-04-09T22:26:31.232168Z","end":"2026-04-09T22:26:31.3707Z","steps":["trace[1090750234] 'process raft request'  (duration: 123.935976ms)","trace[1090750234] 'compare'  (duration: 14.333732ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:26:39.540411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.678886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-04-09T22:26:39.540408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.326459ms","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-09T22:26:39.540438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.016594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-09T22:26:39.540479Z","caller":"traceutil/trace.go:171","msg":"trace[2114236572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1163; }","duration":"101.781008ms","start":"2026-04-09T22:26:39.438684Z","end":"2026-04-09T22:26:39.540465Z","steps":["trace[2114236572] 'range keys from in-memory index tree'  (duration: 101.549984ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:26:39.540504Z","caller":"traceutil/trace.go:171","msg":"trace[635210418] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1163; }","duration":"110.458792ms","start":"2026-04-09T22:26:39.430018Z","end":"2026-04-09T22:26:39.540476Z","steps":["trace[635210418] 'range keys from in-memory index tree'  (duration: 110.159656ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:26:39.54051Z","caller":"traceutil/trace.go:171","msg":"trace[701287762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1163; }","duration":"105.139767ms","start":"2026-04-09T22:26:39.435354Z","end":"2026-04-09T22:26:39.540494Z","steps":["trace[701287762] 'range keys from in-memory index tree'  (duration: 104.807731ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:26:40.073977Z","caller":"traceutil/trace.go:171","msg":"trace[1315174798] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"529.196399ms","start":"2026-04-09T22:26:39.544757Z","end":"2026-04-09T22:26:40.073953Z","steps":["trace[1315174798] 'process raft request'  (duration: 529.117458ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:26:40.074141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:26:39.544749Z","time spent":"529.296082ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1159 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-09T22:26:40.074057Z","caller":"traceutil/trace.go:171","msg":"trace[60738906] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"529.919742ms","start":"2026-04-09T22:26:39.544106Z","end":"2026-04-09T22:26:40.074026Z","steps":["trace[60738906] 'process raft request'  (duration: 461.68338ms)","trace[60738906] 'compare'  (duration: 67.968118ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:26:40.074289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:26:39.544081Z","time spent":"530.120797ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1158 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-09T22:26:40.131462Z","caller":"traceutil/trace.go:171","msg":"trace[2137101974] linearizableReadLoop","detail":"{readStateIndex:1214; appliedIndex:1213; }","duration":"124.567725ms","start":"2026-04-09T22:26:40.006872Z","end":"2026-04-09T22:26:40.13144Z","steps":["trace[2137101974] 'read index received'  (duration: 124.526084ms)","trace[2137101974] 'applied index is now lower than readState.Index'  (duration: 40.431µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:26:40.131631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.723467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:26:40.131673Z","caller":"traceutil/trace.go:171","msg":"trace[1337881333] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1167; }","duration":"124.827139ms","start":"2026-04-09T22:26:40.00683Z","end":"2026-04-09T22:26:40.131657Z","steps":["trace[1337881333] 'agreement among raft nodes before linearized reading'  (duration: 124.704067ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:26:40.131649Z","caller":"traceutil/trace.go:171","msg":"trace[2129184312] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"181.69796ms","start":"2026-04-09T22:26:39.949919Z","end":"2026-04-09T22:26:40.131617Z","steps":["trace[2129184312] 'process raft request'  (duration: 181.409405ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:27:10.012471Z","caller":"traceutil/trace.go:171","msg":"trace[1493370979] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"152.095311ms","start":"2026-04-09T22:27:09.860346Z","end":"2026-04-09T22:27:10.012442Z","steps":["trace[1493370979] 'process raft request'  (duration: 151.942999ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:27:10.378618Z","caller":"traceutil/trace.go:171","msg":"trace[94457582] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1353; }","duration":"169.172354ms","start":"2026-04-09T22:27:10.209404Z","end":"2026-04-09T22:27:10.378576Z","steps":["trace[94457582] 'read index received'  (duration: 166.10995ms)","trace[94457582] 'applied index is now lower than readState.Index'  (duration: 3.059274ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:27:10.3788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.380347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-04-09T22:27:10.378845Z","caller":"traceutil/trace.go:171","msg":"trace[1759942610] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1299; }","duration":"169.483959ms","start":"2026-04-09T22:27:10.209351Z","end":"2026-04-09T22:27:10.378835Z","steps":["trace[1759942610] 'agreement among raft nodes before linearized reading'  (duration: 169.313926ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:27:14.132105Z","caller":"traceutil/trace.go:171","msg":"trace[1690436831] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"481.232745ms","start":"2026-04-09T22:27:13.650841Z","end":"2026-04-09T22:27:14.132074Z","steps":["trace[1690436831] 'process raft request'  (duration: 481.017212ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:14.132371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:27:13.650816Z","time spent":"481.459078ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1303 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-09T22:27:14.267493Z","caller":"traceutil/trace.go:171","msg":"trace[232567780] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1365; }","duration":"240.675075ms","start":"2026-04-09T22:27:14.026778Z","end":"2026-04-09T22:27:14.267453Z","steps":["trace[232567780] 'read index received'  (duration: 105.157819ms)","trace[232567780] 'applied index is now lower than readState.Index'  (duration: 135.516026ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:27:14.267497Z","caller":"traceutil/trace.go:171","msg":"trace[1441104030] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"612.257117ms","start":"2026-04-09T22:27:13.655205Z","end":"2026-04-09T22:27:14.267462Z","steps":["trace[1441104030] 'process raft request'  (duration: 606.016628ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:14.267677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.895888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-04-09T22:27:14.267748Z","caller":"traceutil/trace.go:171","msg":"trace[12953913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1312; }","duration":"241.022169ms","start":"2026-04-09T22:27:14.026711Z","end":"2026-04-09T22:27:14.267733Z","steps":["trace[12953913] 'agreement among raft nodes before linearized reading'  (duration: 240.833286ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:14.267806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:27:13.655192Z","time spent":"612.487111ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1304 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-09T22:27:14.267979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.879714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:27:14.268057Z","caller":"traceutil/trace.go:171","msg":"trace[1568158735] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1312; }","duration":"148.986495ms","start":"2026-04-09T22:27:14.119056Z","end":"2026-04-09T22:27:14.268042Z","steps":["trace[1568158735] 'agreement among raft nodes before linearized reading'  (duration: 148.856873ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:14.898862Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305495272139450034,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-09T22:27:14.953464Z","caller":"traceutil/trace.go:171","msg":"trace[983497706] linearizableReadLoop","detail":"{readStateIndex:1369; appliedIndex:1368; }","duration":"554.919024ms","start":"2026-04-09T22:27:14.398521Z","end":"2026-04-09T22:27:14.95344Z","steps":["trace[983497706] 'read index received'  (duration: 515.262406ms)","trace[983497706] 'applied index is now lower than readState.Index'  (duration: 39.655748ms)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:27:14.953547Z","caller":"traceutil/trace.go:171","msg":"trace[1101613307] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"562.702392ms","start":"2026-04-09T22:27:14.390791Z","end":"2026-04-09T22:27:14.953494Z","steps":["trace[1101613307] 'process raft request'  (duration: 523.071846ms)","trace[1101613307] 'compare'  (duration: 39.253881ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:27:14.953643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.113106ms","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-09T22:27:14.953667Z","caller":"traceutil/trace.go:171","msg":"trace[84040704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1314; }","duration":"555.202268ms","start":"2026-04-09T22:27:14.398458Z","end":"2026-04-09T22:27:14.95366Z","steps":["trace[84040704] 'agreement among raft nodes before linearized reading'  (duration: 555.096016ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:14.953712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:27:14.398429Z","time spent":"555.276319ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-09T22:27:14.953758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:27:14.390738Z","time spent":"562.907395ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1306 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-09T22:27:14.954255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.668354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-09T22:27:14.954344Z","caller":"traceutil/trace.go:171","msg":"trace[73355843] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1314; }","duration":"555.802737ms","start":"2026-04-09T22:27:14.398523Z","end":"2026-04-09T22:27:14.954326Z","steps":["trace[73355843] 'agreement among raft nodes before linearized reading'  (duration: 555.052215ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:14.954659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:27:14.3985Z","time spent":"556.145121ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-09T22:27:19.970048Z","caller":"traceutil/trace.go:171","msg":"trace[748803628] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"182.044641ms","start":"2026-04-09T22:27:19.787979Z","end":"2026-04-09T22:27:19.970024Z","steps":["trace[748803628] 'process raft request'  (duration: 181.853258ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:27:21.070512Z","caller":"traceutil/trace.go:171","msg":"trace[1510429073] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"100.466982ms","start":"2026-04-09T22:27:20.970012Z","end":"2026-04-09T22:27:21.070479Z","steps":["trace[1510429073] 'process raft request'  (duration: 100.26724ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:34.707983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.979365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:1059"}
{"level":"info","ts":"2026-04-09T22:27:34.708074Z","caller":"traceutil/trace.go:171","msg":"trace[1658737802] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1384; }","duration":"120.114976ms","start":"2026-04-09T22:27:34.587941Z","end":"2026-04-09T22:27:34.708056Z","steps":["trace[1658737802] 'range keys from in-memory index tree'  (duration: 119.836293ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:34.70818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.03831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" limit:500 ","response":"range_response_count:5 size:1050260"}
{"level":"info","ts":"2026-04-09T22:27:34.70827Z","caller":"traceutil/trace.go:171","msg":"trace[1984356338] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1384; }","duration":"107.165772ms","start":"2026-04-09T22:27:34.601081Z","end":"2026-04-09T22:27:34.708247Z","steps":["trace[1984356338] 'range keys from in-memory index tree'  (duration: 106.666525ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:34.708257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.504246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"}
{"level":"info","ts":"2026-04-09T22:27:34.708341Z","caller":"traceutil/trace.go:171","msg":"trace[140782375] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1384; }","duration":"118.616117ms","start":"2026-04-09T22:27:34.589704Z","end":"2026-04-09T22:27:34.70832Z","steps":["trace[140782375] 'range keys from in-memory index tree'  (duration: 118.401344ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:27:35.372885Z","caller":"traceutil/trace.go:171","msg":"trace[100135807] linearizableReadLoop","detail":"{readStateIndex:1447; appliedIndex:1446; }","duration":"233.685095ms","start":"2026-04-09T22:27:35.139178Z","end":"2026-04-09T22:27:35.372863Z","steps":["trace[100135807] 'read index received'  (duration: 233.499862ms)","trace[100135807] 'applied index is now lower than readState.Index'  (duration: 184.653µs)"],"step_count":2}
{"level":"info","ts":"2026-04-09T22:27:35.372992Z","caller":"traceutil/trace.go:171","msg":"trace[679292724] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"235.028422ms","start":"2026-04-09T22:27:35.13794Z","end":"2026-04-09T22:27:35.372968Z","steps":["trace[679292724] 'process raft request'  (duration: 234.79606ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:35.373124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.925988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-04-09T22:27:35.373154Z","caller":"traceutil/trace.go:171","msg":"trace[308339739] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1386; }","duration":"233.99454ms","start":"2026-04-09T22:27:35.139152Z","end":"2026-04-09T22:27:35.373147Z","steps":["trace[308339739] 'agreement among raft nodes before linearized reading'  (duration: 233.850108ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:35.373167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.754533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-role\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-04-09T22:27:35.373229Z","caller":"traceutil/trace.go:171","msg":"trace[616545139] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-leader-election-role; range_end:; response_count:1; response_revision:1386; }","duration":"209.842413ms","start":"2026-04-09T22:27:35.16337Z","end":"2026-04-09T22:27:35.373213Z","steps":["trace[616545139] 'agreement among raft nodes before linearized reading'  (duration: 209.684842ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:35.373219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.719767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/default\" ","response":"range_response_count:1 size:197"}
{"level":"warn","ts":"2026-04-09T22:27:35.373136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.7154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-04-09T22:27:35.373299Z","caller":"traceutil/trace.go:171","msg":"trace[59973081] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/default; range_end:; response_count:1; response_revision:1386; }","duration":"154.813078ms","start":"2026-04-09T22:27:35.218468Z","end":"2026-04-09T22:27:35.373281Z","steps":["trace[59973081] 'agreement among raft nodes before linearized reading'  (duration: 154.628916ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:35.373344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.373276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-node-lease/\" range_end:\"/registry/configmaps/kube-node-lease0\" limit:500 ","response":"range_response_count:1 size:1754"}
{"level":"info","ts":"2026-04-09T22:27:35.373358Z","caller":"traceutil/trace.go:171","msg":"trace[1983013675] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1386; }","duration":"208.928393ms","start":"2026-04-09T22:27:35.164393Z","end":"2026-04-09T22:27:35.373321Z","steps":["trace[1983013675] 'agreement among raft nodes before linearized reading'  (duration: 208.638069ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:35.373427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.823848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-09T22:27:35.373455Z","caller":"traceutil/trace.go:171","msg":"trace[1439397823] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1386; }","duration":"207.867388ms","start":"2026-04-09T22:27:35.165581Z","end":"2026-04-09T22:27:35.373448Z","steps":["trace[1439397823] 'agreement among raft nodes before linearized reading'  (duration: 207.623455ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:27:35.373415Z","caller":"traceutil/trace.go:171","msg":"trace[1958786002] range","detail":"{range_begin:/registry/configmaps/kube-node-lease/; range_end:/registry/configmaps/kube-node-lease0; response_count:1; response_revision:1386; }","duration":"231.457787ms","start":"2026-04-09T22:27:35.141946Z","end":"2026-04-09T22:27:35.373404Z","steps":["trace[1958786002] 'agreement among raft nodes before linearized reading'  (duration: 231.219274ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-09T22:27:35.37363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.009779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/default/\" range_end:\"/registry/statefulsets/default0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-09T22:27:35.373795Z","caller":"traceutil/trace.go:171","msg":"trace[670037610] range","detail":"{range_begin:/registry/statefulsets/default/; range_end:/registry/statefulsets/default0; response_count:0; response_revision:1386; }","duration":"234.186791ms","start":"2026-04-09T22:27:35.139592Z","end":"2026-04-09T22:27:35.373779Z","steps":["trace[670037610] 'agreement among raft nodes before linearized reading'  (duration: 233.424452ms)"],"step_count":1}
{"level":"info","ts":"2026-04-09T22:27:37.605988Z","caller":"traceutil/trace.go:171","msg":"trace[1676686968] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"141.522624ms","start":"2026-04-09T22:27:37.464436Z","end":"2026-04-09T22:27:37.605959Z","steps":["trace[1676686968] 'process raft request'  (duration: 113.428702ms)","trace[1676686968] 'compare'  (duration: 27.92693ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-09T22:27:37.606074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.364753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:371"}
{"level":"info","ts":"2026-04-09T22:27:37.606157Z","caller":"traceutil/trace.go:171","msg":"trace[982732932] range","detail":"{range_begin:/registry/roles/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:1395; }","duration":"141.464024ms","start":"2026-04-09T22:27:37.464669Z","end":"2026-04-09T22:27:37.606133Z","steps":["trace[982732932] 'agreement among raft nodes before linearized reading'  (duration: 141.323242ms)"],"step_count":1}