{"level":"warn","ts":"2026-02-25T16:58:47.080883Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T16:58:47.081858Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.11: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.19.213.11:2380","--initial-cluster=instance=https://199.19.213.11:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.11:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.11: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-02-25T16:58:47.082057Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T16:58:47.082144Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.11:2380"]}
{"level":"info","ts":"2026-02-25T16:58:47.082213Z","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-02-25T16:58:47.083708Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.11:2379"]}
{"level":"info","ts":"2026-02-25T16:58:47.08396Z","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.19.213.11:2380"],"listen-peer-urls":["https://199.19.213.11:2380"],"advertise-client-urls":["https://199.19.213.11:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.11:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.11: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-02-25T16:58:47.176949Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"65.800011ms"}
{"level":"info","ts":"2026-02-25T16:58:47.191501Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ce8ad90e35537ee3","cluster-id":"3c17b62c6529d987"}
{"level":"info","ts":"2026-02-25T16:58:47.191815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T16:58:47.191934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became follower at term 0"}
{"level":"info","ts":"2026-02-25T16:58:47.192032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ce8ad90e35537ee3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T16:58:47.192122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became follower at term 1"}
{"level":"info","ts":"2026-02-25T16:58:47.192296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 switched to configuration voters=(14882946573646659299)"}
{"level":"warn","ts":"2026-02-25T16:58:47.208665Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T16:58:47.21212Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T16:58:47.214753Z","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-02-25T16:58:47.218095Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ce8ad90e35537ee3","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T16:58:47.21835Z","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-02-25T16:58:47.218476Z","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-02-25T16:58:47.218514Z","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-02-25T16:58:47.218832Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ce8ad90e35537ee3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T16:58:47.222393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 switched to configuration voters=(14882946573646659299)"}
{"level":"info","ts":"2026-02-25T16:58:47.222561Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3c17b62c6529d987","local-member-id":"ce8ad90e35537ee3","added-peer-id":"ce8ad90e35537ee3","added-peer-peer-urls":["https://199.19.213.11:2380"]}
{"level":"info","ts":"2026-02-25T16:58:47.230811Z","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-02-25T16:58:47.235938Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ce8ad90e35537ee3","initial-advertise-peer-urls":["https://199.19.213.11:2380"],"listen-peer-urls":["https://199.19.213.11:2380"],"advertise-client-urls":["https://199.19.213.11:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.11:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T16:58:47.236017Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T16:58:47.234194Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.11:2380"}
{"level":"info","ts":"2026-02-25T16:58:47.236101Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.11:2380"}
{"level":"info","ts":"2026-02-25T16:58:48.193158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T16:58:48.193203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T16:58:48.193225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 received MsgPreVoteResp from ce8ad90e35537ee3 at term 1"}
{"level":"info","ts":"2026-02-25T16:58:48.193238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became candidate at term 2"}
{"level":"info","ts":"2026-02-25T16:58:48.193324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 received MsgVoteResp from ce8ad90e35537ee3 at term 2"}
{"level":"info","ts":"2026-02-25T16:58:48.193334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ce8ad90e35537ee3 became leader at term 2"}
{"level":"info","ts":"2026-02-25T16:58:48.193341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ce8ad90e35537ee3 elected leader ce8ad90e35537ee3 at term 2"}
{"level":"info","ts":"2026-02-25T16:58:48.194741Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T16:58:48.196029Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T16:58:48.196066Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T16:58:48.196035Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ce8ad90e35537ee3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.11:2379]}","request-path":"/0/members/ce8ad90e35537ee3/attributes","cluster-id":"3c17b62c6529d987","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T16:58:48.19635Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T16:58:48.196379Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T16:58:48.198356Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T16:58:48.200018Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.11:2379"}
{"level":"info","ts":"2026-02-25T16:58:48.206508Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3c17b62c6529d987","local-member-id":"ce8ad90e35537ee3","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T16:58:48.206753Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T16:58:48.206814Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-02-25T16:58:49.805004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.519947ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9143323835429689465 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:2814 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-25T16:58:49.805199Z","caller":"traceutil/trace.go:171","msg":"trace[937329407] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"247.848009ms","start":"2026-02-25T16:58:49.557313Z","end":"2026-02-25T16:58:49.805161Z","steps":["trace[937329407] 'process raft request'  (duration: 129.842918ms)","trace[937329407] 'compare'  (duration: 117.408727ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:58:49.805373Z","caller":"traceutil/trace.go:171","msg":"trace[1773952422] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"241.638554ms","start":"2026-02-25T16:58:49.56371Z","end":"2026-02-25T16:58:49.805349Z","steps":["trace[1773952422] 'process raft request'  (duration: 241.384562ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.805543Z","caller":"traceutil/trace.go:171","msg":"trace[319883916] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"241.657073ms","start":"2026-02-25T16:58:49.563876Z","end":"2026-02-25T16:58:49.805533Z","steps":["trace[319883916] 'process raft request'  (duration: 241.507832ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.805561Z","caller":"traceutil/trace.go:171","msg":"trace[1457404913] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"229.816616ms","start":"2026-02-25T16:58:49.575691Z","end":"2026-02-25T16:58:49.805508Z","steps":["trace[1457404913] 'process raft request'  (duration: 229.783346ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.80568Z","caller":"traceutil/trace.go:171","msg":"trace[410596513] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"241.933815ms","start":"2026-02-25T16:58:49.563735Z","end":"2026-02-25T16:58:49.805669Z","steps":["trace[410596513] 'process raft request'  (duration: 241.517852ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.805723Z","caller":"traceutil/trace.go:171","msg":"trace[1665250803] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:7; }","duration":"232.847309ms","start":"2026-02-25T16:58:49.572863Z","end":"2026-02-25T16:58:49.805711Z","steps":["trace[1665250803] 'read index received'  (duration: 114.435135ms)","trace[1665250803] 'applied index is now lower than readState.Index'  (duration: 118.410704ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:58:49.805766Z","caller":"traceutil/trace.go:171","msg":"trace[172879977] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"241.959697ms","start":"2026-02-25T16:58:49.563801Z","end":"2026-02-25T16:58:49.805761Z","steps":["trace[172879977] 'process raft request'  (duration: 241.483203ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.805815Z","caller":"traceutil/trace.go:171","msg":"trace[546078277] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"241.106591ms","start":"2026-02-25T16:58:49.564693Z","end":"2026-02-25T16:58:49.8058Z","steps":["trace[546078277] 'process raft request'  (duration: 240.751238ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.805843Z","caller":"traceutil/trace.go:171","msg":"trace[840396061] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"241.983737ms","start":"2026-02-25T16:58:49.563854Z","end":"2026-02-25T16:58:49.805838Z","steps":["trace[840396061] 'process raft request'  (duration: 241.500752ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:49.806013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.791748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-02-25T16:58:49.806045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.951029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.11\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-02-25T16:58:49.806069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.899979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T16:58:49.806071Z","caller":"traceutil/trace.go:171","msg":"trace[871389537] range","detail":"{range_begin:/registry/masterleases/199.19.213.11; range_end:; response_count:0; response_revision:12; }","duration":"245.004709ms","start":"2026-02-25T16:58:49.561059Z","end":"2026-02-25T16:58:49.806063Z","steps":["trace[871389537] 'agreement among raft nodes before linearized reading'  (duration: 244.973359ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.806091Z","caller":"traceutil/trace.go:171","msg":"trace[477094081] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"320.949299ms","start":"2026-02-25T16:58:49.485137Z","end":"2026-02-25T16:58:49.806086Z","steps":["trace[477094081] 'agreement among raft nodes before linearized reading'  (duration: 320.920459ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:49.806115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:58:49.485121Z","time spent":"320.989369ms","remote":"127.0.0.1:45694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-02-25T16:58:49.806207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.543354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T16:58:49.806236Z","caller":"traceutil/trace.go:171","msg":"trace[856857784] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12; }","duration":"271.583294ms","start":"2026-02-25T16:58:49.534645Z","end":"2026-02-25T16:58:49.806228Z","steps":["trace[856857784] 'agreement among raft nodes before linearized reading'  (duration: 271.541904ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:49.806291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.222986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T16:58:49.806318Z","caller":"traceutil/trace.go:171","msg":"trace[1473792220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:12; }","duration":"331.267876ms","start":"2026-02-25T16:58:49.475043Z","end":"2026-02-25T16:58:49.806311Z","steps":["trace[1473792220] 'agreement among raft nodes before linearized reading'  (duration: 331.228316ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:49.806335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:58:49.475028Z","time spent":"331.303496ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T16:58:49.806346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.57888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T16:58:49.806371Z","caller":"traceutil/trace.go:171","msg":"trace[1402939924] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"273.62249ms","start":"2026-02-25T16:58:49.532742Z","end":"2026-02-25T16:58:49.806364Z","steps":["trace[1402939924] 'agreement among raft nodes before linearized reading'  (duration: 273.58072ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:49.806416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.521349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T16:58:49.80644Z","caller":"traceutil/trace.go:171","msg":"trace[1809772581] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"178.585089ms","start":"2026-02-25T16:58:49.627849Z","end":"2026-02-25T16:58:49.806434Z","steps":["trace[1809772581] 'agreement among raft nodes before linearized reading'  (duration: 178.553629ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.806045Z","caller":"traceutil/trace.go:171","msg":"trace[975537734] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"221.895949ms","start":"2026-02-25T16:58:49.584141Z","end":"2026-02-25T16:58:49.806037Z","steps":["trace[975537734] 'agreement among raft nodes before linearized reading'  (duration: 221.812738ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:49.806015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.241732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T16:58:49.806532Z","caller":"traceutil/trace.go:171","msg":"trace[215748600] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"283.796855ms","start":"2026-02-25T16:58:49.522729Z","end":"2026-02-25T16:58:49.806526Z","steps":["trace[215748600] 'agreement among raft nodes before linearized reading'  (duration: 283.222441ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.945445Z","caller":"traceutil/trace.go:171","msg":"trace[1236401765] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"134.307151ms","start":"2026-02-25T16:58:49.811101Z","end":"2026-02-25T16:58:49.945408Z","steps":["trace[1236401765] 'process raft request'  (duration: 124.236757ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.945696Z","caller":"traceutil/trace.go:171","msg":"trace[233435171] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:16; }","duration":"113.061734ms","start":"2026-02-25T16:58:49.832609Z","end":"2026-02-25T16:58:49.945671Z","steps":["trace[233435171] 'read index received'  (duration: 102.727108ms)","trace[233435171] 'applied index is now lower than readState.Index'  (duration: 10.332436ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:58:49.945815Z","caller":"traceutil/trace.go:171","msg":"trace[1636431604] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"129.454606ms","start":"2026-02-25T16:58:49.816351Z","end":"2026-02-25T16:58:49.945805Z","steps":["trace[1636431604] 'process raft request'  (duration: 129.167584ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.945471Z","caller":"traceutil/trace.go:171","msg":"trace[787108353] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"134.089349ms","start":"2026-02-25T16:58:49.811363Z","end":"2026-02-25T16:58:49.945452Z","steps":["trace[787108353] 'process raft request'  (duration: 133.936768ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:49.945892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.55093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T16:58:49.945541Z","caller":"traceutil/trace.go:171","msg":"trace[1410886935] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"133.716426ms","start":"2026-02-25T16:58:49.811791Z","end":"2026-02-25T16:58:49.945507Z","steps":["trace[1410886935] 'process raft request'  (duration: 133.608806ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.945939Z","caller":"traceutil/trace.go:171","msg":"trace[1370177009] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:22; }","duration":"109.63209ms","start":"2026-02-25T16:58:49.836293Z","end":"2026-02-25T16:58:49.945925Z","steps":["trace[1370177009] 'agreement among raft nodes before linearized reading'  (duration: 109.54639ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:49.945992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.237401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3180"}
{"level":"info","ts":"2026-02-25T16:58:49.946094Z","caller":"traceutil/trace.go:171","msg":"trace[453784089] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:22; }","duration":"134.362872ms","start":"2026-02-25T16:58:49.811721Z","end":"2026-02-25T16:58:49.946084Z","steps":["trace[453784089] 'agreement among raft nodes before linearized reading'  (duration: 134.21883ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.945614Z","caller":"traceutil/trace.go:171","msg":"trace[1138666525] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"134.157199ms","start":"2026-02-25T16:58:49.81145Z","end":"2026-02-25T16:58:49.945608Z","steps":["trace[1138666525] 'process raft request'  (duration: 133.906357ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.945599Z","caller":"traceutil/trace.go:171","msg":"trace[1618394289] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"132.85358ms","start":"2026-02-25T16:58:49.812721Z","end":"2026-02-25T16:58:49.945575Z","steps":["trace[1618394289] 'process raft request'  (duration: 132.759229ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.945649Z","caller":"traceutil/trace.go:171","msg":"trace[1233744306] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"133.437744ms","start":"2026-02-25T16:58:49.812199Z","end":"2026-02-25T16:58:49.945637Z","steps":["trace[1233744306] 'process raft request'  (duration: 133.232953ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:49.946411Z","caller":"traceutil/trace.go:171","msg":"trace[1254795104] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"133.899038ms","start":"2026-02-25T16:58:49.812452Z","end":"2026-02-25T16:58:49.946351Z","steps":["trace[1254795104] 'process raft request'  (duration: 133.003431ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:58:50.899191Z","caller":"traceutil/trace.go:171","msg":"trace[637249619] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"121.346831ms","start":"2026-02-25T16:58:50.777793Z","end":"2026-02-25T16:58:50.89914Z","steps":["trace[637249619] 'process raft request'  (duration: 49.743195ms)","trace[637249619] 'compare'  (duration: 71.158793ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:58:51.388309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.192835ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9143323835429689632 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/system:controller:cronjob-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:controller:cronjob-controller\" value_size:755 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-25T16:58:51.388404Z","caller":"traceutil/trace.go:171","msg":"trace[2103557721] transaction","detail":"{read_only:false; response_revision:110; number_of_response:1; }","duration":"147.620936ms","start":"2026-02-25T16:58:51.240766Z","end":"2026-02-25T16:58:51.388387Z","steps":["trace[2103557721] 'process raft request'  (duration: 34.2959ms)","trace[2103557721] 'compare'  (duration: 113.071484ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:58:51.963659Z","caller":"traceutil/trace.go:171","msg":"trace[932989530] transaction","detail":"{read_only:false; response_revision:137; number_of_response:1; }","duration":"133.375984ms","start":"2026-02-25T16:58:51.830257Z","end":"2026-02-25T16:58:51.963633Z","steps":["trace[932989530] 'process raft request'  (duration: 46.754042ms)","trace[932989530] 'compare'  (duration: 86.423541ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:58:53.136499Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143323835429689767,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T16:58:53.574401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.380815ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9143323835429689768 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:ttl-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:ttl-controller\" value_size:646 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T16:58:53.574692Z","caller":"traceutil/trace.go:171","msg":"trace[1033122197] linearizableReadLoop","detail":"{readStateIndex:183; appliedIndex:180; }","duration":"938.8551ms","start":"2026-02-25T16:58:52.635813Z","end":"2026-02-25T16:58:53.574668Z","steps":["trace[1033122197] 'read index received'  (duration: 661.956262ms)","trace[1033122197] 'applied index is now lower than readState.Index'  (duration: 276.897578ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:58:53.574754Z","caller":"traceutil/trace.go:171","msg":"trace[931114638] transaction","detail":"{read_only:false; response_revision:178; number_of_response:1; }","duration":"992.285537ms","start":"2026-02-25T16:58:52.582433Z","end":"2026-02-25T16:58:53.574719Z","steps":["trace[931114638] 'process raft request'  (duration: 992.088536ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:53.574903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:58:52.58241Z","time spent":"992.436448ms","remote":"127.0.0.1:45478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3937,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3889 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T16:58:53.574951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.123522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:58:53.575025Z","caller":"traceutil/trace.go:171","msg":"trace[1866287415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:178; }","duration":"939.232592ms","start":"2026-02-25T16:58:52.635767Z","end":"2026-02-25T16:58:53.574999Z","steps":["trace[1866287415] 'agreement among raft nodes before linearized reading'  (duration: 939.087041ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:53.575075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:58:52.635747Z","time spent":"939.316533ms","remote":"127.0.0.1:45270","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-02-25T16:58:53.575115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.71956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:58:53.575223Z","caller":"traceutil/trace.go:171","msg":"trace[1830867952] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:178; }","duration":"282.967362ms","start":"2026-02-25T16:58:53.292229Z","end":"2026-02-25T16:58:53.575196Z","steps":["trace[1830867952] 'agreement among raft nodes before linearized reading'  (duration: 282.68181ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:53.574804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:58:52.895651Z","time spent":"679.150355ms","remote":"127.0.0.1:45360","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-25T16:58:53.574679Z","caller":"traceutil/trace.go:171","msg":"trace[1981638455] transaction","detail":"{read_only:false; response_revision:177; number_of_response:1; }","duration":"1.196020836s","start":"2026-02-25T16:58:52.378611Z","end":"2026-02-25T16:58:53.574632Z","steps":["trace[1981638455] 'process raft request'  (duration: 919.081667ms)","trace[1981638455] 'compare'  (duration: 275.883532ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:58:53.57692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:58:52.378593Z","time spent":"1.198280023s","remote":"127.0.0.1:45642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:ttl-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:ttl-controller\" value_size:646 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T16:58:55.036248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.356885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:58:55.036401Z","caller":"traceutil/trace.go:171","msg":"trace[644355572] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:0; response_revision:277; }","duration":"169.566456ms","start":"2026-02-25T16:58:54.866812Z","end":"2026-02-25T16:58:55.036379Z","steps":["trace[644355572] 'range keys from in-memory index tree'  (duration: 169.200504ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:58.750822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.606899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"}
{"level":"info","ts":"2026-02-25T16:58:58.750942Z","caller":"traceutil/trace.go:171","msg":"trace[492915597] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:346; }","duration":"184.792221ms","start":"2026-02-25T16:58:58.566125Z","end":"2026-02-25T16:58:58.750917Z","steps":["trace[492915597] 'range keys from in-memory index tree'  (duration: 184.431399ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:58:58.750938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.464244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-02-25T16:58:58.751029Z","caller":"traceutil/trace.go:171","msg":"trace[749468179] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:346; }","duration":"135.610315ms","start":"2026-02-25T16:58:58.615398Z","end":"2026-02-25T16:58:58.751009Z","steps":["trace[749468179] 'range keys from in-memory index tree'  (duration: 135.371614ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:59:10.438193Z","caller":"traceutil/trace.go:171","msg":"trace[341463545] linearizableReadLoop","detail":"{readStateIndex:470; appliedIndex:469; }","duration":"320.197009ms","start":"2026-02-25T16:59:10.117944Z","end":"2026-02-25T16:59:10.438141Z","steps":["trace[341463545] 'read index received'  (duration: 319.662396ms)","trace[341463545] 'applied index is now lower than readState.Index'  (duration: 532.422µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:59:10.438448Z","caller":"traceutil/trace.go:171","msg":"trace[1810448876] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"323.835666ms","start":"2026-02-25T16:59:10.114591Z","end":"2026-02-25T16:59:10.438426Z","steps":["trace[1810448876] 'process raft request'  (duration: 323.168919ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:10.438529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.862124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:59:10.438638Z","caller":"traceutil/trace.go:171","msg":"trace[1245280302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:455; }","duration":"293.997709ms","start":"2026-02-25T16:59:10.144606Z","end":"2026-02-25T16:59:10.438603Z","steps":["trace[1245280302] 'agreement among raft nodes before linearized reading'  (duration: 293.834893ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:10.438954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.000661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-02-25T16:59:10.439007Z","caller":"traceutil/trace.go:171","msg":"trace[1936501852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:455; }","duration":"321.075384ms","start":"2026-02-25T16:59:10.117919Z","end":"2026-02-25T16:59:10.438994Z","steps":["trace[1936501852] 'agreement among raft nodes before linearized reading'  (duration: 320.97864ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:10.438987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:10.114573Z","time spent":"323.923429ms","remote":"127.0.0.1:45540","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:425 > 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-02-25T16:59:10.439109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.301417ms","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-02-25T16:59:10.439151Z","caller":"traceutil/trace.go:171","msg":"trace[2061156101] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:455; }","duration":"186.336478ms","start":"2026-02-25T16:59:10.252802Z","end":"2026-02-25T16:59:10.439138Z","steps":["trace[2061156101] 'agreement among raft nodes before linearized reading'  (duration: 186.276066ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:10.43904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:10.117908Z","time spent":"321.123156ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-25T16:59:10.804477Z","caller":"traceutil/trace.go:171","msg":"trace[470404683] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"241.739108ms","start":"2026-02-25T16:59:10.562721Z","end":"2026-02-25T16:59:10.80446Z","steps":["trace[470404683] 'process raft request'  (duration: 241.714397ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:59:10.80476Z","caller":"traceutil/trace.go:171","msg":"trace[1713239523] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"361.473407ms","start":"2026-02-25T16:59:10.443279Z","end":"2026-02-25T16:59:10.804753Z","steps":["trace[1713239523] 'process raft request'  (duration: 300.547785ms)","trace[1713239523] 'compare'  (duration: 60.498204ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:59:10.804832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:10.443263Z","time spent":"361.516398ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:427 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T16:59:10.804918Z","caller":"traceutil/trace.go:171","msg":"trace[1876811510] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"361.608402ms","start":"2026-02-25T16:59:10.443304Z","end":"2026-02-25T16:59:10.804912Z","steps":["trace[1876811510] 'process raft request'  (duration: 361.106981ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:10.804955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:10.44329Z","time spent":"361.647453ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:453 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T16:59:15.13459Z","caller":"traceutil/trace.go:171","msg":"trace[2056334788] linearizableReadLoop","detail":"{readStateIndex:481; appliedIndex:480; }","duration":"316.787764ms","start":"2026-02-25T16:59:14.817774Z","end":"2026-02-25T16:59:15.134562Z","steps":["trace[2056334788] 'read index received'  (duration: 316.603447ms)","trace[2056334788] 'applied index is now lower than readState.Index'  (duration: 183.647µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:59:15.134652Z","caller":"traceutil/trace.go:171","msg":"trace[180655849] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"667.4104ms","start":"2026-02-25T16:59:14.467208Z","end":"2026-02-25T16:59:15.134618Z","steps":["trace[180655849] 'process raft request'  (duration: 667.216793ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:15.134738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.95344ms","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-02-25T16:59:15.134766Z","caller":"traceutil/trace.go:171","msg":"trace[1728579158] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:465; }","duration":"317.040734ms","start":"2026-02-25T16:59:14.817718Z","end":"2026-02-25T16:59:15.134759Z","steps":["trace[1728579158] 'agreement among raft nodes before linearized reading'  (duration: 316.962941ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:15.134808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:14.817689Z","time spent":"317.112996ms","remote":"127.0.0.1:45540","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-02-25T16:59:15.13481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:14.46719Z","time spent":"667.533005ms","remote":"127.0.0.1:45540","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:460 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T16:59:15.134855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.819017ms","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-02-25T16:59:15.134938Z","caller":"traceutil/trace.go:171","msg":"trace[178646032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:465; }","duration":"315.945012ms","start":"2026-02-25T16:59:14.81897Z","end":"2026-02-25T16:59:15.134915Z","steps":["trace[178646032] 'agreement among raft nodes before linearized reading'  (duration: 315.774525ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:15.134987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:14.818953Z","time spent":"316.025744ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-25T16:59:15.307073Z","caller":"traceutil/trace.go:171","msg":"trace[797897536] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"167.037615ms","start":"2026-02-25T16:59:15.140009Z","end":"2026-02-25T16:59:15.307046Z","steps":["trace[797897536] 'process raft request'  (duration: 166.312057ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:15.307944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.678247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:59:15.308013Z","caller":"traceutil/trace.go:171","msg":"trace[1281914859] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:467; }","duration":"163.793681ms","start":"2026-02-25T16:59:15.144204Z","end":"2026-02-25T16:59:15.307998Z","steps":["trace[1281914859] 'agreement among raft nodes before linearized reading'  (duration: 163.579803ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:59:15.307735Z","caller":"traceutil/trace.go:171","msg":"trace[1416312055] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"167.146099ms","start":"2026-02-25T16:59:15.14057Z","end":"2026-02-25T16:59:15.307716Z","steps":["trace[1416312055] 'process raft request'  (duration: 166.832058ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:59:15.307823Z","caller":"traceutil/trace.go:171","msg":"trace[1307753842] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:481; }","duration":"163.313943ms","start":"2026-02-25T16:59:15.144247Z","end":"2026-02-25T16:59:15.307561Z","steps":["trace[1307753842] 'read index received'  (duration: 161.791694ms)","trace[1307753842] 'applied index is now lower than readState.Index'  (duration: 1.521359ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:59:28.031419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.254267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T16:59:28.031406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.181262ms","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-02-25T16:59:28.03156Z","caller":"traceutil/trace.go:171","msg":"trace[1219950008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:527; }","duration":"254.488345ms","start":"2026-02-25T16:59:27.777035Z","end":"2026-02-25T16:59:28.031523Z","steps":["trace[1219950008] 'range keys from in-memory index tree'  (duration: 254.140044ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:28.031545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.920921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T16:59:28.031675Z","caller":"traceutil/trace.go:171","msg":"trace[1840601291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:527; }","duration":"121.101548ms","start":"2026-02-25T16:59:27.910551Z","end":"2026-02-25T16:59:28.031652Z","steps":["trace[1840601291] 'range keys from in-memory index tree'  (duration: 120.681734ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:28.031775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.013459ms","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-02-25T16:59:28.031917Z","caller":"traceutil/trace.go:171","msg":"trace[830098170] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:527; }","duration":"652.205305ms","start":"2026-02-25T16:59:27.379689Z","end":"2026-02-25T16:59:28.031895Z","steps":["trace[830098170] 'range keys from in-memory index tree'  (duration: 651.688228ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:28.032006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:27.379669Z","time spent":"652.327608ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-25T16:59:28.032091Z","caller":"traceutil/trace.go:171","msg":"trace[560713839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:527; }","duration":"648.387688ms","start":"2026-02-25T16:59:27.383142Z","end":"2026-02-25T16:59:28.03153Z","steps":["trace[560713839] 'range keys from in-memory index tree'  (duration: 648.062558ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:28.032169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:27.383121Z","time spent":"649.027209ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T16:59:28.645869Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143323835429690509,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T16:59:28.757336Z","caller":"traceutil/trace.go:171","msg":"trace[1787419682] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"720.875557ms","start":"2026-02-25T16:59:28.036431Z","end":"2026-02-25T16:59:28.757307Z","steps":["trace[1787419682] 'process raft request'  (duration: 720.65814ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:28.757484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:28.036406Z","time spent":"721.004551ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:490 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T16:59:28.757665Z","caller":"traceutil/trace.go:171","msg":"trace[970300042] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"721.210498ms","start":"2026-02-25T16:59:28.036431Z","end":"2026-02-25T16:59:28.757642Z","steps":["trace[970300042] 'process raft request'  (duration: 720.836455ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:28.757782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:28.036399Z","time spent":"721.327401ms","remote":"127.0.0.1:45540","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:489 > 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-02-25T16:59:28.763863Z","caller":"traceutil/trace.go:171","msg":"trace[541550886] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"727.098541ms","start":"2026-02-25T16:59:28.036748Z","end":"2026-02-25T16:59:28.763847Z","steps":["trace[541550886] 'process raft request'  (duration: 726.963547ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:59:28.763921Z","caller":"traceutil/trace.go:171","msg":"trace[1197768937] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:545; }","duration":"618.300192ms","start":"2026-02-25T16:59:28.145603Z","end":"2026-02-25T16:59:28.763903Z","steps":["trace[1197768937] 'read index received'  (duration: 611.470368ms)","trace[1197768937] 'applied index is now lower than readState.Index'  (duration: 6.828514ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:59:28.763972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:28.036742Z","time spent":"727.178284ms","remote":"127.0.0.1:45540","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:523 > 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-02-25T16:59:28.76402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.421296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:59:28.764079Z","caller":"traceutil/trace.go:171","msg":"trace[1150680621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:531; }","duration":"618.524559ms","start":"2026-02-25T16:59:28.145539Z","end":"2026-02-25T16:59:28.764063Z","steps":["trace[1150680621] 'agreement among raft nodes before linearized reading'  (duration: 618.432637ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:59:28.764112Z","caller":"traceutil/trace.go:171","msg":"trace[1067868583] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"725.358055ms","start":"2026-02-25T16:59:28.038742Z","end":"2026-02-25T16:59:28.7641Z","steps":["trace[1067868583] 'process raft request'  (duration: 725.063115ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:28.764123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:28.145517Z","time spent":"618.594011ms","remote":"127.0.0.1:45254","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-02-25T16:59:28.764171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:28.038704Z","time spent":"725.435047ms","remote":"127.0.0.1:45464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4212,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:420 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4178 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-25T16:59:35.389789Z","caller":"traceutil/trace.go:171","msg":"trace[1624483305] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:587; }","duration":"483.020639ms","start":"2026-02-25T16:59:34.906745Z","end":"2026-02-25T16:59:35.389766Z","steps":["trace[1624483305] 'read index received'  (duration: 5.555221ms)","trace[1624483305] 'applied index is now lower than readState.Index'  (duration: 477.464528ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:59:35.389907Z","caller":"traceutil/trace.go:171","msg":"trace[373542584] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"509.184347ms","start":"2026-02-25T16:59:34.880712Z","end":"2026-02-25T16:59:35.389896Z","steps":["trace[373542584] 'process raft request'  (duration: 508.788564ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:35.390001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:34.88069Z","time spent":"509.247318ms","remote":"127.0.0.1:45540","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:560 > 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-02-25T16:59:35.390182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.956024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:59:35.390219Z","caller":"traceutil/trace.go:171","msg":"trace[2073969907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"245.026986ms","start":"2026-02-25T16:59:35.145182Z","end":"2026-02-25T16:59:35.390209Z","steps":["trace[2073969907] 'agreement among raft nodes before linearized reading'  (duration: 244.975545ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:35.390222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.463003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-25T16:59:35.390285Z","caller":"traceutil/trace.go:171","msg":"trace[1565676653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:570; }","duration":"483.551906ms","start":"2026-02-25T16:59:34.906715Z","end":"2026-02-25T16:59:35.390267Z","steps":["trace[1565676653] 'agreement among raft nodes before linearized reading'  (duration: 483.34804ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:35.390342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:34.906702Z","time spent":"483.628138ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-25T16:59:35.390499Z","caller":"traceutil/trace.go:171","msg":"trace[1855060716] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"505.854764ms","start":"2026-02-25T16:59:34.884635Z","end":"2026-02-25T16:59:35.39049Z","steps":["trace[1855060716] 'process raft request'  (duration: 505.050868ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:35.390556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:34.884616Z","time spent":"505.913695ms","remote":"127.0.0.1:45478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-5vzj2\" mod_revision:521 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-5vzj2\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-5vzj2\" > >"}
{"level":"warn","ts":"2026-02-25T16:59:35.66131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.580291ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9143323835429690600 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:562 > 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-02-25T16:59:35.661494Z","caller":"traceutil/trace.go:171","msg":"trace[104603552] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"267.011007ms","start":"2026-02-25T16:59:35.394465Z","end":"2026-02-25T16:59:35.661476Z","steps":["trace[104603552] 'process raft request'  (duration: 162.168368ms)","trace[104603552] 'compare'  (duration: 104.478108ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:59:35.661635Z","caller":"traceutil/trace.go:171","msg":"trace[479778971] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"267.153682ms","start":"2026-02-25T16:59:35.394462Z","end":"2026-02-25T16:59:35.661616Z","steps":["trace[479778971] 'process raft request'  (duration: 266.932344ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:37.416877Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9143323835429690601,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T16:59:37.591377Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.423989664s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T16:59:37.591856Z","caller":"traceutil/trace.go:171","msg":"trace[2132251886] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"675.082066ms","start":"2026-02-25T16:59:36.916752Z","end":"2026-02-25T16:59:37.591834Z","steps":["trace[2132251886] 'read index received'  (duration: 674.772046ms)","trace[2132251886] 'applied index is now lower than readState.Index'  (duration: 308.59µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:59:37.591955Z","caller":"traceutil/trace.go:171","msg":"trace[2126847253] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"1.424663454s","start":"2026-02-25T16:59:36.167263Z","end":"2026-02-25T16:59:37.591927Z","steps":["trace[2126847253] 'process raft request'  (duration: 1.424452008s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:37.59205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.286481ms","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-02-25T16:59:37.592082Z","caller":"traceutil/trace.go:171","msg":"trace[445805710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"675.370854ms","start":"2026-02-25T16:59:36.916701Z","end":"2026-02-25T16:59:37.592072Z","steps":["trace[445805710] 'agreement among raft nodes before linearized reading'  (duration: 675.24946ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:37.592099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:36.167234Z","time spent":"1.424781178s","remote":"127.0.0.1:45540","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:526 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-25T16:59:37.592111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:36.91666Z","time spent":"675.444226ms","remote":"127.0.0.1:45540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T16:59:37.592139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.258873ms","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-02-25T16:59:37.592183Z","caller":"traceutil/trace.go:171","msg":"trace[968311967] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"198.337256ms","start":"2026-02-25T16:59:37.393833Z","end":"2026-02-25T16:59:37.59217Z","steps":["trace[968311967] 'agreement among raft nodes before linearized reading'  (duration: 198.226322ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:37.592219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.258132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:59:37.592258Z","caller":"traceutil/trace.go:171","msg":"trace[1571701588] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"446.319634ms","start":"2026-02-25T16:59:37.145928Z","end":"2026-02-25T16:59:37.592247Z","steps":["trace[1571701588] 'agreement among raft nodes before linearized reading'  (duration: 446.248012ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:37.592282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:37.145915Z","time spent":"446.362385ms","remote":"127.0.0.1:45270","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-02-25T16:59:39.021759Z","caller":"traceutil/trace.go:171","msg":"trace[1687958190] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"134.213203ms","start":"2026-02-25T16:59:38.887525Z","end":"2026-02-25T16:59:39.021738Z","steps":["trace[1687958190] 'process raft request'  (duration: 120.592304ms)","trace[1687958190] 'compare'  (duration: 13.517476ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T16:59:39.73017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.192122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:59:39.730242Z","caller":"traceutil/trace.go:171","msg":"trace[1565407779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"584.321676ms","start":"2026-02-25T16:59:39.145902Z","end":"2026-02-25T16:59:39.730223Z","steps":["trace[1565407779] 'range keys from in-memory index tree'  (duration: 583.910554ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:39.730279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:39.145849Z","time spent":"584.420538ms","remote":"127.0.0.1:45270","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-02-25T16:59:41.356674Z","caller":"traceutil/trace.go:171","msg":"trace[247869399] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"212.53885ms","start":"2026-02-25T16:59:41.144098Z","end":"2026-02-25T16:59:41.356637Z","steps":["trace[247869399] 'read index received'  (duration: 212.354455ms)","trace[247869399] 'applied index is now lower than readState.Index'  (duration: 183.275µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T16:59:41.356724Z","caller":"traceutil/trace.go:171","msg":"trace[1531863525] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"327.774814ms","start":"2026-02-25T16:59:41.028923Z","end":"2026-02-25T16:59:41.356698Z","steps":["trace[1531863525] 'process raft request'  (duration: 327.519887ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:41.356896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T16:59:41.02889Z","time spent":"327.911028ms","remote":"127.0.0.1:45330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" value_size:8170 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T16:59:41.357043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.930772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:59:41.357083Z","caller":"traceutil/trace.go:171","msg":"trace[1378308611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"213.013775ms","start":"2026-02-25T16:59:41.14406Z","end":"2026-02-25T16:59:41.357073Z","steps":["trace[1378308611] 'agreement among raft nodes before linearized reading'  (duration: 212.790808ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:59:41.358864Z","caller":"traceutil/trace.go:171","msg":"trace[2063103561] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"131.649693ms","start":"2026-02-25T16:59:41.227187Z","end":"2026-02-25T16:59:41.358836Z","steps":["trace[2063103561] 'process raft request'  (duration: 131.534559ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:46.358251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.178379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T16:59:46.358258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.418045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:59:46.358341Z","caller":"traceutil/trace.go:171","msg":"trace[2076122949] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:686; }","duration":"144.309792ms","start":"2026-02-25T16:59:46.214009Z","end":"2026-02-25T16:59:46.358319Z","steps":["trace[2076122949] 'count revisions from in-memory index tree'  (duration: 144.095707ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T16:59:46.358397Z","caller":"traceutil/trace.go:171","msg":"trace[1923915168] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:686; }","duration":"144.62354ms","start":"2026-02-25T16:59:46.213742Z","end":"2026-02-25T16:59:46.358365Z","steps":["trace[1923915168] 'range keys from in-memory index tree'  (duration: 144.298562ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T16:59:46.358551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.737164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T16:59:46.358579Z","caller":"traceutil/trace.go:171","msg":"trace[1848963829] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:686; }","duration":"144.831236ms","start":"2026-02-25T16:59:46.213736Z","end":"2026-02-25T16:59:46.358568Z","steps":["trace[1848963829] 'range keys from in-memory index tree'  (duration: 144.629461ms)"],"step_count":1}