{"level":"warn","ts":"2026-03-25T16:50:34.329071Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-25T16:50:34.329273Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.123: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.123:2380","--initial-cluster=instance=https://199.19.213.123:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.123:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.123: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-03-25T16:50:34.330334Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-25T16:50:34.330353Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.123:2380"]}
{"level":"info","ts":"2026-03-25T16:50:34.330378Z","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-03-25T16:50:34.331181Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"]}
{"level":"info","ts":"2026-03-25T16:50:34.331274Z","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.123:2380"],"listen-peer-urls":["https://199.19.213.123:2380"],"advertise-client-urls":["https://199.19.213.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.123: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-03-25T16:50:34.388802Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"57.271788ms"}
{"level":"info","ts":"2026-03-25T16:50:34.623518Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3e4829a3cabe4fce","cluster-id":"b469cfed817d8605"}
{"level":"info","ts":"2026-03-25T16:50:34.623651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=()"}
{"level":"info","ts":"2026-03-25T16:50:34.623685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became follower at term 0"}
{"level":"info","ts":"2026-03-25T16:50:34.623706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3e4829a3cabe4fce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-25T16:50:34.623719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became follower at term 1"}
{"level":"info","ts":"2026-03-25T16:50:34.623942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=(4487882812132577230)"}
{"level":"warn","ts":"2026-03-25T16:50:34.830399Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-25T16:50:34.832649Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-25T16:50:34.909564Z","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-03-25T16:50:34.94004Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3e4829a3cabe4fce","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-25T16:50:34.943179Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3e4829a3cabe4fce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-25T16:50:34.943283Z","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-03-25T16:50:34.94346Z","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-03-25T16:50:34.94348Z","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-03-25T16:50:34.947191Z","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-03-25T16:50:34.947384Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3e4829a3cabe4fce","initial-advertise-peer-urls":["https://199.19.213.123:2380"],"listen-peer-urls":["https://199.19.213.123:2380"],"advertise-client-urls":["https://199.19.213.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-25T16:50:34.947431Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-25T16:50:34.947409Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.123:2380"}
{"level":"info","ts":"2026-03-25T16:50:34.947789Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.123:2380"}
{"level":"info","ts":"2026-03-25T16:50:34.967183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=(4487882812132577230)"}
{"level":"info","ts":"2026-03-25T16:50:34.967335Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b469cfed817d8605","local-member-id":"3e4829a3cabe4fce","added-peer-id":"3e4829a3cabe4fce","added-peer-peer-urls":["https://199.19.213.123:2380"]}
{"level":"info","ts":"2026-03-25T16:50:35.626032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce is starting a new election at term 1"}
{"level":"info","ts":"2026-03-25T16:50:35.626092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-25T16:50:35.626133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce received MsgPreVoteResp from 3e4829a3cabe4fce at term 1"}
{"level":"info","ts":"2026-03-25T16:50:35.626154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became candidate at term 2"}
{"level":"info","ts":"2026-03-25T16:50:35.626166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce received MsgVoteResp from 3e4829a3cabe4fce at term 2"}
{"level":"info","ts":"2026-03-25T16:50:35.626182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became leader at term 2"}
{"level":"info","ts":"2026-03-25T16:50:35.626196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3e4829a3cabe4fce elected leader 3e4829a3cabe4fce at term 2"}
{"level":"info","ts":"2026-03-25T16:50:35.627235Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3e4829a3cabe4fce","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.123:2379]}","request-path":"/0/members/3e4829a3cabe4fce/attributes","cluster-id":"b469cfed817d8605","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-25T16:50:35.627252Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T16:50:35.627369Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-25T16:50:35.627436Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-25T16:50:35.627636Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-25T16:50:35.627664Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-25T16:50:35.628513Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b469cfed817d8605","local-member-id":"3e4829a3cabe4fce","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T16:50:35.628635Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T16:50:35.628666Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-25T16:50:35.630167Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.123:2379"}
{"level":"info","ts":"2026-03-25T16:50:35.63093Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-03-25T16:50:37.357274Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750706560325255542,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-25T16:50:37.636121Z","caller":"traceutil/trace.go:171","msg":"trace[1600273573] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"781.171031ms","start":"2026-03-25T16:50:36.854898Z","end":"2026-03-25T16:50:37.636069Z","steps":["trace[1600273573] 'process raft request'  (duration: 780.891307ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:37.636767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.854878Z","time spent":"781.457975ms","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:50:38.484835Z","caller":"traceutil/trace.go:171","msg":"trace[1424919865] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.62979877s","start":"2026-03-25T16:50:36.855001Z","end":"2026-03-25T16:50:38.484799Z","steps":["trace[1424919865] 'process raft request'  (duration: 1.629479656s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:38.484993Z","caller":"traceutil/trace.go:171","msg":"trace[1228456563] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:4; }","duration":"1.628221556s","start":"2026-03-25T16:50:36.856745Z","end":"2026-03-25T16:50:38.484966Z","steps":["trace[1228456563] 'read index received'  (duration: 779.082759ms)","trace[1228456563] 'applied index is now lower than readState.Index'  (duration: 849.137017ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:50:38.485108Z","caller":"traceutil/trace.go:171","msg":"trace[87996358] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.629942192s","start":"2026-03-25T16:50:36.855157Z","end":"2026-03-25T16:50:38.485099Z","steps":["trace[87996358] 'process raft request'  (duration: 1.629510105s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:38.485119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.854984Z","time spent":"1.629921952s","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T16:50:38.485203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.855146Z","time spent":"1.629989823s","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:50:38.485332Z","caller":"traceutil/trace.go:171","msg":"trace[1248829100] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.630083134s","start":"2026-03-25T16:50:36.85524Z","end":"2026-03-25T16:50:38.485323Z","steps":["trace[1248829100] 'process raft request'  (duration: 1.629475515s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:38.485377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.855235Z","time spent":"1.630117375s","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:50:38.485627Z","caller":"traceutil/trace.go:171","msg":"trace[481239260] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.630340128s","start":"2026-03-25T16:50:36.855275Z","end":"2026-03-25T16:50:38.485615Z","steps":["trace[481239260] 'process raft request'  (duration: 1.629495575s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:38.485704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.855261Z","time spent":"1.6304102s","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:50:38.485824Z","caller":"traceutil/trace.go:171","msg":"trace[1160613576] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.544593168s","start":"2026-03-25T16:50:36.941222Z","end":"2026-03-25T16:50:38.485815Z","steps":["trace[1160613576] 'process raft request'  (duration: 1.543645203s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:38.485642Z","caller":"traceutil/trace.go:171","msg":"trace[850293290] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.551596315s","start":"2026-03-25T16:50:36.934036Z","end":"2026-03-25T16:50:38.485632Z","steps":["trace[850293290] 'process raft request'  (duration: 1.550801673s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:38.485986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.934024Z","time spent":"1.55193692s","remote":"127.0.0.1:57556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3125 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:50:38.485657Z","caller":"traceutil/trace.go:171","msg":"trace[581090207] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.562521332s","start":"2026-03-25T16:50:36.923117Z","end":"2026-03-25T16:50:38.485639Z","steps":["trace[581090207] 'process raft request'  (duration: 1.561685799s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:38.486254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.923099Z","time spent":"1.563119461s","remote":"127.0.0.1:57836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T16:50:38.48592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.941206Z","time spent":"1.544661899s","remote":"127.0.0.1:57620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-w62g9\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-w62g9\" value_size:795 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T16:50:38.486128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.629345433s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:38.487241Z","caller":"traceutil/trace.go:171","msg":"trace[1948765130] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:9; }","duration":"1.63047915s","start":"2026-03-25T16:50:36.856741Z","end":"2026-03-25T16:50:38.48722Z","steps":["trace[1948765130] 'agreement among raft nodes before linearized reading'  (duration: 1.629211681s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:38.487533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.85672Z","time spent":"1.630786665s","remote":"127.0.0.1:57444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"warn","ts":"2026-03-25T16:50:38.985743Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750706560325255551,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T16:50:39.485966Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750706560325255551,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T16:50:39.922196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000697884s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T16:50:39.922262Z","caller":"traceutil/trace.go:171","msg":"trace[1835323753] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000811186s","start":"2026-03-25T16:50:37.921436Z","end":"2026-03-25T16:50:39.922247Z","steps":["trace[1835323753] 'agreement among raft nodes before linearized reading'  (duration: 2.000718665s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:39.922305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:37.921412Z","time spent":"2.000887027s","remote":"127.0.0.1:57380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 16:50:39 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T16:50:39.986959Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750706560325255551,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T16:50:40.382772Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.898263189s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-25T16:50:40.391621Z","caller":"traceutil/trace.go:171","msg":"trace[1488887986] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"2.75108283s","start":"2026-03-25T16:50:37.640512Z","end":"2026-03-25T16:50:40.391594Z","steps":["trace[1488887986] 'process raft request'  (duration: 2.74248502s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.391747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:37.640484Z","time spent":"2.751205123s","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authorization.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authorization.k8s.io\" value_size:892 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:50:40.398333Z","caller":"traceutil/trace.go:171","msg":"trace[833179182] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"1.908102118s","start":"2026-03-25T16:50:38.490209Z","end":"2026-03-25T16:50:40.398311Z","steps":["trace[833179182] 'process raft request'  (duration: 1.907899125s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.398408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:38.4902Z","time spent":"1.908172319s","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.autoscaling\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.autoscaling\" value_size:874 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:50:40.398369Z","caller":"traceutil/trace.go:171","msg":"trace[1190132384] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.908768708s","start":"2026-03-25T16:50:38.489584Z","end":"2026-03-25T16:50:40.398353Z","steps":["trace[1190132384] 'process raft request'  (duration: 1.908399362s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.398601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:38.489566Z","time spent":"1.90895543s","remote":"127.0.0.1:57836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/node-high\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/node-high\" value_size:649 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:50:40.398631Z","caller":"traceutil/trace.go:171","msg":"trace[1844305798] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"1.907735912s","start":"2026-03-25T16:50:38.490886Z","end":"2026-03-25T16:50:40.398622Z","steps":["trace[1844305798] 'process raft request'  (duration: 1.907364736s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.398676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:38.490876Z","time spent":"1.907774942s","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.batch\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.batch\" value_size:862 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:50:40.398882Z","caller":"traceutil/trace.go:171","msg":"trace[415697900] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"1.908083757s","start":"2026-03-25T16:50:38.490789Z","end":"2026-03-25T16:50:40.398873Z","steps":["trace[415697900] 'process raft request'  (duration: 1.908029197s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:40.398952Z","caller":"traceutil/trace.go:171","msg":"trace[2072414239] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"1.907970315s","start":"2026-03-25T16:50:38.490952Z","end":"2026-03-25T16:50:40.398922Z","steps":["trace[2072414239] 'process raft request'  (duration: 1.907792522s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:40.399034Z","caller":"traceutil/trace.go:171","msg":"trace[1931678444] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"1.905779712s","start":"2026-03-25T16:50:38.493232Z","end":"2026-03-25T16:50:40.399011Z","steps":["trace[1931678444] 'process raft request'  (duration: 1.905606049s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.399058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:38.490942Z","time spent":"1.908067066s","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v2.autoscaling\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v2.autoscaling\" value_size:874 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T16:50:40.399151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:38.493219Z","time spent":"1.905865274s","remote":"127.0.0.1:57912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.certificates.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.certificates.k8s.io\" value_size:890 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T16:50:40.399159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:38.490775Z","time spent":"1.908177749s","remote":"127.0.0.1:57444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/ranges/servicenodeports\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/servicenodeports\" value_size:66 >> failure:<request_range:<key:\"/registry/ranges/servicenodeports\" > >"}
{"level":"info","ts":"2026-03-25T16:50:40.399494Z","caller":"traceutil/trace.go:171","msg":"trace[643258850] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"1.902540033s","start":"2026-03-25T16:50:38.496943Z","end":"2026-03-25T16:50:40.399483Z","steps":["trace[643258850] 'process raft request'  (duration: 1.902412331s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.399558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:38.496926Z","time spent":"1.902592923s","remote":"127.0.0.1:57556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:8 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3445 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-25T16:50:40.39963Z","caller":"traceutil/trace.go:171","msg":"trace[1392379439] linearizableReadLoop","detail":"{readStateIndex:20; appliedIndex:12; }","duration":"1.914552275s","start":"2026-03-25T16:50:38.485069Z","end":"2026-03-25T16:50:40.399621Z","steps":["trace[1392379439] 'read index received'  (duration: 1.897939803s)","trace[1392379439] 'applied index is now lower than readState.Index'  (duration: 16.611692ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:50:40.399859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.578937185s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.399886Z","caller":"traceutil/trace.go:171","msg":"trace[1970609790] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:18; }","duration":"2.579034867s","start":"2026-03-25T16:50:37.820844Z","end":"2026-03-25T16:50:40.399879Z","steps":["trace[1970609790] 'agreement among raft nodes before linearized reading'  (duration: 2.578836844s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.399907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:37.820829Z","time spent":"2.579073177s","remote":"127.0.0.1:57746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.399949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.578830713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.400005Z","caller":"traceutil/trace.go:171","msg":"trace[1212341025] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:18; }","duration":"2.578921635s","start":"2026-03-25T16:50:37.82107Z","end":"2026-03-25T16:50:40.399991Z","steps":["trace[1212341025] 'agreement among raft nodes before linearized reading'  (duration: 2.578603261s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.400039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:37.821061Z","time spent":"2.578968896s","remote":"127.0.0.1:57718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.400169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.478033542s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.123\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.400241Z","caller":"traceutil/trace.go:171","msg":"trace[1049177873] range","detail":"{range_begin:/registry/masterleases/199.19.213.123; range_end:; response_count:0; response_revision:18; }","duration":"3.478146964s","start":"2026-03-25T16:50:36.922082Z","end":"2026-03-25T16:50:40.400229Z","steps":["trace[1049177873] 'agreement among raft nodes before linearized reading'  (duration: 3.478039292s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.400273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.906929709s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-w62g9\" ","response":"range_response_count:1 size:861"}
{"level":"warn","ts":"2026-03-25T16:50:40.400302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.922061Z","time spent":"3.478231045s","remote":"127.0.0.1:57416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.123\" "}
{"level":"info","ts":"2026-03-25T16:50:40.400309Z","caller":"traceutil/trace.go:171","msg":"trace[855827657] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-w62g9; range_end:; response_count:1; response_revision:18; }","duration":"1.90698411s","start":"2026-03-25T16:50:38.493314Z","end":"2026-03-25T16:50:40.400299Z","steps":["trace[855827657] 'agreement among raft nodes before linearized reading'  (duration: 1.906906359s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.400351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:38.493309Z","time spent":"1.907034371s","remote":"127.0.0.1:57620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-w62g9\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.400399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.425902645s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.400431Z","caller":"traceutil/trace.go:171","msg":"trace[784112615] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:18; }","duration":"3.425951866s","start":"2026-03-25T16:50:36.97447Z","end":"2026-03-25T16:50:40.400422Z","steps":["trace[784112615] 'agreement among raft nodes before linearized reading'  (duration: 3.425885695s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.400453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.974463Z","time spent":"3.425986206s","remote":"127.0.0.1:57488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.400477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.537219137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.400504Z","caller":"traceutil/trace.go:171","msg":"trace[1706617875] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:18; }","duration":"3.537245737s","start":"2026-03-25T16:50:36.86325Z","end":"2026-03-25T16:50:40.400495Z","steps":["trace[1706617875] 'agreement among raft nodes before linearized reading'  (duration: 3.537206156s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.40053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.863216Z","time spent":"3.537308967s","remote":"127.0.0.1:57784","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-03-25T16:50:40.400529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.476063141s","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-03-25T16:50:40.400564Z","caller":"traceutil/trace.go:171","msg":"trace[1113699409] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:18; }","duration":"3.476118162s","start":"2026-03-25T16:50:36.924435Z","end":"2026-03-25T16:50:40.400553Z","steps":["trace[1113699409] 'agreement among raft nodes before linearized reading'  (duration: 3.476031991s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.400597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.924419Z","time spent":"3.476171003s","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.400618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.416597514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.400648Z","caller":"traceutil/trace.go:171","msg":"trace[649151562] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:18; }","duration":"3.416648624s","start":"2026-03-25T16:50:36.983991Z","end":"2026-03-25T16:50:40.400639Z","steps":["trace[649151562] 'agreement among raft nodes before linearized reading'  (duration: 3.416553333s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.400671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.983982Z","time spent":"3.416682795s","remote":"127.0.0.1:57488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.400732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.477370551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.400758Z","caller":"traceutil/trace.go:171","msg":"trace[1752109615] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:18; }","duration":"3.477414542s","start":"2026-03-25T16:50:36.923336Z","end":"2026-03-25T16:50:40.40075Z","steps":["trace[1752109615] 'agreement among raft nodes before linearized reading'  (duration: 3.477373701s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.400767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.543807917s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.400805Z","caller":"traceutil/trace.go:171","msg":"trace[856682058] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:18; }","duration":"3.543877768s","start":"2026-03-25T16:50:36.856917Z","end":"2026-03-25T16:50:40.400795Z","steps":["trace[856682058] 'agreement among raft nodes before linearized reading'  (duration: 3.543733865s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.400834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.856899Z","time spent":"3.543928959s","remote":"127.0.0.1:57434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.400945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.209207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.40097Z","caller":"traceutil/trace.go:171","msg":"trace[1430568266] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:18; }","duration":"364.256737ms","start":"2026-03-25T16:50:40.036706Z","end":"2026-03-25T16:50:40.400962Z","steps":["trace[1430568266] 'agreement among raft nodes before linearized reading'  (duration: 364.217106ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:40.036692Z","time spent":"364.301199ms","remote":"127.0.0.1:57488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.401098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033720077s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.401121Z","caller":"traceutil/trace.go:171","msg":"trace[1650950670] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:18; }","duration":"1.033781787s","start":"2026-03-25T16:50:39.367332Z","end":"2026-03-25T16:50:40.401114Z","steps":["trace[1650950670] 'agreement among raft nodes before linearized reading'  (duration: 1.033749127s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.401145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:39.367315Z","time spent":"1.033825149s","remote":"127.0.0.1:57488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.40078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.923329Z","time spent":"3.477445973s","remote":"127.0.0.1:57488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-25T16:50:40.400016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.402773882s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-25T16:50:40.40282Z","caller":"traceutil/trace.go:171","msg":"trace[1540153686] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:18; }","duration":"3.405590165s","start":"2026-03-25T16:50:36.997217Z","end":"2026-03-25T16:50:40.402807Z","steps":["trace[1540153686] 'agreement among raft nodes before linearized reading'  (duration: 3.402783372s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:40.402855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:36.997205Z","time spent":"3.405639006s","remote":"127.0.0.1:57488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-03-25T16:50:42.374328Z","caller":"traceutil/trace.go:171","msg":"trace[520355430] linearizableReadLoop","detail":"{readStateIndex:255; appliedIndex:254; }","duration":"128.007822ms","start":"2026-03-25T16:50:42.246262Z","end":"2026-03-25T16:50:42.37427Z","steps":["trace[520355430] 'read index received'  (duration: 127.735367ms)","trace[520355430] 'applied index is now lower than readState.Index'  (duration: 268.085µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:50:42.374416Z","caller":"traceutil/trace.go:171","msg":"trace[897865376] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"407.069951ms","start":"2026-03-25T16:50:41.967318Z","end":"2026-03-25T16:50:42.374388Z","steps":["trace[897865376] 'process raft request'  (duration: 406.769047ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:42.374479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.205194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:50:42.374517Z","caller":"traceutil/trace.go:171","msg":"trace[234478196] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:249; }","duration":"128.335307ms","start":"2026-03-25T16:50:42.246168Z","end":"2026-03-25T16:50:42.374504Z","steps":["trace[234478196] 'agreement among raft nodes before linearized reading'  (duration: 128.257216ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:42.374563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:50:41.967292Z","time spent":"407.197204ms","remote":"127.0.0.1:57556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:17 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3661 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-25T16:50:44.400418Z","caller":"traceutil/trace.go:171","msg":"trace[503607184] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"112.496591ms","start":"2026-03-25T16:50:44.287887Z","end":"2026-03-25T16:50:44.400383Z","steps":["trace[503607184] 'process raft request'  (duration: 112.301668ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:44.765259Z","caller":"traceutil/trace.go:171","msg":"trace[74789552] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:325; }","duration":"228.520386ms","start":"2026-03-25T16:50:44.536716Z","end":"2026-03-25T16:50:44.765236Z","steps":["trace[74789552] 'read index received'  (duration: 225.694853ms)","trace[74789552] 'applied index is now lower than readState.Index'  (duration: 2.824633ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:50:44.765283Z","caller":"traceutil/trace.go:171","msg":"trace[122019866] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"256.699879ms","start":"2026-03-25T16:50:44.50856Z","end":"2026-03-25T16:50:44.76526Z","steps":["trace[122019866] 'process raft request'  (duration: 253.919357ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:44.765428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.010781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-25T16:50:44.765427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.679518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-25T16:50:44.765471Z","caller":"traceutil/trace.go:171","msg":"trace[907888785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:316; }","duration":"191.099213ms","start":"2026-03-25T16:50:44.574358Z","end":"2026-03-25T16:50:44.765457Z","steps":["trace[907888785] 'agreement among raft nodes before linearized reading'  (duration: 191.009312ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:44.765479Z","caller":"traceutil/trace.go:171","msg":"trace[2089554623] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:316; }","duration":"228.787509ms","start":"2026-03-25T16:50:44.53668Z","end":"2026-03-25T16:50:44.765467Z","steps":["trace[2089554623] 'agreement among raft nodes before linearized reading'  (duration: 228.650827ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:44.765582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.355581ms","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-03-25T16:50:44.765641Z","caller":"traceutil/trace.go:171","msg":"trace[1780060338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:316; }","duration":"190.470174ms","start":"2026-03-25T16:50:44.575157Z","end":"2026-03-25T16:50:44.765627Z","steps":["trace[1780060338] 'agreement among raft nodes before linearized reading'  (duration: 190.323051ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:45.008352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.983408ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325256127 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:267 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:50:45.008541Z","caller":"traceutil/trace.go:171","msg":"trace[1804938199] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"237.361247ms","start":"2026-03-25T16:50:44.771154Z","end":"2026-03-25T16:50:45.008515Z","steps":["trace[1804938199] 'process raft request'  (duration: 111.992213ms)","trace[1804938199] 'compare'  (duration: 124.849046ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:50:45.008565Z","caller":"traceutil/trace.go:171","msg":"trace[1002902923] linearizableReadLoop","detail":"{readStateIndex:330; appliedIndex:327; }","duration":"187.326295ms","start":"2026-03-25T16:50:44.821207Z","end":"2026-03-25T16:50:45.008533Z","steps":["trace[1002902923] 'read index received'  (duration: 61.830439ms)","trace[1002902923] 'applied index is now lower than readState.Index'  (duration: 125.495016ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:50:45.008677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.473137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"}
{"level":"info","ts":"2026-03-25T16:50:45.008725Z","caller":"traceutil/trace.go:171","msg":"trace[1406140683] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:320; }","duration":"187.552249ms","start":"2026-03-25T16:50:44.821157Z","end":"2026-03-25T16:50:45.008709Z","steps":["trace[1406140683] 'agreement among raft nodes before linearized reading'  (duration: 187.447487ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:45.008898Z","caller":"traceutil/trace.go:171","msg":"trace[262465517] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"237.620922ms","start":"2026-03-25T16:50:44.771203Z","end":"2026-03-25T16:50:45.008824Z","steps":["trace[262465517] 'process raft request'  (duration: 237.240716ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:45.008961Z","caller":"traceutil/trace.go:171","msg":"trace[1952042617] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"232.559575ms","start":"2026-03-25T16:50:44.776391Z","end":"2026-03-25T16:50:45.008951Z","steps":["trace[1952042617] 'process raft request'  (duration: 232.100389ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:45.163475Z","caller":"traceutil/trace.go:171","msg":"trace[995512586] linearizableReadLoop","detail":"{readStateIndex:333; appliedIndex:332; }","duration":"103.175078ms","start":"2026-03-25T16:50:45.060254Z","end":"2026-03-25T16:50:45.163429Z","steps":["trace[995512586] 'read index received'  (duration: 80.979174ms)","trace[995512586] 'applied index is now lower than readState.Index'  (duration: 22.193993ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:50:45.163689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.37765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-25T16:50:45.163727Z","caller":"traceutil/trace.go:171","msg":"trace[1566795536] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:323; }","duration":"103.485872ms","start":"2026-03-25T16:50:45.060229Z","end":"2026-03-25T16:50:45.163715Z","steps":["trace[1566795536] 'agreement among raft nodes before linearized reading'  (duration: 103.35039ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:45.164327Z","caller":"traceutil/trace.go:171","msg":"trace[1696978212] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"104.477776ms","start":"2026-03-25T16:50:45.059798Z","end":"2026-03-25T16:50:45.164276Z","steps":["trace[1696978212] 'process raft request'  (duration: 81.361939ms)","trace[1696978212] 'compare'  (duration: 22.030641ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:50:45.496113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.223454ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325256149 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:323 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4253 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:50:45.496232Z","caller":"traceutil/trace.go:171","msg":"trace[135800362] linearizableReadLoop","detail":"{readStateIndex:337; appliedIndex:336; }","duration":"240.167014ms","start":"2026-03-25T16:50:45.256048Z","end":"2026-03-25T16:50:45.496215Z","steps":["trace[135800362] 'read index received'  (duration: 97.754117ms)","trace[135800362] 'applied index is now lower than readState.Index'  (duration: 142.411797ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:50:45.496295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.249735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:50:45.496328Z","caller":"traceutil/trace.go:171","msg":"trace[1117605438] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:0; response_revision:327; }","duration":"240.311565ms","start":"2026-03-25T16:50:45.256001Z","end":"2026-03-25T16:50:45.496312Z","steps":["trace[1117605438] 'agreement among raft nodes before linearized reading'  (duration: 240.260795ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:45.496258Z","caller":"traceutil/trace.go:171","msg":"trace[1577548986] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"275.440343ms","start":"2026-03-25T16:50:45.220789Z","end":"2026-03-25T16:50:45.49623Z","steps":["trace[1577548986] 'process raft request'  (duration: 133.012966ms)","trace[1577548986] 'compare'  (duration: 142.075672ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:50:45.628978Z","caller":"traceutil/trace.go:171","msg":"trace[1842360096] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"126.411607ms","start":"2026-03-25T16:50:45.50254Z","end":"2026-03-25T16:50:45.628952Z","steps":["trace[1842360096] 'process raft request'  (duration: 99.550314ms)","trace[1842360096] 'compare'  (duration: 26.745991ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:50:45.630145Z","caller":"traceutil/trace.go:171","msg":"trace[1478805831] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"124.01022ms","start":"2026-03-25T16:50:45.506116Z","end":"2026-03-25T16:50:45.630127Z","steps":["trace[1478805831] 'process raft request'  (duration: 123.902699ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:51.273743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.539157ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325256311 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:402 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:50:51.274331Z","caller":"traceutil/trace.go:171","msg":"trace[684523307] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"236.953769ms","start":"2026-03-25T16:50:51.037306Z","end":"2026-03-25T16:50:51.27426Z","steps":["trace[684523307] 'process raft request'  (duration: 132.760497ms)","trace[684523307] 'compare'  (duration: 103.186269ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:50:52.317553Z","caller":"traceutil/trace.go:171","msg":"trace[107489953] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"222.806721ms","start":"2026-03-25T16:50:52.094714Z","end":"2026-03-25T16:50:52.31752Z","steps":["trace[107489953] 'process raft request'  (duration: 222.648343ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:52.610375Z","caller":"traceutil/trace.go:171","msg":"trace[1644448400] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"110.509185ms","start":"2026-03-25T16:50:52.499803Z","end":"2026-03-25T16:50:52.610312Z","steps":["trace[1644448400] 'process raft request'  (duration: 110.202159ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:52.942535Z","caller":"traceutil/trace.go:171","msg":"trace[547072669] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"257.92197ms","start":"2026-03-25T16:50:52.684566Z","end":"2026-03-25T16:50:52.942488Z","steps":["trace[547072669] 'process raft request'  (duration: 257.764132ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:50:53.220588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.779797ms","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-03-25T16:50:53.220708Z","caller":"traceutil/trace.go:171","msg":"trace[2006407547] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:416; }","duration":"161.987437ms","start":"2026-03-25T16:50:53.058706Z","end":"2026-03-25T16:50:53.220693Z","steps":["trace[2006407547] 'range keys from in-memory index tree'  (duration: 161.65093ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:50:53.327163Z","caller":"traceutil/trace.go:171","msg":"trace[443197550] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"101.96993ms","start":"2026-03-25T16:50:53.22517Z","end":"2026-03-25T16:50:53.32714Z","steps":["trace[443197550] 'process raft request'  (duration: 101.416761ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:08.586076Z","caller":"traceutil/trace.go:171","msg":"trace[971068998] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"104.087324ms","start":"2026-03-25T16:51:08.481966Z","end":"2026-03-25T16:51:08.586053Z","steps":["trace[971068998] 'process raft request'  (duration: 100.266494ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:09.635896Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750706560325256585,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T16:51:09.952161Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.03109965s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-25T16:51:09.955291Z","caller":"traceutil/trace.go:171","msg":"trace[1353434063] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.034402685s","start":"2026-03-25T16:51:08.920862Z","end":"2026-03-25T16:51:09.955265Z","steps":["trace[1353434063] 'process raft request'  (duration: 1.031542509s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:09.955581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:08.920833Z","time spent":"1.034556192s","remote":"127.0.0.1:57432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" mod_revision:564 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" value_size:151109 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" > >"}
{"level":"info","ts":"2026-03-25T16:51:09.977513Z","caller":"traceutil/trace.go:171","msg":"trace[1847415507] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:593; }","duration":"841.689538ms","start":"2026-03-25T16:51:09.135795Z","end":"2026-03-25T16:51:09.977485Z","steps":["trace[1847415507] 'read index received'  (duration: 816.605944ms)","trace[1847415507] 'applied index is now lower than readState.Index'  (duration: 25.082744ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:09.977953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.106786ms","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-03-25T16:51:09.978042Z","caller":"traceutil/trace.go:171","msg":"trace[1686283349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"842.266534ms","start":"2026-03-25T16:51:09.135754Z","end":"2026-03-25T16:51:09.978021Z","steps":["trace[1686283349] 'agreement among raft nodes before linearized reading'  (duration: 841.94408ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:09.978093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:09.135739Z","time spent":"842.347837ms","remote":"127.0.0.1:57630","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-03-25T16:51:09.978175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.196568ms","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-03-25T16:51:09.978223Z","caller":"traceutil/trace.go:171","msg":"trace[1074068251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:576; }","duration":"535.301612ms","start":"2026-03-25T16:51:09.442909Z","end":"2026-03-25T16:51:09.978211Z","steps":["trace[1074068251] 'agreement among raft nodes before linearized reading'  (duration: 535.199008ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:09.978261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:09.442884Z","time spent":"535.369205ms","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-25T16:51:09.978369Z","caller":"traceutil/trace.go:171","msg":"trace[691146260] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"851.05348ms","start":"2026-03-25T16:51:09.127305Z","end":"2026-03-25T16:51:09.978359Z","steps":["trace[691146260] 'process raft request'  (duration: 849.955051ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:09.97846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:09.127279Z","time spent":"851.116123ms","remote":"127.0.0.1:57432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" value_size:568993 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T16:51:09.978508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.715322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:09.978549Z","caller":"traceutil/trace.go:171","msg":"trace[687237291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"356.793045ms","start":"2026-03-25T16:51:09.621745Z","end":"2026-03-25T16:51:09.978538Z","steps":["trace[687237291] 'agreement among raft nodes before linearized reading'  (duration: 356.735172ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:09.97858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:09.621724Z","time spent":"356.850417ms","remote":"127.0.0.1:57380","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-03-25T16:51:09.97876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.029358ms","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-03-25T16:51:09.978834Z","caller":"traceutil/trace.go:171","msg":"trace[960993779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"512.123672ms","start":"2026-03-25T16:51:09.466693Z","end":"2026-03-25T16:51:09.978816Z","steps":["trace[960993779] 'agreement among raft nodes before linearized reading'  (duration: 512.005257ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:09.978883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:09.46668Z","time spent":"512.192045ms","remote":"127.0.0.1:57630","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-03-25T16:51:10.97611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.553303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570096"}
{"level":"info","ts":"2026-03-25T16:51:10.976187Z","caller":"traceutil/trace.go:171","msg":"trace[1722387778] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:590; }","duration":"530.684138ms","start":"2026-03-25T16:51:10.445488Z","end":"2026-03-25T16:51:10.976172Z","steps":["trace[1722387778] 'range keys from in-memory index tree'  (duration: 530.274971ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:10.97622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:10.44547Z","time spent":"530.743271ms","remote":"127.0.0.1:57432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":570119,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" "}
{"level":"warn","ts":"2026-03-25T16:51:10.977139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.716933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:65214"}
{"level":"info","ts":"2026-03-25T16:51:10.977345Z","caller":"traceutil/trace.go:171","msg":"trace[1551952104] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:590; }","duration":"575.984814ms","start":"2026-03-25T16:51:10.401353Z","end":"2026-03-25T16:51:10.977338Z","steps":["trace[1551952104] 'range keys from in-memory index tree'  (duration: 575.529405ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:10.977369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:10.401333Z","time spent":"576.030276ms","remote":"127.0.0.1:57432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":65237,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tlsroutes.gateway.networking.k8s.io\" "}
{"level":"info","ts":"2026-03-25T16:51:10.977208Z","caller":"traceutil/trace.go:171","msg":"trace[1745761284] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"154.827834ms","start":"2026-03-25T16:51:10.82237Z","end":"2026-03-25T16:51:10.977198Z","steps":["trace[1745761284] 'read index received'  (duration: 153.940595ms)","trace[1745761284] 'applied index is now lower than readState.Index'  (duration: 886.559µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:10.977281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.911017ms","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-03-25T16:51:10.977441Z","caller":"traceutil/trace.go:171","msg":"trace[798871070] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"155.107376ms","start":"2026-03-25T16:51:10.822327Z","end":"2026-03-25T16:51:10.977435Z","steps":["trace[798871070] 'agreement among raft nodes before linearized reading'  (duration: 154.894727ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:10.977304Z","caller":"traceutil/trace.go:171","msg":"trace[857489461] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"487.320197ms","start":"2026-03-25T16:51:10.489977Z","end":"2026-03-25T16:51:10.977297Z","steps":["trace[857489461] 'process raft request'  (duration: 486.429608ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:10.97761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:10.489948Z","time spent":"487.61929ms","remote":"127.0.0.1:57432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" mod_revision:588 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" value_size:569989 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-03-25T16:51:12.756881Z","caller":"traceutil/trace.go:171","msg":"trace[1773962247] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"126.27359ms","start":"2026-03-25T16:51:12.630578Z","end":"2026-03-25T16:51:12.756852Z","steps":["trace[1773962247] 'read index received'  (duration: 126.04026ms)","trace[1773962247] 'applied index is now lower than readState.Index'  (duration: 232.42µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:51:12.756936Z","caller":"traceutil/trace.go:171","msg":"trace[2053686467] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"363.709744ms","start":"2026-03-25T16:51:12.393202Z","end":"2026-03-25T16:51:12.756911Z","steps":["trace[2053686467] 'process raft request'  (duration: 363.506665ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:12.757047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.451658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T16:51:12.757117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:12.393192Z","time spent":"363.825329ms","remote":"127.0.0.1:57488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":397,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/namespaces/envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/envoy-gateway-system\" value_size:348 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:51:12.757105Z","caller":"traceutil/trace.go:171","msg":"trace[1234286887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"126.547792ms","start":"2026-03-25T16:51:12.630542Z","end":"2026-03-25T16:51:12.75709Z","steps":["trace[1234286887] 'agreement among raft nodes before linearized reading'  (duration: 126.428287ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:13.277228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.967596ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325256665 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/envoy-gateway-system/default\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/envoy-gateway-system/default\" value_size:121 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:51:13.277415Z","caller":"traceutil/trace.go:171","msg":"trace[780993380] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"289.135315ms","start":"2026-03-25T16:51:12.988257Z","end":"2026-03-25T16:51:13.277392Z","steps":["trace[780993380] 'read index received'  (duration: 283.421093ms)","trace[780993380] 'applied index is now lower than readState.Index'  (duration: 5.712972ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:13.277615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.352695ms","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-03-25T16:51:13.277648Z","caller":"traceutil/trace.go:171","msg":"trace[1692918716] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:603; }","duration":"289.426028ms","start":"2026-03-25T16:51:12.988212Z","end":"2026-03-25T16:51:13.277638Z","steps":["trace[1692918716] 'agreement among raft nodes before linearized reading'  (duration: 289.264401ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:13.277849Z","caller":"traceutil/trace.go:171","msg":"trace[596116995] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"515.019094ms","start":"2026-03-25T16:51:12.76282Z","end":"2026-03-25T16:51:13.277839Z","steps":["trace[596116995] 'process raft request'  (duration: 514.511273ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:13.278082Z","caller":"traceutil/trace.go:171","msg":"trace[1460005411] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"517.336164ms","start":"2026-03-25T16:51:12.760726Z","end":"2026-03-25T16:51:13.278062Z","steps":["trace[1460005411] 'process raft request'  (duration: 105.47372ms)","trace[1460005411] 'compare'  (duration: 410.712425ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:13.27816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:12.760706Z","time spent":"517.417326ms","remote":"127.0.0.1:57578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/envoy-gateway-system/default\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/envoy-gateway-system/default\" value_size:121 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T16:51:13.278212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:12.762795Z","time spent":"515.087287ms","remote":"127.0.0.1:57474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1749,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/envoy-gateway-system/kube-root-ca.crt\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/envoy-gateway-system/kube-root-ca.crt\" value_size:1683 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:51:13.316491Z","caller":"traceutil/trace.go:171","msg":"trace[2069411943] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"155.716553ms","start":"2026-03-25T16:51:13.160754Z","end":"2026-03-25T16:51:13.31647Z","steps":["trace[2069411943] 'process raft request'  (duration: 155.40686ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:13.489142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.733584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:13.489231Z","caller":"traceutil/trace.go:171","msg":"trace[788610580] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:605; }","duration":"111.862541ms","start":"2026-03-25T16:51:13.377345Z","end":"2026-03-25T16:51:13.489208Z","steps":["trace[788610580] 'range keys from in-memory index tree'  (duration: 111.62687ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:15.463009Z","caller":"traceutil/trace.go:171","msg":"trace[2057741054] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"137.07201ms","start":"2026-03-25T16:51:15.325913Z","end":"2026-03-25T16:51:15.462985Z","steps":["trace[2057741054] 'process raft request'  (duration: 136.928524ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:15.941292Z","caller":"traceutil/trace.go:171","msg":"trace[143766028] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"320.542526ms","start":"2026-03-25T16:51:15.620718Z","end":"2026-03-25T16:51:15.94126Z","steps":["trace[143766028] 'read index received'  (duration: 248.666317ms)","trace[143766028] 'applied index is now lower than readState.Index'  (duration: 71.874379ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:51:15.941404Z","caller":"traceutil/trace.go:171","msg":"trace[384272038] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"382.389797ms","start":"2026-03-25T16:51:15.558986Z","end":"2026-03-25T16:51:15.941376Z","steps":["trace[384272038] 'process raft request'  (duration: 310.672644ms)","trace[384272038] 'compare'  (duration: 71.223692ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:15.941756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:15.55896Z","time spent":"382.672049ms","remote":"127.0.0.1:57462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:614 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036145 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-03-25T16:51:15.941427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.694263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:15.941843Z","caller":"traceutil/trace.go:171","msg":"trace[121793848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"321.142002ms","start":"2026-03-25T16:51:15.620682Z","end":"2026-03-25T16:51:15.941824Z","steps":["trace[121793848] 'agreement among raft nodes before linearized reading'  (duration: 320.690613ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:15.94195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:15.620665Z","time spent":"321.266566ms","remote":"127.0.0.1:57380","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-03-25T16:51:16.417366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.422908ms","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-03-25T16:51:16.417454Z","caller":"traceutil/trace.go:171","msg":"trace[928327899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"365.543612ms","start":"2026-03-25T16:51:16.05189Z","end":"2026-03-25T16:51:16.417434Z","steps":["trace[928327899] 'range keys from in-memory index tree'  (duration: 365.275541ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:16.417497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:16.05188Z","time spent":"365.608185ms","remote":"127.0.0.1:57630","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-03-25T16:51:16.41752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.872676ms","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-03-25T16:51:16.417619Z","caller":"traceutil/trace.go:171","msg":"trace[875880787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"366.006521ms","start":"2026-03-25T16:51:16.05158Z","end":"2026-03-25T16:51:16.417587Z","steps":["trace[875880787] 'range keys from in-memory index tree'  (duration: 365.368515ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:16.41766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:16.051555Z","time spent":"366.096345ms","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-25T16:51:16.41787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.851255ms","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-03-25T16:51:16.4179Z","caller":"traceutil/trace.go:171","msg":"trace[74647226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"365.896457ms","start":"2026-03-25T16:51:16.051994Z","end":"2026-03-25T16:51:16.41789Z","steps":["trace[74647226] 'range keys from in-memory index tree'  (duration: 365.758652ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:16.417927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:16.051985Z","time spent":"365.935429ms","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-25T16:51:16.742233Z","caller":"traceutil/trace.go:171","msg":"trace[765476824] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"120.172621ms","start":"2026-03-25T16:51:16.62203Z","end":"2026-03-25T16:51:16.742202Z","steps":["trace[765476824] 'read index received'  (duration: 119.267884ms)","trace[765476824] 'applied index is now lower than readState.Index'  (duration: 903.527µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:51:16.742284Z","caller":"traceutil/trace.go:171","msg":"trace[703781748] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"213.489761ms","start":"2026-03-25T16:51:16.528766Z","end":"2026-03-25T16:51:16.742255Z","steps":["trace[703781748] 'process raft request'  (duration: 212.817184ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:16.742382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.327098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:16.74248Z","caller":"traceutil/trace.go:171","msg":"trace[502104283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"120.518955ms","start":"2026-03-25T16:51:16.621944Z","end":"2026-03-25T16:51:16.742463Z","steps":["trace[502104283] 'agreement among raft nodes before linearized reading'  (duration: 120.354668ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:16.955619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.189058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:16.955706Z","caller":"traceutil/trace.go:171","msg":"trace[1784889317] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:623; }","duration":"110.318694ms","start":"2026-03-25T16:51:16.845368Z","end":"2026-03-25T16:51:16.955687Z","steps":["trace[1784889317] 'range keys from in-memory index tree'  (duration: 110.110475ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:16.955779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.336515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:16.95581Z","caller":"traceutil/trace.go:171","msg":"trace[901980091] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:623; }","duration":"110.392737ms","start":"2026-03-25T16:51:16.845409Z","end":"2026-03-25T16:51:16.955802Z","steps":["trace[901980091] 'count revisions from in-memory index tree'  (duration: 110.273382ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:16.956129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.392817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:16.956206Z","caller":"traceutil/trace.go:171","msg":"trace[1743543644] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:623; }","duration":"110.510891ms","start":"2026-03-25T16:51:16.845684Z","end":"2026-03-25T16:51:16.956195Z","steps":["trace[1743543644] 'range keys from in-memory index tree'  (duration: 110.348145ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:17.65647Z","caller":"traceutil/trace.go:171","msg":"trace[164104070] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"375.833894ms","start":"2026-03-25T16:51:17.28062Z","end":"2026-03-25T16:51:17.656454Z","steps":["trace[164104070] 'read index received'  (duration: 375.173997ms)","trace[164104070] 'applied index is now lower than readState.Index'  (duration: 659.117µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:51:17.656555Z","caller":"traceutil/trace.go:171","msg":"trace[179410224] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"403.012558ms","start":"2026-03-25T16:51:17.253527Z","end":"2026-03-25T16:51:17.656539Z","steps":["trace[179410224] 'process raft request'  (duration: 402.455426ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.656632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.99066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T16:51:17.65666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.253498Z","time spent":"403.097942ms","remote":"127.0.0.1:57462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:622 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036201 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-03-25T16:51:17.65668Z","caller":"traceutil/trace.go:171","msg":"trace[139509042] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"376.072084ms","start":"2026-03-25T16:51:17.280599Z","end":"2026-03-25T16:51:17.656671Z","steps":["trace[139509042] 'agreement among raft nodes before linearized reading'  (duration: 375.960209ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.656714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.280588Z","time spent":"376.116965ms","remote":"127.0.0.1:52034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T16:51:17.656744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.117354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T16:51:17.656831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.179415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:17.656899Z","caller":"traceutil/trace.go:171","msg":"trace[792831444] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"353.246907ms","start":"2026-03-25T16:51:17.303629Z","end":"2026-03-25T16:51:17.656876Z","steps":["trace[792831444] 'agreement among raft nodes before linearized reading'  (duration: 353.166004ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.656933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.253189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T16:51:17.656881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.874104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T16:51:17.656964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.303626Z","time spent":"353.3205ms","remote":"127.0.0.1:52042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "}
{"level":"info","ts":"2026-03-25T16:51:17.656972Z","caller":"traceutil/trace.go:171","msg":"trace[594559480] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:624; }","duration":"334.300102ms","start":"2026-03-25T16:51:17.322659Z","end":"2026-03-25T16:51:17.656959Z","steps":["trace[594559480] 'agreement among raft nodes before linearized reading'  (duration: 334.242319ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:17.656984Z","caller":"traceutil/trace.go:171","msg":"trace[504563650] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:624; }","duration":"334.002049ms","start":"2026-03-25T16:51:17.322969Z","end":"2026-03-25T16:51:17.656971Z","steps":["trace[504563650] 'agreement among raft nodes before linearized reading'  (duration: 333.890415ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.657011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.322656Z","time spent":"334.347293ms","remote":"127.0.0.1:52058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T16:51:17.657027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.336427ms","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-03-25T16:51:17.657026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.32296Z","time spent":"334.055311ms","remote":"127.0.0.1:52058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "}
{"level":"info","ts":"2026-03-25T16:51:17.657067Z","caller":"traceutil/trace.go:171","msg":"trace[846914533] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"191.39509ms","start":"2026-03-25T16:51:17.465657Z","end":"2026-03-25T16:51:17.657052Z","steps":["trace[846914533] 'agreement among raft nodes before linearized reading'  (duration: 191.298876ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.657143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.249714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:17.657188Z","caller":"traceutil/trace.go:171","msg":"trace[373627847] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"210.307586ms","start":"2026-03-25T16:51:17.446871Z","end":"2026-03-25T16:51:17.657178Z","steps":["trace[373627847] 'agreement among raft nodes before linearized reading'  (duration: 210.247553ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.657255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.616542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:17.656833Z","caller":"traceutil/trace.go:171","msg":"trace[684554299] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:624; }","duration":"334.245829ms","start":"2026-03-25T16:51:17.322565Z","end":"2026-03-25T16:51:17.65681Z","steps":["trace[684554299] 'agreement among raft nodes before linearized reading'  (duration: 334.115803ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:17.657313Z","caller":"traceutil/trace.go:171","msg":"trace[1061763969] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"353.685016ms","start":"2026-03-25T16:51:17.303614Z","end":"2026-03-25T16:51:17.657299Z","steps":["trace[1061763969] 'agreement among raft nodes before linearized reading'  (duration: 353.597572ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.657343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.322548Z","time spent":"334.785221ms","remote":"127.0.0.1:52058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "}
{"level":"warn","ts":"2026-03-25T16:51:17.657365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.30361Z","time spent":"353.738908ms","remote":"127.0.0.1:52042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T16:51:17.656755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.866768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:17.657466Z","caller":"traceutil/trace.go:171","msg":"trace[1016379877] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"210.623579ms","start":"2026-03-25T16:51:17.446832Z","end":"2026-03-25T16:51:17.657455Z","steps":["trace[1016379877] 'agreement among raft nodes before linearized reading'  (duration: 209.837857ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.656743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.030732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:17.657536Z","caller":"traceutil/trace.go:171","msg":"trace[248704747] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"376.859826ms","start":"2026-03-25T16:51:17.280663Z","end":"2026-03-25T16:51:17.657523Z","steps":["trace[248704747] 'agreement among raft nodes before linearized reading'  (duration: 375.98448ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.657572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.280659Z","time spent":"376.905898ms","remote":"127.0.0.1:52034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-03-25T16:51:17.657431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.833621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:17.657636Z","caller":"traceutil/trace.go:171","msg":"trace[162852119] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"354.065131ms","start":"2026-03-25T16:51:17.303566Z","end":"2026-03-25T16:51:17.657631Z","steps":["trace[162852119] 'agreement among raft nodes before linearized reading'  (duration: 353.849892ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:17.657656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.303552Z","time spent":"354.099162ms","remote":"127.0.0.1:52042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "}
{"level":"warn","ts":"2026-03-25T16:51:18.018534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.479798ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325256739 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:616 > 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":"warn","ts":"2026-03-25T16:51:18.018562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.046983ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.018664Z","caller":"traceutil/trace.go:171","msg":"trace[1941568352] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"356.026926ms","start":"2026-03-25T16:51:17.662616Z","end":"2026-03-25T16:51:18.018643Z","steps":["trace[1941568352] 'process raft request'  (duration: 105.357251ms)","trace[1941568352] 'compare'  (duration: 250.377044ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:51:18.018682Z","caller":"traceutil/trace.go:171","msg":"trace[23876697] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"283.013052ms","start":"2026-03-25T16:51:17.735653Z","end":"2026-03-25T16:51:18.018666Z","steps":["trace[23876697] 'process raft request'  (duration: 282.967551ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:18.018695Z","caller":"traceutil/trace.go:171","msg":"trace[1434665193] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:624; }","duration":"124.201179ms","start":"2026-03-25T16:51:17.894474Z","end":"2026-03-25T16:51:18.018675Z","steps":["trace[1434665193] 'range keys from in-memory index tree'  (duration: 123.837234ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.018938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.662599Z","time spent":"356.10402ms","remote":"127.0.0.1:57630","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:616 > 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-03-25T16:51:18.019055Z","caller":"traceutil/trace.go:171","msg":"trace[1648926840] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"330.244929ms","start":"2026-03-25T16:51:17.688787Z","end":"2026-03-25T16:51:18.019032Z","steps":["trace[1648926840] 'read index received'  (duration: 79.224539ms)","trace[1648926840] 'applied index is now lower than readState.Index'  (duration: 251.01701ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:18.019212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.414616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.019264Z","caller":"traceutil/trace.go:171","msg":"trace[29750811] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"330.496979ms","start":"2026-03-25T16:51:17.688756Z","end":"2026-03-25T16:51:18.019253Z","steps":["trace[29750811] 'agreement among raft nodes before linearized reading'  (duration: 330.401315ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.019297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.688742Z","time spent":"330.545442ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "}
{"level":"warn","ts":"2026-03-25T16:51:18.019444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.51757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.019472Z","caller":"traceutil/trace.go:171","msg":"trace[1742060084] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"330.567782ms","start":"2026-03-25T16:51:17.688897Z","end":"2026-03-25T16:51:18.019465Z","steps":["trace[1742060084] 'agreement among raft nodes before linearized reading'  (duration: 330.506719ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.01949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.688891Z","time spent":"330.593933ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "}
{"level":"warn","ts":"2026-03-25T16:51:18.01958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.675605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.019599Z","caller":"traceutil/trace.go:171","msg":"trace[929156867] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"280.709837ms","start":"2026-03-25T16:51:17.738885Z","end":"2026-03-25T16:51:18.019594Z","steps":["trace[929156867] 'agreement among raft nodes before linearized reading'  (duration: 280.679786ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.019688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.820662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.019706Z","caller":"traceutil/trace.go:171","msg":"trace[1755650630] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"280.840473ms","start":"2026-03-25T16:51:17.738861Z","end":"2026-03-25T16:51:18.019702Z","steps":["trace[1755650630] 'agreement among raft nodes before linearized reading'  (duration: 280.805691ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.019659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.683276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-25T16:51:18.01977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.582721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.019789Z","caller":"traceutil/trace.go:171","msg":"trace[481058201] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"309.622113ms","start":"2026-03-25T16:51:17.710162Z","end":"2026-03-25T16:51:18.019784Z","steps":["trace[481058201] 'agreement among raft nodes before linearized reading'  (duration: 309.594572ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:18.019774Z","caller":"traceutil/trace.go:171","msg":"trace[94056343] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"280.846952ms","start":"2026-03-25T16:51:17.7389Z","end":"2026-03-25T16:51:18.019747Z","steps":["trace[94056343] 'agreement among raft nodes before linearized reading'  (duration: 280.630754ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.019811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.710151Z","time spent":"309.647874ms","remote":"127.0.0.1:52084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "}
{"level":"warn","ts":"2026-03-25T16:51:18.019887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.870804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.019908Z","caller":"traceutil/trace.go:171","msg":"trace[675804327] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"310.896476ms","start":"2026-03-25T16:51:17.709003Z","end":"2026-03-25T16:51:18.0199Z","steps":["trace[675804327] 'agreement among raft nodes before linearized reading'  (duration: 310.869034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.019922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.709Z","time spent":"310.918136ms","remote":"127.0.0.1:52084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T16:51:18.019983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.235999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.02Z","caller":"traceutil/trace.go:171","msg":"trace[1573025023] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"311.274811ms","start":"2026-03-25T16:51:17.708721Z","end":"2026-03-25T16:51:18.019996Z","steps":["trace[1573025023] 'agreement among raft nodes before linearized reading'  (duration: 311.245429ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.020012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.708707Z","time spent":"311.302562ms","remote":"127.0.0.1:52084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "}
{"level":"warn","ts":"2026-03-25T16:51:18.020075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.146955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.020089Z","caller":"traceutil/trace.go:171","msg":"trace[1849368710] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"331.172017ms","start":"2026-03-25T16:51:17.688913Z","end":"2026-03-25T16:51:18.020085Z","steps":["trace[1849368710] 'agreement among raft nodes before linearized reading'  (duration: 331.144216ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.020102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:17.68891Z","time spent":"331.188438ms","remote":"127.0.0.1:52074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T16:51:18.020088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.114488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.020146Z","caller":"traceutil/trace.go:171","msg":"trace[191739793] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:626; }","duration":"157.225442ms","start":"2026-03-25T16:51:17.862903Z","end":"2026-03-25T16:51:18.020129Z","steps":["trace[191739793] 'agreement among raft nodes before linearized reading'  (duration: 157.114227ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.019698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.615048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.020228Z","caller":"traceutil/trace.go:171","msg":"trace[1014377414] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:626; }","duration":"157.272984ms","start":"2026-03-25T16:51:17.862944Z","end":"2026-03-25T16:51:18.020217Z","steps":["trace[1014377414] 'agreement among raft nodes before linearized reading'  (duration: 156.513654ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.020351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.419276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.020408Z","caller":"traceutil/trace.go:171","msg":"trace[988120065] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"202.478298ms","start":"2026-03-25T16:51:17.817909Z","end":"2026-03-25T16:51:18.020388Z","steps":["trace[988120065] 'agreement among raft nodes before linearized reading'  (duration: 202.403855ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.020612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.358494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.020652Z","caller":"traceutil/trace.go:171","msg":"trace[1440900404] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"203.408247ms","start":"2026-03-25T16:51:17.817235Z","end":"2026-03-25T16:51:18.020643Z","steps":["trace[1440900404] 'agreement among raft nodes before linearized reading'  (duration: 203.347034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.020746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.475953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.02078Z","caller":"traceutil/trace.go:171","msg":"trace[310356206] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:626; }","duration":"157.520714ms","start":"2026-03-25T16:51:17.863249Z","end":"2026-03-25T16:51:18.02077Z","steps":["trace[310356206] 'agreement among raft nodes before linearized reading'  (duration: 157.481922ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.020815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.702668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.020852Z","caller":"traceutil/trace.go:171","msg":"trace[1915642094] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"203.757871ms","start":"2026-03-25T16:51:17.817086Z","end":"2026-03-25T16:51:18.020844Z","steps":["trace[1915642094] 'agreement among raft nodes before linearized reading'  (duration: 203.702259ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.020878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.907197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.020917Z","caller":"traceutil/trace.go:171","msg":"trace[370287580] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"242.973609ms","start":"2026-03-25T16:51:17.777932Z","end":"2026-03-25T16:51:18.020906Z","steps":["trace[370287580] 'agreement among raft nodes before linearized reading'  (duration: 242.913047ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:18.023803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.067263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:18.023969Z","caller":"traceutil/trace.go:171","msg":"trace[53745523] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:626; }","duration":"245.909139ms","start":"2026-03-25T16:51:17.777929Z","end":"2026-03-25T16:51:18.023839Z","steps":["trace[53745523] 'agreement among raft nodes before linearized reading'  (duration: 243.079934ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:18.545206Z","caller":"traceutil/trace.go:171","msg":"trace[343495785] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"142.268585ms","start":"2026-03-25T16:51:18.402912Z","end":"2026-03-25T16:51:18.545181Z","steps":["trace[343495785] 'process raft request'  (duration: 141.65923ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:20.710356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:18.644611Z","time spent":"2.065666714s","remote":"127.0.0.1:52168","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-25T16:51:20.710678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.029283474s","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325256748 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:621 > 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-03-25T16:51:20.710821Z","caller":"traceutil/trace.go:171","msg":"trace[2054028358] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:649; }","duration":"1.088437438s","start":"2026-03-25T16:51:19.622372Z","end":"2026-03-25T16:51:20.710809Z","steps":["trace[2054028358] 'read index received'  (duration: 56.143µs)","trace[2054028358] 'applied index is now lower than readState.Index'  (duration: 1.088380585s)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:51:20.710867Z","caller":"traceutil/trace.go:171","msg":"trace[1723888801] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"2.160561462s","start":"2026-03-25T16:51:18.550273Z","end":"2026-03-25T16:51:20.710834Z","steps":["trace[1723888801] 'process raft request'  (duration: 2.160470208s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:20.711195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:18.550263Z","time spent":"2.160905057s","remote":"127.0.0.1:57630","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:619 > 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":"info","ts":"2026-03-25T16:51:20.711055Z","caller":"traceutil/trace.go:171","msg":"trace[1284556411] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"2.161114695s","start":"2026-03-25T16:51:18.549912Z","end":"2026-03-25T16:51:20.711026Z","steps":["trace[1284556411] 'process raft request'  (duration: 131.423364ms)","trace[1284556411] 'compare'  (duration: 2.029136699s)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:20.711313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:18.549888Z","time spent":"2.161391576s","remote":"127.0.0.1:57630","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:621 > 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-03-25T16:51:20.711335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.667904ms","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-03-25T16:51:20.711396Z","caller":"traceutil/trace.go:171","msg":"trace[1821803291] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"104.78779ms","start":"2026-03-25T16:51:20.606594Z","end":"2026-03-25T16:51:20.711381Z","steps":["trace[1821803291] 'agreement among raft nodes before linearized reading'  (duration: 104.581562ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:20.711379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.894914ms","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-03-25T16:51:20.711047Z","caller":"traceutil/trace.go:171","msg":"trace[395739363] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"2.109780307s","start":"2026-03-25T16:51:18.601236Z","end":"2026-03-25T16:51:20.711017Z","steps":["trace[395739363] 'process raft request'  (duration: 2.109541768s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:20.711471Z","caller":"traceutil/trace.go:171","msg":"trace[263804661] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"686.065652ms","start":"2026-03-25T16:51:20.025377Z","end":"2026-03-25T16:51:20.711443Z","steps":["trace[263804661] 'agreement among raft nodes before linearized reading'  (duration: 685.799301ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:20.711516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:18.601201Z","time spent":"2.110296559s","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"warn","ts":"2026-03-25T16:51:20.711525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:20.025357Z","time spent":"686.155225ms","remote":"127.0.0.1:57630","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-03-25T16:51:20.711066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088677327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:20.711612Z","caller":"traceutil/trace.go:171","msg":"trace[1676917266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"1.089275911s","start":"2026-03-25T16:51:19.622328Z","end":"2026-03-25T16:51:20.711604Z","steps":["trace[1676917266] 'agreement among raft nodes before linearized reading'  (duration: 1.088656866s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:20.711636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:19.622278Z","time spent":"1.089352584s","remote":"127.0.0.1:57380","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-03-25T16:51:21.187914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.729833ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325256755 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:628 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:51:21.188Z","caller":"traceutil/trace.go:171","msg":"trace[2077556408] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"472.233049ms","start":"2026-03-25T16:51:20.715752Z","end":"2026-03-25T16:51:21.187985Z","steps":["trace[2077556408] 'process raft request'  (duration: 220.36987ms)","trace[2077556408] 'compare'  (duration: 251.437422ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:21.188045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:20.715741Z","time spent":"472.283511ms","remote":"127.0.0.1:57630","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:628 > 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-03-25T16:51:22.269134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.91033ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325256756 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:625 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:51:22.269231Z","caller":"traceutil/trace.go:171","msg":"trace[1980737524] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"1.551730433s","start":"2026-03-25T16:51:20.717486Z","end":"2026-03-25T16:51:22.269217Z","steps":["trace[1980737524] 'read index received'  (duration: 218.61792ms)","trace[1980737524] 'applied index is now lower than readState.Index'  (duration: 1.333110903s)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:22.269502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.552009523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-03-25T16:51:22.269545Z","caller":"traceutil/trace.go:171","msg":"trace[1334634677] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:633; }","duration":"1.552072536s","start":"2026-03-25T16:51:20.717461Z","end":"2026-03-25T16:51:22.269533Z","steps":["trace[1334634677] 'agreement among raft nodes before linearized reading'  (duration: 1.551985233s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:22.269577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:20.717449Z","time spent":"1.552120298s","remote":"127.0.0.1:57578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "}
{"level":"info","ts":"2026-03-25T16:51:22.269586Z","caller":"traceutil/trace.go:171","msg":"trace[1894644809] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"1.552882968s","start":"2026-03-25T16:51:20.716679Z","end":"2026-03-25T16:51:22.269562Z","steps":["trace[1894644809] 'process raft request'  (duration: 870.437857ms)","trace[1894644809] 'compare'  (duration: 681.595588ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:22.26969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:20.716644Z","time spent":"1.552991992s","remote":"127.0.0.1:57630","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:625 > 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-03-25T16:51:22.438389Z","caller":"traceutil/trace.go:171","msg":"trace[314119915] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"169.11517ms","start":"2026-03-25T16:51:22.269256Z","end":"2026-03-25T16:51:22.438371Z","steps":["trace[314119915] 'read index received'  (duration: 110.602329ms)","trace[314119915] 'applied index is now lower than readState.Index'  (duration: 58.511981ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:51:22.438424Z","caller":"traceutil/trace.go:171","msg":"trace[132342099] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.312759338s","start":"2026-03-25T16:51:21.125636Z","end":"2026-03-25T16:51:22.438395Z","steps":["trace[132342099] 'process raft request'  (duration: 1.254292689s)","trace[132342099] 'compare'  (duration: 58.336574ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:22.43855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:21.125609Z","time spent":"1.312873052s","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:594 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-25T16:51:22.438562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.213113657s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.123\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-25T16:51:22.438581Z","caller":"traceutil/trace.go:171","msg":"trace[83882487] range","detail":"{range_begin:/registry/masterleases/199.19.213.123; range_end:; response_count:1; response_revision:634; }","duration":"1.21318775s","start":"2026-03-25T16:51:21.225387Z","end":"2026-03-25T16:51:22.438575Z","steps":["trace[83882487] 'agreement among raft nodes before linearized reading'  (duration: 1.213074585s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:22.438598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:21.225364Z","time spent":"1.213229681s","remote":"127.0.0.1:57416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.123\" "}
{"level":"warn","ts":"2026-03-25T16:51:22.438627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.716670096s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:22.43865Z","caller":"traceutil/trace.go:171","msg":"trace[21094955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"1.716731378s","start":"2026-03-25T16:51:20.721912Z","end":"2026-03-25T16:51:22.438644Z","steps":["trace[21094955] 'agreement among raft nodes before linearized reading'  (duration: 1.716690526s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:22.438665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:20.721896Z","time spent":"1.716764999s","remote":"127.0.0.1:57380","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-03-25T16:51:22.438658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.98835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:22.438738Z","caller":"traceutil/trace.go:171","msg":"trace[1293476048] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:634; }","duration":"160.101115ms","start":"2026-03-25T16:51:22.278621Z","end":"2026-03-25T16:51:22.438722Z","steps":["trace[1293476048] 'agreement among raft nodes before linearized reading'  (duration: 159.98145ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:24.002923Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750706560325256783,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T16:51:24.503908Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750706560325256783,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-25T16:51:24.773236Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.576185674s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-25T16:51:24.773735Z","caller":"traceutil/trace.go:171","msg":"trace[2099065056] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.576751896s","start":"2026-03-25T16:51:23.196956Z","end":"2026-03-25T16:51:24.773707Z","steps":["trace[2099065056] 'process raft request'  (duration: 1.576531938s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:24.773892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:23.196935Z","time spent":"1.576877681s","remote":"127.0.0.1:57630","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:632 > 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-03-25T16:51:25.622665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000488247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-25T16:51:25.62273Z","caller":"traceutil/trace.go:171","msg":"trace[1235124696] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000596662s","start":"2026-03-25T16:51:23.622122Z","end":"2026-03-25T16:51:25.622719Z","steps":["trace[1235124696] 'agreement among raft nodes before linearized reading'  (duration: 2.000511888s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:25.622794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:23.622106Z","time spent":"2.000679975s","remote":"127.0.0.1:57380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/25 16:51:25 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-25T16:51:26.517927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.994003ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325256785 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:611 > 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-03-25T16:51:26.518044Z","caller":"traceutil/trace.go:171","msg":"trace[951888510] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"3.015350494s","start":"2026-03-25T16:51:23.502674Z","end":"2026-03-25T16:51:26.518024Z","steps":["trace[951888510] 'read index received'  (duration: 1.270791255s)","trace[951888510] 'applied index is now lower than readState.Index'  (duration: 1.744557449s)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:51:26.518135Z","caller":"traceutil/trace.go:171","msg":"trace[46696940] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"2.336802828s","start":"2026-03-25T16:51:24.181318Z","end":"2026-03-25T16:51:26.518121Z","steps":["trace[46696940] 'process raft request'  (duration: 1.601524744s)","trace[46696940] 'compare'  (duration: 734.769264ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:26.518212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:24.181286Z","time spent":"2.336880441s","remote":"127.0.0.1:57630","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:611 > 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-03-25T16:51:26.518347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.015652005s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-46p89\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-03-25T16:51:26.518424Z","caller":"traceutil/trace.go:171","msg":"trace[1189744046] range","detail":"{range_begin:/registry/pods/kube-system/cilium-46p89; range_end:; response_count:1; response_revision:647; }","duration":"3.015769049s","start":"2026-03-25T16:51:23.502633Z","end":"2026-03-25T16:51:26.518402Z","steps":["trace[1189744046] 'agreement among raft nodes before linearized reading'  (duration: 3.015544691s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:26.5215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:23.502615Z","time spent":"3.015841942s","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-46p89\" "}
{"level":"warn","ts":"2026-03-25T16:51:26.542141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.313067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:26.542194Z","caller":"traceutil/trace.go:171","msg":"trace[1063075604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"919.392901ms","start":"2026-03-25T16:51:25.622789Z","end":"2026-03-25T16:51:26.542182Z","steps":["trace[1063075604] 'agreement among raft nodes before linearized reading'  (duration: 919.313457ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:26.542229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.797509643s","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-03-25T16:51:26.542226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.268367636s","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-03-25T16:51:26.54225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:25.622776Z","time spent":"919.437672ms","remote":"127.0.0.1:57370","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-03-25T16:51:26.542277Z","caller":"traceutil/trace.go:171","msg":"trace[2015236691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"1.797555655s","start":"2026-03-25T16:51:24.744711Z","end":"2026-03-25T16:51:26.542267Z","steps":["trace[2015236691] 'agreement among raft nodes before linearized reading'  (duration: 1.797458891s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:26.542311Z","caller":"traceutil/trace.go:171","msg":"trace[1025899356] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:647; }","duration":"2.26847342s","start":"2026-03-25T16:51:24.273792Z","end":"2026-03-25T16:51:26.542266Z","steps":["trace[1025899356] 'agreement among raft nodes before linearized reading'  (duration: 2.268290853s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:26.542323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:24.744667Z","time spent":"1.797651608s","remote":"127.0.0.1:57630","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-03-25T16:51:26.542341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:24.273763Z","time spent":"2.268570523s","remote":"127.0.0.1:57630","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-03-25T16:51:26.542226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.797467811s","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-03-25T16:51:26.542407Z","caller":"traceutil/trace.go:171","msg":"trace[411970009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"1.797671469s","start":"2026-03-25T16:51:24.744722Z","end":"2026-03-25T16:51:26.542393Z","steps":["trace[411970009] 'agreement among raft nodes before linearized reading'  (duration: 1.797429209s)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:26.542455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:24.744705Z","time spent":"1.797738201s","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-25T16:51:29.126498Z","caller":"traceutil/trace.go:171","msg":"trace[2133844880] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"491.868428ms","start":"2026-03-25T16:51:28.634604Z","end":"2026-03-25T16:51:29.126472Z","steps":["trace[2133844880] 'process raft request'  (duration: 491.759294ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:29.126632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:28.634578Z","time spent":"491.994723ms","remote":"127.0.0.1:57432","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":"info","ts":"2026-03-25T16:51:29.129419Z","caller":"traceutil/trace.go:171","msg":"trace[57257009] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:704; }","duration":"253.55289ms","start":"2026-03-25T16:51:28.87585Z","end":"2026-03-25T16:51:29.129403Z","steps":["trace[57257009] 'read index received'  (duration: 250.5853ms)","trace[57257009] 'applied index is now lower than readState.Index'  (duration: 2.96683ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:29.129593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.736937ms","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-03-25T16:51:29.129628Z","caller":"traceutil/trace.go:171","msg":"trace[97229891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:684; }","duration":"253.81223ms","start":"2026-03-25T16:51:28.875804Z","end":"2026-03-25T16:51:29.129616Z","steps":["trace[97229891] 'agreement among raft nodes before linearized reading'  (duration: 253.660934ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:29.129611Z","caller":"traceutil/trace.go:171","msg":"trace[384693831] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"294.521645ms","start":"2026-03-25T16:51:28.835037Z","end":"2026-03-25T16:51:29.129558Z","steps":["trace[384693831] 'process raft request'  (duration: 294.258985ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:30.872012Z","caller":"traceutil/trace.go:171","msg":"trace[555673624] linearizableReadLoop","detail":"{readStateIndex:730; appliedIndex:729; }","duration":"299.166873ms","start":"2026-03-25T16:51:30.572823Z","end":"2026-03-25T16:51:30.87199Z","steps":["trace[555673624] 'read index received'  (duration: 298.938594ms)","trace[555673624] 'applied index is now lower than readState.Index'  (duration: 227.279µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:30.872267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.425162ms","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-03-25T16:51:30.872311Z","caller":"traceutil/trace.go:171","msg":"trace[548336439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:707; }","duration":"299.503845ms","start":"2026-03-25T16:51:30.572792Z","end":"2026-03-25T16:51:30.872296Z","steps":["trace[548336439] 'agreement among raft nodes before linearized reading'  (duration: 299.3588ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:30.87251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.876675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:30.872652Z","caller":"traceutil/trace.go:171","msg":"trace[660977400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:707; }","duration":"250.069052ms","start":"2026-03-25T16:51:30.622549Z","end":"2026-03-25T16:51:30.872619Z","steps":["trace[660977400] 'agreement among raft nodes before linearized reading'  (duration: 249.777291ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:30.872674Z","caller":"traceutil/trace.go:171","msg":"trace[1455597915] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"300.336055ms","start":"2026-03-25T16:51:30.571727Z","end":"2026-03-25T16:51:30.872063Z","steps":["trace[1455597915] 'process raft request'  (duration: 300.127458ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:30.872583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.222589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"}
{"level":"warn","ts":"2026-03-25T16:51:30.87279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:30.571703Z","time spent":"301.01225ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18052,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-46p89\" mod_revision:699 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-46p89\" value_size:18003 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-46p89\" > >"}
{"level":"info","ts":"2026-03-25T16:51:30.8729Z","caller":"traceutil/trace.go:171","msg":"trace[755892552] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:707; }","duration":"240.472468ms","start":"2026-03-25T16:51:30.632342Z","end":"2026-03-25T16:51:30.872815Z","steps":["trace[755892552] 'agreement among raft nodes before linearized reading'  (duration: 239.931918ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:30.872706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.951243ms","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-03-25T16:51:30.873024Z","caller":"traceutil/trace.go:171","msg":"trace[1277039961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:707; }","duration":"296.310857ms","start":"2026-03-25T16:51:30.57669Z","end":"2026-03-25T16:51:30.873001Z","steps":["trace[1277039961] 'agreement among raft nodes before linearized reading'  (duration: 295.744956ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:30.872938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.37714ms","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-03-25T16:51:30.873128Z","caller":"traceutil/trace.go:171","msg":"trace[1900968421] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:707; }","duration":"299.590008ms","start":"2026-03-25T16:51:30.573522Z","end":"2026-03-25T16:51:30.873112Z","steps":["trace[1900968421] 'agreement among raft nodes before linearized reading'  (duration: 298.717766ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:31.141955Z","caller":"traceutil/trace.go:171","msg":"trace[1240069280] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"114.574133ms","start":"2026-03-25T16:51:31.027341Z","end":"2026-03-25T16:51:31.141915Z","steps":["trace[1240069280] 'process raft request'  (duration: 114.343474ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:31.85248Z","caller":"traceutil/trace.go:171","msg":"trace[2130374920] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"160.847185ms","start":"2026-03-25T16:51:31.691611Z","end":"2026-03-25T16:51:31.852458Z","steps":["trace[2130374920] 'process raft request'  (duration: 160.677109ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:36.582893Z","caller":"traceutil/trace.go:171","msg":"trace[35916450] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"113.882313ms","start":"2026-03-25T16:51:36.468991Z","end":"2026-03-25T16:51:36.582874Z","steps":["trace[35916450] 'process raft request'  (duration: 28.299718ms)","trace[35916450] 'compare'  (duration: 85.476151ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:51:36.805957Z","caller":"traceutil/trace.go:171","msg":"trace[470043581] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"161.348055ms","start":"2026-03-25T16:51:36.644585Z","end":"2026-03-25T16:51:36.805933Z","steps":["trace[470043581] 'process raft request'  (duration: 160.794946ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:41.410235Z","caller":"traceutil/trace.go:171","msg":"trace[495481702] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:816; }","duration":"350.119437ms","start":"2026-03-25T16:51:41.060093Z","end":"2026-03-25T16:51:41.410212Z","steps":["trace[495481702] 'read index received'  (duration: 349.93247ms)","trace[495481702] 'applied index is now lower than readState.Index'  (duration: 186.017µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:51:41.410567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.455238ms","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-03-25T16:51:41.410346Z","caller":"traceutil/trace.go:171","msg":"trace[809742205] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"785.244724ms","start":"2026-03-25T16:51:40.625068Z","end":"2026-03-25T16:51:41.410313Z","steps":["trace[809742205] 'process raft request'  (duration: 785.004166ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:41.410743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.592718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-03-25T16:51:41.410758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.800239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.123\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-25T16:51:41.410775Z","caller":"traceutil/trace.go:171","msg":"trace[767925119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:791; }","duration":"296.625279ms","start":"2026-03-25T16:51:41.114142Z","end":"2026-03-25T16:51:41.410767Z","steps":["trace[767925119] 'agreement among raft nodes before linearized reading'  (duration: 296.545647ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:41.410654Z","caller":"traceutil/trace.go:171","msg":"trace[1491032122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:791; }","duration":"350.592113ms","start":"2026-03-25T16:51:41.060041Z","end":"2026-03-25T16:51:41.410633Z","steps":["trace[1491032122] 'agreement among raft nodes before linearized reading'  (duration: 350.343584ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:41.410778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.143682ms","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-03-25T16:51:41.410845Z","caller":"traceutil/trace.go:171","msg":"trace[1635562572] range","detail":"{range_begin:/registry/masterleases/199.19.213.123; range_end:; response_count:1; response_revision:791; }","duration":"184.918243ms","start":"2026-03-25T16:51:41.22591Z","end":"2026-03-25T16:51:41.410828Z","steps":["trace[1635562572] 'agreement among raft nodes before linearized reading'  (duration: 184.703496ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:41.411005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:41.060021Z","time spent":"350.900234ms","remote":"127.0.0.1:57630","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-03-25T16:51:41.411205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:40.625048Z","time spent":"785.657157ms","remote":"127.0.0.1:57630","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:778 > 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-03-25T16:51:41.411498Z","caller":"traceutil/trace.go:171","msg":"trace[1774021938] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:791; }","duration":"341.933069ms","start":"2026-03-25T16:51:41.069544Z","end":"2026-03-25T16:51:41.411477Z","steps":["trace[1774021938] 'agreement among raft nodes before linearized reading'  (duration: 341.043738ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:41.411557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:41.069519Z","time spent":"342.025182ms","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-25T16:51:41.645035Z","caller":"traceutil/trace.go:171","msg":"trace[1227625749] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"230.840064ms","start":"2026-03-25T16:51:41.414175Z","end":"2026-03-25T16:51:41.645015Z","steps":["trace[1227625749] 'process raft request'  (duration: 230.550804ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:41.645158Z","caller":"traceutil/trace.go:171","msg":"trace[1456257657] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"230.489231ms","start":"2026-03-25T16:51:41.414627Z","end":"2026-03-25T16:51:41.645116Z","steps":["trace[1456257657] 'process raft request'  (duration: 230.284924ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:41.645178Z","caller":"traceutil/trace.go:171","msg":"trace[335091795] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"229.806488ms","start":"2026-03-25T16:51:41.415341Z","end":"2026-03-25T16:51:41.645147Z","steps":["trace[335091795] 'process raft request'  (duration: 229.672174ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:41.645402Z","caller":"traceutil/trace.go:171","msg":"trace[132312474] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"230.356687ms","start":"2026-03-25T16:51:41.415028Z","end":"2026-03-25T16:51:41.645385Z","steps":["trace[132312474] 'process raft request'  (duration: 229.932873ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:45.972585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.961024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-25T16:51:45.972711Z","caller":"traceutil/trace.go:171","msg":"trace[88063858] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:811; }","duration":"804.14741ms","start":"2026-03-25T16:51:45.168538Z","end":"2026-03-25T16:51:45.972686Z","steps":["trace[88063858] 'count revisions from in-memory index tree'  (duration: 803.871541ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:45.972767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:45.168518Z","time spent":"804.234343ms","remote":"127.0.0.1:57836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T16:51:45.97312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.748844ms","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-03-25T16:51:45.973176Z","caller":"traceutil/trace.go:171","msg":"trace[656360777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:811; }","duration":"309.838296ms","start":"2026-03-25T16:51:45.663321Z","end":"2026-03-25T16:51:45.973159Z","steps":["trace[656360777] 'range keys from in-memory index tree'  (duration: 309.602589ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:45.973214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:45.663308Z","time spent":"309.894159ms","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-25T16:51:45.972628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.425397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-25T16:51:45.973273Z","caller":"traceutil/trace.go:171","msg":"trace[1878841527] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:811; }","duration":"367.14301ms","start":"2026-03-25T16:51:45.606116Z","end":"2026-03-25T16:51:45.973259Z","steps":["trace[1878841527] 'count revisions from in-memory index tree'  (duration: 366.340194ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:45.973315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:45.606095Z","time spent":"367.205812ms","remote":"127.0.0.1:57608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":30,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T16:51:45.973312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.929972ms","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-03-25T16:51:45.973392Z","caller":"traceutil/trace.go:171","msg":"trace[815754418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"311.046096ms","start":"2026-03-25T16:51:45.662327Z","end":"2026-03-25T16:51:45.973373Z","steps":["trace[815754418] 'range keys from in-memory index tree'  (duration: 310.694835ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:45.973443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:45.662282Z","time spent":"311.15156ms","remote":"127.0.0.1:57630","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-03-25T16:51:45.973615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.214365ms","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-03-25T16:51:45.973654Z","caller":"traceutil/trace.go:171","msg":"trace[884972172] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:811; }","duration":"312.281717ms","start":"2026-03-25T16:51:45.661361Z","end":"2026-03-25T16:51:45.973642Z","steps":["trace[884972172] 'range keys from in-memory index tree'  (duration: 312.097891ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:45.973683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:45.661341Z","time spent":"312.336519ms","remote":"127.0.0.1:57630","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-03-25T16:51:45.973594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.362585772s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-m5x78\" ","response":"range_response_count:1 size:3965"}
{"level":"warn","ts":"2026-03-25T16:51:45.973658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.274644ms","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-03-25T16:51:45.973739Z","caller":"traceutil/trace.go:171","msg":"trace[588265861] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-m5x78; range_end:; response_count:1; response_revision:811; }","duration":"1.362788669s","start":"2026-03-25T16:51:44.610936Z","end":"2026-03-25T16:51:45.973724Z","steps":["trace[588265861] 'range keys from in-memory index tree'  (duration: 1.362333234s)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:45.973768Z","caller":"traceutil/trace.go:171","msg":"trace[1652900220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:811; }","duration":"311.406178ms","start":"2026-03-25T16:51:45.662352Z","end":"2026-03-25T16:51:45.973759Z","steps":["trace[1652900220] 'range keys from in-memory index tree'  (duration: 311.070157ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:45.973785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:44.610912Z","time spent":"1.362858651s","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-m5x78\" "}
{"level":"warn","ts":"2026-03-25T16:51:45.973804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:45.662338Z","time spent":"311.45935ms","remote":"127.0.0.1:57630","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-03-25T16:51:45.974191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.597862ms","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-03-25T16:51:45.974593Z","caller":"traceutil/trace.go:171","msg":"trace[857701056] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:811; }","duration":"551.028356ms","start":"2026-03-25T16:51:45.423546Z","end":"2026-03-25T16:51:45.974574Z","steps":["trace[857701056] 'range keys from in-memory index tree'  (duration: 548.923297ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:45.974684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:45.423526Z","time spent":"551.110469ms","remote":"127.0.0.1:57630","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":"warn","ts":"2026-03-25T16:51:45.972898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:51:45.975356Z","caller":"traceutil/trace.go:171","msg":"trace[887881331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"354.475962ms","start":"2026-03-25T16:51:45.620851Z","end":"2026-03-25T16:51:45.975327Z","steps":["trace[887881331] 'range keys from in-memory index tree'  (duration: 351.883476ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:45.975855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:51:45.620826Z","time spent":"354.963948ms","remote":"127.0.0.1:57380","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-03-25T16:51:46.250477Z","caller":"traceutil/trace.go:171","msg":"trace[1690945228] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"271.830446ms","start":"2026-03-25T16:51:45.978622Z","end":"2026-03-25T16:51:46.250453Z","steps":["trace[1690945228] 'process raft request'  (duration: 271.65403ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:46.265418Z","caller":"traceutil/trace.go:171","msg":"trace[1109248065] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"285.755823ms","start":"2026-03-25T16:51:45.979634Z","end":"2026-03-25T16:51:46.265389Z","steps":["trace[1109248065] 'process raft request'  (duration: 285.494095ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:46.265464Z","caller":"traceutil/trace.go:171","msg":"trace[1505232135] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"270.591872ms","start":"2026-03-25T16:51:45.994847Z","end":"2026-03-25T16:51:46.265439Z","steps":["trace[1505232135] 'process raft request'  (duration: 270.445567ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:46.265615Z","caller":"traceutil/trace.go:171","msg":"trace[1613943384] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"270.214079ms","start":"2026-03-25T16:51:45.995393Z","end":"2026-03-25T16:51:46.265607Z","steps":["trace[1613943384] 'process raft request'  (duration: 269.960381ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:46.265647Z","caller":"traceutil/trace.go:171","msg":"trace[1620383549] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"268.155612ms","start":"2026-03-25T16:51:45.997371Z","end":"2026-03-25T16:51:46.265527Z","steps":["trace[1620383549] 'process raft request'  (duration: 268.10687ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:51:46.265679Z","caller":"traceutil/trace.go:171","msg":"trace[370845656] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"269.951241ms","start":"2026-03-25T16:51:45.995721Z","end":"2026-03-25T16:51:46.265673Z","steps":["trace[370845656] 'process raft request'  (duration: 269.695362ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:51:59.97987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.727257ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325257401 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/local-path-storage/local-path-provisioner-679c578f5-gk6s4.18a023b677e15465\" mod_revision:0 > success:<request_put:<key:\"/registry/events/local-path-storage/local-path-provisioner-679c578f5-gk6s4.18a023b677e15465\" value_size:707 lease:5750706560325257089 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:51:59.980492Z","caller":"traceutil/trace.go:171","msg":"trace[160094266] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"191.309837ms","start":"2026-03-25T16:51:59.788801Z","end":"2026-03-25T16:51:59.980111Z","steps":["trace[160094266] 'compare'  (duration: 180.387997ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:52:00.876876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.384506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:52:00.876961Z","caller":"traceutil/trace.go:171","msg":"trace[8072900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"254.52367ms","start":"2026-03-25T16:52:00.622421Z","end":"2026-03-25T16:52:00.876945Z","steps":["trace[8072900] 'range keys from in-memory index tree'  (duration: 254.310824ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:52:00.877082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.272012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-jjnrc\" ","response":"range_response_count:1 size:5069"}
{"level":"info","ts":"2026-03-25T16:52:00.877176Z","caller":"traceutil/trace.go:171","msg":"trace[821181432] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-jjnrc; range_end:; response_count:1; response_revision:982; }","duration":"191.404226ms","start":"2026-03-25T16:52:00.685746Z","end":"2026-03-25T16:52:00.877151Z","steps":["trace[821181432] 'range keys from in-memory index tree'  (duration: 191.087686ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:00.883223Z","caller":"traceutil/trace.go:171","msg":"trace[182742775] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"133.057034ms","start":"2026-03-25T16:52:00.749934Z","end":"2026-03-25T16:52:00.882991Z","steps":["trace[182742775] 'process raft request'  (duration: 132.894439ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:02.64979Z","caller":"traceutil/trace.go:171","msg":"trace[997576454] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"194.061006ms","start":"2026-03-25T16:52:02.455705Z","end":"2026-03-25T16:52:02.649766Z","steps":["trace[997576454] 'process raft request'  (duration: 193.977394ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:02.649787Z","caller":"traceutil/trace.go:171","msg":"trace[1261144338] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"194.696496ms","start":"2026-03-25T16:52:02.455053Z","end":"2026-03-25T16:52:02.649749Z","steps":["trace[1261144338] 'process raft request'  (duration: 96.115451ms)","trace[1261144338] 'compare'  (duration: 98.371858ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:52:02.650065Z","caller":"traceutil/trace.go:171","msg":"trace[680735746] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"194.062297ms","start":"2026-03-25T16:52:02.45597Z","end":"2026-03-25T16:52:02.650032Z","steps":["trace[680735746] 'process raft request'  (duration: 193.756218ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:11.08411Z","caller":"traceutil/trace.go:171","msg":"trace[555180513] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"156.220547ms","start":"2026-03-25T16:52:10.927859Z","end":"2026-03-25T16:52:11.084079Z","steps":["trace[555180513] 'process raft request'  (duration: 156.059162ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:26.925124Z","caller":"traceutil/trace.go:171","msg":"trace[1114474332] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1113; }","duration":"129.361759ms","start":"2026-03-25T16:52:26.795742Z","end":"2026-03-25T16:52:26.925104Z","steps":["trace[1114474332] 'read index received'  (duration: 129.307138ms)","trace[1114474332] 'applied index is now lower than readState.Index'  (duration: 53.491µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:52:26.925257Z","caller":"traceutil/trace.go:171","msg":"trace[7674164] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"129.736219ms","start":"2026-03-25T16:52:26.795478Z","end":"2026-03-25T16:52:26.925214Z","steps":["trace[7674164] 'process raft request'  (duration: 129.498333ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:52:26.925295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.531904ms","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-03-25T16:52:26.925436Z","caller":"traceutil/trace.go:171","msg":"trace[495066009] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1076; }","duration":"129.691128ms","start":"2026-03-25T16:52:26.795735Z","end":"2026-03-25T16:52:26.925426Z","steps":["trace[495066009] 'agreement among raft nodes before linearized reading'  (duration: 129.451132ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:26.933793Z","caller":"traceutil/trace.go:171","msg":"trace[2099923387] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"137.937554ms","start":"2026-03-25T16:52:26.795839Z","end":"2026-03-25T16:52:26.933776Z","steps":["trace[2099923387] 'process raft request'  (duration: 137.817311ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:35.223828Z","caller":"traceutil/trace.go:171","msg":"trace[242872341] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"193.431765ms","start":"2026-03-25T16:52:35.030364Z","end":"2026-03-25T16:52:35.223796Z","steps":["trace[242872341] 'process raft request'  (duration: 147.385494ms)","trace[242872341] 'compare'  (duration: 45.810315ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:52:37.281422Z","caller":"traceutil/trace.go:171","msg":"trace[543973364] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"231.947159ms","start":"2026-03-25T16:52:37.049449Z","end":"2026-03-25T16:52:37.281396Z","steps":["trace[543973364] 'process raft request'  (duration: 176.447721ms)","trace[543973364] 'compare'  (duration: 55.16503ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:52:39.237588Z","caller":"traceutil/trace.go:171","msg":"trace[249712523] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"202.962944ms","start":"2026-03-25T16:52:39.034601Z","end":"2026-03-25T16:52:39.237564Z","steps":["trace[249712523] 'process raft request'  (duration: 202.79109ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:52:39.424999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.130815ms","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-03-25T16:52:39.4251Z","caller":"traceutil/trace.go:171","msg":"trace[15102971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1116; }","duration":"140.286029ms","start":"2026-03-25T16:52:39.284791Z","end":"2026-03-25T16:52:39.425077Z","steps":["trace[15102971] 'range keys from in-memory index tree'  (duration: 139.89319ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:39.425129Z","caller":"traceutil/trace.go:171","msg":"trace[1328073275] linearizableReadLoop","detail":"{readStateIndex:1157; appliedIndex:1156; }","duration":"109.567848ms","start":"2026-03-25T16:52:39.315539Z","end":"2026-03-25T16:52:39.425107Z","steps":["trace[1328073275] 'read index received'  (duration: 109.411794ms)","trace[1328073275] 'applied index is now lower than readState.Index'  (duration: 155.154µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:52:39.425275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.723172ms","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-03-25T16:52:39.425236Z","caller":"traceutil/trace.go:171","msg":"trace[567110533] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"136.243829ms","start":"2026-03-25T16:52:39.288973Z","end":"2026-03-25T16:52:39.425217Z","steps":["trace[567110533] 'process raft request'  (duration: 135.857249ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:39.425294Z","caller":"traceutil/trace.go:171","msg":"trace[1235096358] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1117; }","duration":"109.788173ms","start":"2026-03-25T16:52:39.3155Z","end":"2026-03-25T16:52:39.425288Z","steps":["trace[1235096358] 'agreement among raft nodes before linearized reading'  (duration: 109.673861ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:52:39.703601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.445502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:52:39.703719Z","caller":"traceutil/trace.go:171","msg":"trace[1962809528] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1119; }","duration":"117.650797ms","start":"2026-03-25T16:52:39.586048Z","end":"2026-03-25T16:52:39.703699Z","steps":["trace[1962809528] 'count revisions from in-memory index tree'  (duration: 117.337459ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:52:41.087002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.376679ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325257801 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1115 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:52:41.087111Z","caller":"traceutil/trace.go:171","msg":"trace[1555573626] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"275.799447ms","start":"2026-03-25T16:52:40.811292Z","end":"2026-03-25T16:52:41.087092Z","steps":["trace[1555573626] 'process raft request'  (duration: 127.248524ms)","trace[1555573626] 'compare'  (duration: 148.272216ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:52:41.592999Z","caller":"traceutil/trace.go:171","msg":"trace[1997027205] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"306.589757ms","start":"2026-03-25T16:52:41.286389Z","end":"2026-03-25T16:52:41.592979Z","steps":["trace[1997027205] 'process raft request'  (duration: 209.6193ms)","trace[1997027205] 'compare'  (duration: 96.892615ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:52:41.593105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:52:41.286378Z","time spent":"306.674959ms","remote":"127.0.0.1:57630","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:1116 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-25T16:52:41.612065Z","caller":"traceutil/trace.go:171","msg":"trace[1403785347] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1163; }","duration":"106.944412ms","start":"2026-03-25T16:52:41.505102Z","end":"2026-03-25T16:52:41.612046Z","steps":["trace[1403785347] 'read index received'  (duration: 106.720217ms)","trace[1403785347] 'applied index is now lower than readState.Index'  (duration: 223.515µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:52:41.612153Z","caller":"traceutil/trace.go:171","msg":"trace[1948799046] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"181.149068ms","start":"2026-03-25T16:52:41.430998Z","end":"2026-03-25T16:52:41.612147Z","steps":["trace[1948799046] 'process raft request'  (duration: 181.017825ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:52:41.612325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.208548ms","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-03-25T16:52:41.612347Z","caller":"traceutil/trace.go:171","msg":"trace[555552472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1124; }","duration":"107.27499ms","start":"2026-03-25T16:52:41.505066Z","end":"2026-03-25T16:52:41.612341Z","steps":["trace[555552472] 'agreement among raft nodes before linearized reading'  (duration: 107.180468ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:52:41.612304Z","caller":"traceutil/trace.go:171","msg":"trace[1011453223] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"289.65615ms","start":"2026-03-25T16:52:41.322618Z","end":"2026-03-25T16:52:41.612274Z","steps":["trace[1011453223] 'process raft request'  (duration: 289.292161ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:52:41.751625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.859321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:52:41.751712Z","caller":"traceutil/trace.go:171","msg":"trace[622944324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1126; }","duration":"130.956173ms","start":"2026-03-25T16:52:41.620731Z","end":"2026-03-25T16:52:41.751687Z","steps":["trace[622944324] 'agreement among raft nodes before linearized reading'  (duration: 72.083774ms)","trace[622944324] 'range keys from in-memory index tree'  (duration: 58.743906ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:52:57.075647Z","caller":"traceutil/trace.go:171","msg":"trace[1276067615] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"182.497128ms","start":"2026-03-25T16:52:56.893118Z","end":"2026-03-25T16:52:57.075615Z","steps":["trace[1276067615] 'process raft request'  (duration: 182.237472ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:07.485336Z","caller":"traceutil/trace.go:171","msg":"trace[1591576873] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"174.22698ms","start":"2026-03-25T16:53:07.311075Z","end":"2026-03-25T16:53:07.485302Z","steps":["trace[1591576873] 'process raft request'  (duration: 174.032096ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:08.144313Z","caller":"traceutil/trace.go:171","msg":"trace[1218061739] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1253; }","duration":"350.762084ms","start":"2026-03-25T16:53:07.793532Z","end":"2026-03-25T16:53:08.144294Z","steps":["trace[1218061739] 'read index received'  (duration: 350.59037ms)","trace[1218061739] 'applied index is now lower than readState.Index'  (duration: 170.894µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:08.144371Z","caller":"traceutil/trace.go:171","msg":"trace[559358105] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"389.07397ms","start":"2026-03-25T16:53:07.755271Z","end":"2026-03-25T16:53:08.144345Z","steps":["trace[559358105] 'process raft request'  (duration: 388.894926ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:08.144493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:07.755244Z","time spent":"389.174903ms","remote":"127.0.0.1:57630","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:1202 > 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-03-25T16:53:08.144505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.961358ms","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-03-25T16:53:08.14464Z","caller":"traceutil/trace.go:171","msg":"trace[589305072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1208; }","duration":"351.04921ms","start":"2026-03-25T16:53:07.793498Z","end":"2026-03-25T16:53:08.144547Z","steps":["trace[589305072] 'agreement among raft nodes before linearized reading'  (duration: 350.909447ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:08.144717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.231434ms","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":"warn","ts":"2026-03-25T16:53:08.1447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:07.79348Z","time spent":"351.203644ms","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-25T16:53:08.144782Z","caller":"traceutil/trace.go:171","msg":"trace[1971266168] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1208; }","duration":"278.326215ms","start":"2026-03-25T16:53:07.866441Z","end":"2026-03-25T16:53:08.144767Z","steps":["trace[1971266168] 'agreement among raft nodes before linearized reading'  (duration: 278.174482ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:08.144645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.880261ms","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-03-25T16:53:08.144879Z","caller":"traceutil/trace.go:171","msg":"trace[2141588792] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1208; }","duration":"326.145137ms","start":"2026-03-25T16:53:07.818719Z","end":"2026-03-25T16:53:08.144864Z","steps":["trace[2141588792] 'agreement among raft nodes before linearized reading'  (duration: 325.797139ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:08.144791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.138717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329948"}
{"level":"info","ts":"2026-03-25T16:53:08.144981Z","caller":"traceutil/trace.go:171","msg":"trace[1621119037] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1208; }","duration":"150.366483ms","start":"2026-03-25T16:53:07.994589Z","end":"2026-03-25T16:53:08.144956Z","steps":["trace[1621119037] 'agreement among raft nodes before linearized reading'  (duration: 149.974884ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:08.145001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:07.818699Z","time spent":"326.28107ms","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-25T16:53:18.538643Z","caller":"traceutil/trace.go:171","msg":"trace[1685759960] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"119.338053ms","start":"2026-03-25T16:53:18.419276Z","end":"2026-03-25T16:53:18.538614Z","steps":["trace[1685759960] 'process raft request'  (duration: 118.956145ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:18.53967Z","caller":"traceutil/trace.go:171","msg":"trace[480663759] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"118.370782ms","start":"2026-03-25T16:53:18.421254Z","end":"2026-03-25T16:53:18.539625Z","steps":["trace[480663759] 'process raft request'  (duration: 118.194339ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:22.951597Z","caller":"traceutil/trace.go:171","msg":"trace[133437369] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1316; }","duration":"327.368331ms","start":"2026-03-25T16:53:22.624207Z","end":"2026-03-25T16:53:22.951576Z","steps":["trace[133437369] 'read index received'  (duration: 327.125135ms)","trace[133437369] 'applied index is now lower than readState.Index'  (duration: 242.175µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:53:22.951772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.546414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:53:22.951821Z","caller":"traceutil/trace.go:171","msg":"trace[1995662232] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"327.644476ms","start":"2026-03-25T16:53:22.624148Z","end":"2026-03-25T16:53:22.951792Z","steps":["trace[1995662232] 'agreement among raft nodes before linearized reading'  (duration: 327.519294ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:22.951862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:22.62412Z","time spent":"327.734639ms","remote":"127.0.0.1:57380","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-03-25T16:53:22.951849Z","caller":"traceutil/trace.go:171","msg":"trace[1472619904] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"395.33956ms","start":"2026-03-25T16:53:22.556483Z","end":"2026-03-25T16:53:22.951822Z","steps":["trace[1472619904] 'process raft request'  (duration: 394.937011ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:22.952026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:22.556459Z","time spent":"395.463493ms","remote":"127.0.0.1:57630","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:1250 > 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-03-25T16:53:23.65435Z","caller":"traceutil/trace.go:171","msg":"trace[741691879] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"274.24199ms","start":"2026-03-25T16:53:23.380015Z","end":"2026-03-25T16:53:23.654257Z","steps":["trace[741691879] 'process raft request'  (duration: 274.017305ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:24.179627Z","caller":"traceutil/trace.go:171","msg":"trace[352250063] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"464.256661ms","start":"2026-03-25T16:53:23.715351Z","end":"2026-03-25T16:53:24.179607Z","steps":["trace[352250063] 'process raft request'  (duration: 385.281598ms)","trace[352250063] 'compare'  (duration: 78.890801ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:53:24.179798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:23.715341Z","time spent":"464.347363ms","remote":"127.0.0.1:57630","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:1256 > 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":"info","ts":"2026-03-25T16:53:25.773087Z","caller":"traceutil/trace.go:171","msg":"trace[1866796425] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"110.241116ms","start":"2026-03-25T16:53:25.662825Z","end":"2026-03-25T16:53:25.773066Z","steps":["trace[1866796425] 'process raft request'  (duration: 110.099413ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:29.291798Z","caller":"traceutil/trace.go:171","msg":"trace[779260237] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1344; }","duration":"260.840897ms","start":"2026-03-25T16:53:29.030936Z","end":"2026-03-25T16:53:29.291777Z","steps":["trace[779260237] 'read index received'  (duration: 260.627472ms)","trace[779260237] 'applied index is now lower than readState.Index'  (duration: 212.265µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:29.291844Z","caller":"traceutil/trace.go:171","msg":"trace[878607282] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"301.06725ms","start":"2026-03-25T16:53:28.990754Z","end":"2026-03-25T16:53:29.291821Z","steps":["trace[878607282] 'process raft request'  (duration: 300.867605ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:29.291965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.0246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-03-25T16:53:29.291976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:28.990726Z","time spent":"301.164052ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3872,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ee083cea-7101-4793-badc-330a7bf4e8bc\" mod_revision:1286 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ee083cea-7101-4793-badc-330a7bf4e8bc\" value_size:3772 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ee083cea-7101-4793-badc-330a7bf4e8bc\" > >"}
{"level":"info","ts":"2026-03-25T16:53:29.291999Z","caller":"traceutil/trace.go:171","msg":"trace[1437769231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1294; }","duration":"261.116392ms","start":"2026-03-25T16:53:29.030872Z","end":"2026-03-25T16:53:29.291988Z","steps":["trace[1437769231] 'agreement among raft nodes before linearized reading'  (duration: 260.99589ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:29.589143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.963443ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325258271 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1287 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:53:29.58926Z","caller":"traceutil/trace.go:171","msg":"trace[1534778732] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1345; }","duration":"237.442405ms","start":"2026-03-25T16:53:29.3518Z","end":"2026-03-25T16:53:29.589242Z","steps":["trace[1534778732] 'read index received'  (duration: 5.383616ms)","trace[1534778732] 'applied index is now lower than readState.Index'  (duration: 232.055189ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:29.589352Z","caller":"traceutil/trace.go:171","msg":"trace[1671255796] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"292.478955ms","start":"2026-03-25T16:53:29.296861Z","end":"2026-03-25T16:53:29.58934Z","steps":["trace[1671255796] 'process raft request'  (duration: 172.231085ms)","trace[1671255796] 'compare'  (duration: 119.835721ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:53:29.589676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.860643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ee083cea-7101-4793-badc-330a7bf4e8bc\" ","response":"range_response_count:1 size:3887"}
{"level":"info","ts":"2026-03-25T16:53:29.589739Z","caller":"traceutil/trace.go:171","msg":"trace[163800374] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ee083cea-7101-4793-badc-330a7bf4e8bc; range_end:; response_count:1; response_revision:1296; }","duration":"237.970456ms","start":"2026-03-25T16:53:29.351753Z","end":"2026-03-25T16:53:29.589724Z","steps":["trace[163800374] 'agreement among raft nodes before linearized reading'  (duration: 237.783962ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:29.813112Z","caller":"traceutil/trace.go:171","msg":"trace[12522053] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1347; }","duration":"189.969665ms","start":"2026-03-25T16:53:29.623116Z","end":"2026-03-25T16:53:29.813086Z","steps":["trace[12522053] 'read index received'  (duration: 148.498976ms)","trace[12522053] 'applied index is now lower than readState.Index'  (duration: 41.469369ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:29.813143Z","caller":"traceutil/trace.go:171","msg":"trace[57034029] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"218.420835ms","start":"2026-03-25T16:53:29.594695Z","end":"2026-03-25T16:53:29.813116Z","steps":["trace[57034029] 'process raft request'  (duration: 177.011097ms)","trace[57034029] 'compare'  (duration: 41.247824ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:53:29.813444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.152339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:53:29.813523Z","caller":"traceutil/trace.go:171","msg":"trace[918457876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1297; }","duration":"190.446155ms","start":"2026-03-25T16:53:29.623064Z","end":"2026-03-25T16:53:29.81351Z","steps":["trace[918457876] 'agreement among raft nodes before linearized reading'  (duration: 190.160379ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:30.089975Z","caller":"traceutil/trace.go:171","msg":"trace[872528153] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"271.542793ms","start":"2026-03-25T16:53:29.818413Z","end":"2026-03-25T16:53:30.089955Z","steps":["trace[872528153] 'process raft request'  (duration: 271.430511ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:30.15793Z","caller":"traceutil/trace.go:171","msg":"trace[256147397] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1350; }","duration":"153.910296ms","start":"2026-03-25T16:53:30.003987Z","end":"2026-03-25T16:53:30.157897Z","steps":["trace[256147397] 'read index received'  (duration: 85.976661ms)","trace[256147397] 'applied index is now lower than readState.Index'  (duration: 67.932445ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:53:30.15814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.13609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:53:30.158034Z","caller":"traceutil/trace.go:171","msg":"trace[1619485332] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"280.098113ms","start":"2026-03-25T16:53:29.877897Z","end":"2026-03-25T16:53:30.157995Z","steps":["trace[1619485332] 'process raft request'  (duration: 279.855488ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:30.1582Z","caller":"traceutil/trace.go:171","msg":"trace[2137160251] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1300; }","duration":"154.247503ms","start":"2026-03-25T16:53:30.003936Z","end":"2026-03-25T16:53:30.158183Z","steps":["trace[2137160251] 'agreement among raft nodes before linearized reading'  (duration: 154.12157ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:30.394355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.253195ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325258284 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/test-pvc.18a023cb829a5661\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/test-pvc.18a023cb829a5661\" value_size:684 lease:5750706560325258171 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:53:30.39449Z","caller":"traceutil/trace.go:171","msg":"trace[171515136] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"230.824902ms","start":"2026-03-25T16:53:30.163644Z","end":"2026-03-25T16:53:30.394469Z","steps":["trace[171515136] 'process raft request'  (duration: 74.353472ms)","trace[171515136] 'compare'  (duration: 155.921188ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:30.717316Z","caller":"traceutil/trace.go:171","msg":"trace[1787207846] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"363.953673ms","start":"2026-03-25T16:53:30.353336Z","end":"2026-03-25T16:53:30.71729Z","steps":["trace[1787207846] 'process raft request'  (duration: 363.888442ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:30.717485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:30.353298Z","time spent":"364.103096ms","remote":"127.0.0.1:57630","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:1291 > 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":"info","ts":"2026-03-25T16:53:30.717592Z","caller":"traceutil/trace.go:171","msg":"trace[741781492] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"552.944208ms","start":"2026-03-25T16:53:30.164555Z","end":"2026-03-25T16:53:30.717499Z","steps":["trace[741781492] 'process raft request'  (duration: 467.728514ms)","trace[741781492] 'compare'  (duration: 84.778975ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:30.71766Z","caller":"traceutil/trace.go:171","msg":"trace[1213229995] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1351; }","duration":"516.942968ms","start":"2026-03-25T16:53:30.200683Z","end":"2026-03-25T16:53:30.717626Z","steps":["trace[1213229995] 'read index received'  (duration: 37.34933ms)","trace[1213229995] 'applied index is now lower than readState.Index'  (duration: 479.587788ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:53:30.71804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:30.164525Z","time spent":"553.167884ms","remote":"127.0.0.1:57524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1240,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/persistentvolumes/pvc-ee083cea-7101-4793-badc-330a7bf4e8bc\" mod_revision:1300 > success:<request_put:<key:\"/registry/persistentvolumes/pvc-ee083cea-7101-4793-badc-330a7bf4e8bc\" value_size:1164 >> failure:<request_range:<key:\"/registry/persistentvolumes/pvc-ee083cea-7101-4793-badc-330a7bf4e8bc\" > >"}
{"level":"warn","ts":"2026-03-25T16:53:30.718545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.468586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-25T16:53:30.718172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.468439ms","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-03-25T16:53:30.718714Z","caller":"traceutil/trace.go:171","msg":"trace[522966541] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1303; }","duration":"224.730691ms","start":"2026-03-25T16:53:30.493969Z","end":"2026-03-25T16:53:30.7187Z","steps":["trace[522966541] 'agreement among raft nodes before linearized reading'  (duration: 224.386374ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:30.718786Z","caller":"traceutil/trace.go:171","msg":"trace[1058182222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1303; }","duration":"518.116403ms","start":"2026-03-25T16:53:30.200631Z","end":"2026-03-25T16:53:30.718747Z","steps":["trace[1058182222] 'agreement among raft nodes before linearized reading'  (duration: 517.178083ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:30.719695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:30.200611Z","time spent":"519.042994ms","remote":"127.0.0.1:57630","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-03-25T16:53:30.991784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.315412ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325258289 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1293 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:53:30.991921Z","caller":"traceutil/trace.go:171","msg":"trace[42981554] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"268.07972ms","start":"2026-03-25T16:53:30.723817Z","end":"2026-03-25T16:53:30.991897Z","steps":["trace[42981554] 'process raft request'  (duration: 114.563543ms)","trace[42981554] 'compare'  (duration: 153.147829ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:31.018681Z","caller":"traceutil/trace.go:171","msg":"trace[2017122304] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"294.71946ms","start":"2026-03-25T16:53:30.723927Z","end":"2026-03-25T16:53:31.018647Z","steps":["trace[2017122304] 'process raft request'  (duration: 294.432824ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:31.01873Z","caller":"traceutil/trace.go:171","msg":"trace[324666865] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1354; }","duration":"285.920131ms","start":"2026-03-25T16:53:30.732778Z","end":"2026-03-25T16:53:31.018698Z","steps":["trace[324666865] 'read index received'  (duration: 105.654162ms)","trace[324666865] 'applied index is now lower than readState.Index'  (duration: 180.264869ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:31.018934Z","caller":"traceutil/trace.go:171","msg":"trace[1470016743] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"294.644988ms","start":"2026-03-25T16:53:30.724271Z","end":"2026-03-25T16:53:31.018916Z","steps":["trace[1470016743] 'process raft request'  (duration: 294.28167ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:31.018994Z","caller":"traceutil/trace.go:171","msg":"trace[1256585488] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"294.310491ms","start":"2026-03-25T16:53:30.724657Z","end":"2026-03-25T16:53:31.018968Z","steps":["trace[1256585488] 'process raft request'  (duration: 293.962354ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:31.019161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.33217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:53:31.019252Z","caller":"traceutil/trace.go:171","msg":"trace[447863266] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1307; }","duration":"286.490554ms","start":"2026-03-25T16:53:30.732739Z","end":"2026-03-25T16:53:31.01923Z","steps":["trace[447863266] 'agreement among raft nodes before linearized reading'  (duration: 286.244619ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:31.2634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.011954ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325258294 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/persistentvolumeclaims/default/test-pvc\" mod_revision:1307 > success:<request_put:<key:\"/registry/persistentvolumeclaims/default/test-pvc\" value_size:1393 >> failure:<request_range:<key:\"/registry/persistentvolumeclaims/default/test-pvc\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:53:31.263645Z","caller":"traceutil/trace.go:171","msg":"trace[857750300] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"240.675553ms","start":"2026-03-25T16:53:31.022931Z","end":"2026-03-25T16:53:31.263607Z","steps":["trace[857750300] 'process raft request'  (duration: 69.355392ms)","trace[857750300] 'compare'  (duration: 170.844761ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:31.263826Z","caller":"traceutil/trace.go:171","msg":"trace[36734474] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"118.377709ms","start":"2026-03-25T16:53:31.145428Z","end":"2026-03-25T16:53:31.263806Z","steps":["trace[36734474] 'process raft request'  (duration: 118.106374ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:31.599914Z","caller":"traceutil/trace.go:171","msg":"trace[1332587343] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1361; }","duration":"273.049995ms","start":"2026-03-25T16:53:31.326828Z","end":"2026-03-25T16:53:31.599878Z","steps":["trace[1332587343] 'read index received'  (duration: 273.029364ms)","trace[1332587343] 'applied index is now lower than readState.Index'  (duration: 19.511µs)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:31.599955Z","caller":"traceutil/trace.go:171","msg":"trace[347839828] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"329.004911ms","start":"2026-03-25T16:53:31.270918Z","end":"2026-03-25T16:53:31.599923Z","steps":["trace[347839828] 'process raft request'  (duration: 328.831407ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:31.600021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.182637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:1 size:199"}
{"level":"warn","ts":"2026-03-25T16:53:31.600081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:31.270902Z","time spent":"329.119253ms","remote":"127.0.0.1:57452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":656,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/default/test-pvc-pod.18a023cbc48af5bd\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/test-pvc-pod.18a023cbc48af5bd\" value_size:584 lease:5750706560325258171 >> failure:<>"}
{"level":"info","ts":"2026-03-25T16:53:31.600084Z","caller":"traceutil/trace.go:171","msg":"trace[476482553] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:1; response_revision:1310; }","duration":"331.276079ms","start":"2026-03-25T16:53:31.268791Z","end":"2026-03-25T16:53:31.600067Z","steps":["trace[476482553] 'agreement among raft nodes before linearized reading'  (duration: 331.097705ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:31.600143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:31.268781Z","time spent":"331.349271ms","remote":"127.0.0.1:57578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":222,"request content":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" "}
{"level":"warn","ts":"2026-03-25T16:53:31.600306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.622206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1536"}
{"level":"info","ts":"2026-03-25T16:53:31.600355Z","caller":"traceutil/trace.go:171","msg":"trace[247609137] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1310; }","duration":"332.054926ms","start":"2026-03-25T16:53:31.268288Z","end":"2026-03-25T16:53:31.600343Z","steps":["trace[247609137] 'agreement among raft nodes before linearized reading'  (duration: 331.687238ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:31.600379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:31.268269Z","time spent":"332.104486ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":1559,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "}
{"level":"info","ts":"2026-03-25T16:53:31.604257Z","caller":"traceutil/trace.go:171","msg":"trace[1458007120] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"276.504078ms","start":"2026-03-25T16:53:31.327741Z","end":"2026-03-25T16:53:31.604245Z","steps":["trace[1458007120] 'process raft request'  (duration: 276.398095ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:31.604686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.914025ms","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-03-25T16:53:31.604719Z","caller":"traceutil/trace.go:171","msg":"trace[1083456588] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1311; }","duration":"267.988737ms","start":"2026-03-25T16:53:31.336721Z","end":"2026-03-25T16:53:31.60471Z","steps":["trace[1083456588] 'agreement among raft nodes before linearized reading'  (duration: 267.920615ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:35.364393Z","caller":"traceutil/trace.go:171","msg":"trace[2070530009] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"633.83901ms","start":"2026-03-25T16:53:34.730531Z","end":"2026-03-25T16:53:35.36437Z","steps":["trace[2070530009] 'process raft request'  (duration: 633.693877ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:35.364532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:34.730511Z","time spent":"633.948732ms","remote":"127.0.0.1:57630","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:1317 > 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":"info","ts":"2026-03-25T16:53:35.366024Z","caller":"traceutil/trace.go:171","msg":"trace[14419719] linearizableReadLoop","detail":"{readStateIndex:1377; appliedIndex:1375; }","duration":"360.524184ms","start":"2026-03-25T16:53:35.005474Z","end":"2026-03-25T16:53:35.365998Z","steps":["trace[14419719] 'read index received'  (duration: 358.766666ms)","trace[14419719] 'applied index is now lower than readState.Index'  (duration: 1.756798ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:35.366115Z","caller":"traceutil/trace.go:171","msg":"trace[652104082] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"459.135809ms","start":"2026-03-25T16:53:34.906971Z","end":"2026-03-25T16:53:35.366107Z","steps":["trace[652104082] 'process raft request'  (duration: 458.925625ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:35.3662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:34.906945Z","time spent":"459.18887ms","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1276 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-25T16:53:35.366278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.809798ms","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-03-25T16:53:35.366354Z","caller":"traceutil/trace.go:171","msg":"trace[1507313633] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1325; }","duration":"288.91262ms","start":"2026-03-25T16:53:35.07743Z","end":"2026-03-25T16:53:35.366343Z","steps":["trace[1507313633] 'agreement among raft nodes before linearized reading'  (duration: 288.749447ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:35.366511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.031445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:53:35.366541Z","caller":"traceutil/trace.go:171","msg":"trace[1102705141] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1325; }","duration":"258.118757ms","start":"2026-03-25T16:53:35.108415Z","end":"2026-03-25T16:53:35.366533Z","steps":["trace[1102705141] 'agreement among raft nodes before linearized reading'  (duration: 258.052546ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:35.366574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.083784ms","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-03-25T16:53:35.366611Z","caller":"traceutil/trace.go:171","msg":"trace[207831821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1325; }","duration":"289.148506ms","start":"2026-03-25T16:53:35.077453Z","end":"2026-03-25T16:53:35.366602Z","steps":["trace[207831821] 'agreement among raft nodes before linearized reading'  (duration: 289.054184ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:35.367155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.662089ms","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-03-25T16:53:35.36725Z","caller":"traceutil/trace.go:171","msg":"trace[239795698] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1325; }","duration":"361.802171ms","start":"2026-03-25T16:53:35.005427Z","end":"2026-03-25T16:53:35.367229Z","steps":["trace[239795698] 'agreement among raft nodes before linearized reading'  (duration: 361.086266ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:35.367403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:35.005406Z","time spent":"361.979075ms","remote":"127.0.0.1:57630","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-03-25T16:53:35.479201Z","caller":"traceutil/trace.go:171","msg":"trace[1538203784] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"108.179604ms","start":"2026-03-25T16:53:35.370982Z","end":"2026-03-25T16:53:35.479162Z","steps":["trace[1538203784] 'process raft request'  (duration: 103.777791ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:35.479735Z","caller":"traceutil/trace.go:171","msg":"trace[276952148] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"108.517581ms","start":"2026-03-25T16:53:35.371202Z","end":"2026-03-25T16:53:35.47972Z","steps":["trace[276952148] 'process raft request'  (duration: 108.058522ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:37.668769Z","caller":"traceutil/trace.go:171","msg":"trace[462314712] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"121.544907ms","start":"2026-03-25T16:53:37.547195Z","end":"2026-03-25T16:53:37.66874Z","steps":["trace[462314712] 'process raft request'  (duration: 121.316003ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:37.711784Z","caller":"traceutil/trace.go:171","msg":"trace[1945443072] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"163.435052ms","start":"2026-03-25T16:53:37.548323Z","end":"2026-03-25T16:53:37.711758Z","steps":["trace[1945443072] 'process raft request'  (duration: 163.262819ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:39.694338Z","caller":"traceutil/trace.go:171","msg":"trace[84346419] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"233.092757ms","start":"2026-03-25T16:53:39.461216Z","end":"2026-03-25T16:53:39.694308Z","steps":["trace[84346419] 'process raft request'  (duration: 157.764191ms)","trace[84346419] 'compare'  (duration: 74.997479ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:39.694737Z","caller":"traceutil/trace.go:171","msg":"trace[360505920] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"176.721019ms","start":"2026-03-25T16:53:39.517998Z","end":"2026-03-25T16:53:39.694719Z","steps":["trace[360505920] 'process raft request'  (duration: 176.473564ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:39.865817Z","caller":"traceutil/trace.go:171","msg":"trace[458993350] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"126.993373ms","start":"2026-03-25T16:53:39.738794Z","end":"2026-03-25T16:53:39.865787Z","steps":["trace[458993350] 'process raft request'  (duration: 60.710467ms)","trace[458993350] 'compare'  (duration: 66.160643ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:43.823932Z","caller":"traceutil/trace.go:171","msg":"trace[142907791] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"111.987801ms","start":"2026-03-25T16:53:43.711908Z","end":"2026-03-25T16:53:43.823896Z","steps":["trace[142907791] 'process raft request'  (duration: 111.766946ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:44.583417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.442878ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325258441 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1352 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-25T16:53:44.583562Z","caller":"traceutil/trace.go:171","msg":"trace[1473661395] linearizableReadLoop","detail":"{readStateIndex:1414; appliedIndex:1413; }","duration":"661.396603ms","start":"2026-03-25T16:53:43.922108Z","end":"2026-03-25T16:53:44.583504Z","steps":["trace[1473661395] 'read index received'  (duration: 20.69µs)","trace[1473661395] 'applied index is now lower than readState.Index'  (duration: 661.374623ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:44.583571Z","caller":"traceutil/trace.go:171","msg":"trace[1750893869] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"700.850079ms","start":"2026-03-25T16:53:43.882667Z","end":"2026-03-25T16:53:44.583517Z","steps":["trace[1750893869] 'process raft request'  (duration: 34.89973ms)","trace[1750893869] 'compare'  (duration: 664.989659ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:53:44.58375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.16684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:53:44.583784Z","caller":"traceutil/trace.go:171","msg":"trace[1101323769] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1360; }","duration":"574.253762ms","start":"2026-03-25T16:53:44.00952Z","end":"2026-03-25T16:53:44.583774Z","steps":["trace[1101323769] 'agreement among raft nodes before linearized reading'  (duration: 574.15919ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:44.583817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:44.009493Z","time spent":"574.314754ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "}
{"level":"warn","ts":"2026-03-25T16:53:44.583842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.71263ms","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-03-25T16:53:44.583928Z","caller":"traceutil/trace.go:171","msg":"trace[1982724306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1360; }","duration":"661.831323ms","start":"2026-03-25T16:53:43.922078Z","end":"2026-03-25T16:53:44.58391Z","steps":["trace[1982724306] 'agreement among raft nodes before linearized reading'  (duration: 661.574387ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:44.58397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:43.922067Z","time spent":"661.893894ms","remote":"127.0.0.1:57630","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-03-25T16:53:44.583969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.181477ms","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-03-25T16:53:44.584032Z","caller":"traceutil/trace.go:171","msg":"trace[240056440] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1360; }","duration":"315.29406ms","start":"2026-03-25T16:53:44.268721Z","end":"2026-03-25T16:53:44.584015Z","steps":["trace[240056440] 'agreement among raft nodes before linearized reading'  (duration: 314.988114ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:44.584076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:44.268702Z","time spent":"315.362771ms","remote":"127.0.0.1:57630","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-03-25T16:53:44.584469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:43.882647Z","time spent":"701.015162ms","remote":"127.0.0.1:57630","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:1352 > 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-03-25T16:53:44.969961Z","caller":"traceutil/trace.go:171","msg":"trace[1721871190] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"382.049171ms","start":"2026-03-25T16:53:44.587888Z","end":"2026-03-25T16:53:44.969937Z","steps":["trace[1721871190] 'process raft request'  (duration: 381.307946ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:44.970211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:44.587871Z","time spent":"382.239636ms","remote":"127.0.0.1:57630","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:1354 > 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-03-25T16:53:44.972381Z","caller":"traceutil/trace.go:171","msg":"trace[1249555809] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"383.961771ms","start":"2026-03-25T16:53:44.588406Z","end":"2026-03-25T16:53:44.972368Z","steps":["trace[1249555809] 'process raft request'  (duration: 383.91752ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:44.97244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T16:53:44.588388Z","time spent":"384.023383ms","remote":"127.0.0.1:57630","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:1353 > 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-03-25T16:53:48.061997Z","caller":"traceutil/trace.go:171","msg":"trace[1369175316] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"116.715231ms","start":"2026-03-25T16:53:47.945259Z","end":"2026-03-25T16:53:48.061974Z","steps":["trace[1369175316] 'process raft request'  (duration: 107.640293ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:53:59.189575Z","caller":"traceutil/trace.go:171","msg":"trace[1268556917] linearizableReadLoop","detail":"{readStateIndex:1470; appliedIndex:1468; }","duration":"139.361923ms","start":"2026-03-25T16:53:59.050188Z","end":"2026-03-25T16:53:59.18955Z","steps":["trace[1268556917] 'read index received'  (duration: 61.504185ms)","trace[1268556917] 'applied index is now lower than readState.Index'  (duration: 77.856058ms)"],"step_count":2}
{"level":"info","ts":"2026-03-25T16:53:59.189609Z","caller":"traceutil/trace.go:171","msg":"trace[278449701] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"147.432099ms","start":"2026-03-25T16:53:59.042134Z","end":"2026-03-25T16:53:59.189566Z","steps":["trace[278449701] 'process raft request'  (duration: 88.191419ms)","trace[278449701] 'compare'  (duration: 59.082216ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:53:59.189849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.612849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node-bootstrapper\" ","response":"range_response_count:1 size:633"}
{"level":"info","ts":"2026-03-25T16:53:59.18996Z","caller":"traceutil/trace.go:171","msg":"trace[1716906921] range","detail":"{range_begin:/registry/clusterroles/system:node-bootstrapper; range_end:; response_count:1; response_revision:1413; }","duration":"139.781752ms","start":"2026-03-25T16:53:59.050152Z","end":"2026-03-25T16:53:59.189933Z","steps":["trace[1716906921] 'agreement among raft nodes before linearized reading'  (duration: 139.505556ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:53:59.871905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.679117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:persistent-volume-provisioner\" ","response":"range_response_count:1 size:812"}
{"level":"info","ts":"2026-03-25T16:53:59.871992Z","caller":"traceutil/trace.go:171","msg":"trace[886158163] range","detail":"{range_begin:/registry/clusterroles/system:persistent-volume-provisioner; range_end:; response_count:1; response_revision:1414; }","duration":"106.808769ms","start":"2026-03-25T16:53:59.765163Z","end":"2026-03-25T16:53:59.871971Z","steps":["trace[886158163] 'range keys from in-memory index tree'  (duration: 106.580015ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:54:00.201843Z","caller":"traceutil/trace.go:171","msg":"trace[540507070] transaction","detail":"{read_only:false; response_revision:1416; number_of_response:1; }","duration":"106.310147ms","start":"2026-03-25T16:54:00.095511Z","end":"2026-03-25T16:54:00.201821Z","steps":["trace[540507070] 'process raft request'  (duration: 105.99639ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:54:00.781526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.861446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:kube-dns\" ","response":"range_response_count:1 size:674"}
{"level":"info","ts":"2026-03-25T16:54:00.781591Z","caller":"traceutil/trace.go:171","msg":"trace[1418277501] range","detail":"{range_begin:/registry/clusterrolebindings/system:kube-dns; range_end:; response_count:1; response_revision:1418; }","duration":"100.973377ms","start":"2026-03-25T16:54:00.680603Z","end":"2026-03-25T16:54:00.781577Z","steps":["trace[1418277501] 'range keys from in-memory index tree'  (duration: 100.745193ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-25T16:54:16.96584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.335515ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5750706560325259767 > lease_revoke:<id:4fce9d25e7b20ed2>","response":"size:28"}
{"level":"info","ts":"2026-03-25T16:54:16.966058Z","caller":"traceutil/trace.go:171","msg":"trace[1457042371] linearizableReadLoop","detail":"{readStateIndex:1531; appliedIndex:1530; }","duration":"290.348925ms","start":"2026-03-25T16:54:16.675655Z","end":"2026-03-25T16:54:16.966004Z","steps":["trace[1457042371] 'read index received'  (duration: 56.735255ms)","trace[1457042371] 'applied index is now lower than readState.Index'  (duration: 233.6118ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-25T16:54:16.96635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.61218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-25T16:54:16.966445Z","caller":"traceutil/trace.go:171","msg":"trace[537122174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1470; }","duration":"290.813674ms","start":"2026-03-25T16:54:16.675613Z","end":"2026-03-25T16:54:16.966427Z","steps":["trace[537122174] 'agreement among raft nodes before linearized reading'  (duration: 290.557509ms)"],"step_count":1}
{"level":"info","ts":"2026-03-25T16:54:18.247756Z","caller":"traceutil/trace.go:171","msg":"trace[778475721] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"108.335202ms","start":"2026-03-25T16:54:18.139325Z","end":"2026-03-25T16:54:18.24766Z","steps":["trace[778475721] 'process raft request'  (duration: 108.135858ms)"],"step_count":1}