{"level":"warn","ts":"2026-02-17T19:55:43.233854Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-17T19:55:43.233965Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-02-17T19:55:43.234198Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-17T19:55:43.23423Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]}
{"level":"info","ts":"2026-02-17T19:55:43.234275Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-17T19:55:43.234918Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]}
{"level":"info","ts":"2026-02-17T19:55:43.235034Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-02-17T19:55:43.242319Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.037661ms"}
{"level":"info","ts":"2026-02-17T19:55:43.257957Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"}
{"level":"info","ts":"2026-02-17T19:55:43.258178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-17T19:55:43.258248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"}
{"level":"info","ts":"2026-02-17T19:55:43.258281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-17T19:55:43.258436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"}
{"level":"info","ts":"2026-02-17T19:55:43.258516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"}
{"level":"warn","ts":"2026-02-17T19:55:43.268695Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-17T19:55:43.272323Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-17T19:55:43.276499Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-02-17T19:55:43.289248Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-17T19:55:43.291192Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-17T19:55:43.291683Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-17T19:55:43.291748Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-17T19:55:43.291762Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-17T19:55:43.297775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"}
{"level":"info","ts":"2026-02-17T19:55:43.297959Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]}
{"level":"info","ts":"2026-02-17T19:55:43.314644Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-17T19:55:43.314992Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-17T19:55:43.314838Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"}
{"level":"info","ts":"2026-02-17T19:55:43.315972Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"}
{"level":"info","ts":"2026-02-17T19:55:43.315886Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-17T19:55:43.765184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-17T19:55:43.76577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-17T19:55:43.765897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"}
{"level":"info","ts":"2026-02-17T19:55:43.766157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"}
{"level":"info","ts":"2026-02-17T19:55:43.766235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"}
{"level":"info","ts":"2026-02-17T19:55:43.766401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"}
{"level":"info","ts":"2026-02-17T19:55:43.766547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"}
{"level":"info","ts":"2026-02-17T19:55:43.782574Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-17T19:55:43.783688Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-17T19:55:43.783711Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-17T19:55:43.78493Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-17T19:55:43.786534Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-17T19:55:43.792266Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-17T19:55:43.792301Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-17T19:55:43.792429Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"}
{"level":"info","ts":"2026-02-17T19:55:43.814879Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-17T19:55:43.814968Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-17T19:55:43.815064Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-17T19:55:46.136699Z","caller":"traceutil/trace.go:171","msg":"trace[117964786] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"484.223932ms","start":"2026-02-17T19:55:45.652456Z","end":"2026-02-17T19:55:46.13668Z","steps":["trace[117964786] 'process raft request'  (duration: 484.027658ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.140603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.652448Z","time spent":"484.328884ms","remote":"127.0.0.1:44410","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-02-17T19:55:46.727881Z","caller":"traceutil/trace.go:171","msg":"trace[966615751] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.033608943s","start":"2026-02-17T19:55:45.694259Z","end":"2026-02-17T19:55:46.727868Z","steps":["trace[966615751] 'process raft request'  (duration: 1.033387478s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.728034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.694252Z","time spent":"1.033705835s","remote":"127.0.0.1:44874","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-02-17T19:55:46.727788Z","caller":"traceutil/trace.go:171","msg":"trace[1135572252] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"1.069392977s","start":"2026-02-17T19:55:45.658371Z","end":"2026-02-17T19:55:46.727764Z","steps":["trace[1135572252] 'read index received'  (duration: 479.933663ms)","trace[1135572252] 'applied index is now lower than readState.Index'  (duration: 589.458564ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:55:46.728313Z","caller":"traceutil/trace.go:171","msg":"trace[1630872511] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.033860839s","start":"2026-02-17T19:55:45.694441Z","end":"2026-02-17T19:55:46.728302Z","steps":["trace[1630872511] 'process raft request'  (duration: 1.033227665s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.728361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.694433Z","time spent":"1.0339027s","remote":"127.0.0.1:44874","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-02-17T19:55:46.728444Z","caller":"traceutil/trace.go:171","msg":"trace[510161096] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.033337707s","start":"2026-02-17T19:55:45.695097Z","end":"2026-02-17T19:55:46.728434Z","steps":["trace[510161096] 'process raft request'  (duration: 1.0325912s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.728478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.695087Z","time spent":"1.033374798s","remote":"127.0.0.1:44874","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":"info","ts":"2026-02-17T19:55:46.729521Z","caller":"traceutil/trace.go:171","msg":"trace[895264181] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.076870768s","start":"2026-02-17T19:55:45.652632Z","end":"2026-02-17T19:55:46.729502Z","steps":["trace[895264181] 'process raft request'  (duration: 1.074574815s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.729597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.652627Z","time spent":"1.07692625s","remote":"127.0.0.1:44394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:67 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"info","ts":"2026-02-17T19:55:46.729808Z","caller":"traceutil/trace.go:171","msg":"trace[1123869283] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.035940267s","start":"2026-02-17T19:55:45.693832Z","end":"2026-02-17T19:55:46.729772Z","steps":["trace[1123869283] 'process raft request'  (duration: 1.033716036s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.729853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.693818Z","time spent":"1.036015068s","remote":"127.0.0.1:44874","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-02-17T19:55:46.729953Z","caller":"traceutil/trace.go:171","msg":"trace[1914414938] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.036039538s","start":"2026-02-17T19:55:45.693905Z","end":"2026-02-17T19:55:46.729945Z","steps":["trace[1914414938] 'process raft request'  (duration: 1.033675855s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.729992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.693899Z","time spent":"1.036072779s","remote":"127.0.0.1:44874","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-02-17T19:55:46.731792Z","caller":"traceutil/trace.go:171","msg":"trace[1148764708] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.035154219s","start":"2026-02-17T19:55:45.696613Z","end":"2026-02-17T19:55:46.731767Z","steps":["trace[1148764708] 'process raft request'  (duration: 1.031093786s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.731947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.696604Z","time spent":"1.03523982s","remote":"127.0.0.1:44628","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-gz5r9\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-gz5r9\" value_size:795 >> failure:<>"}
{"level":"info","ts":"2026-02-17T19:55:46.732303Z","caller":"traceutil/trace.go:171","msg":"trace[305649168] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"987.532852ms","start":"2026-02-17T19:55:45.744746Z","end":"2026-02-17T19:55:46.732279Z","steps":["trace[305649168] 'process raft request'  (duration: 982.987028ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.732364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.744725Z","time spent":"987.602794ms","remote":"127.0.0.1:44818","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-02-17T19:55:46.732616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074225037s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-17T19:55:46.732655Z","caller":"traceutil/trace.go:171","msg":"trace[1302438925] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"1.074285489s","start":"2026-02-17T19:55:45.658359Z","end":"2026-02-17T19:55:46.732645Z","steps":["trace[1302438925] 'agreement among raft nodes before linearized reading'  (duration: 1.074159316s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.732682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.658354Z","time spent":"1.074321539s","remote":"127.0.0.1:44754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-02-17T19:55:46.732829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03647853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-17T19:55:46.732855Z","caller":"traceutil/trace.go:171","msg":"trace[1708118847] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.03651515s","start":"2026-02-17T19:55:45.696331Z","end":"2026-02-17T19:55:46.732846Z","steps":["trace[1708118847] 'agreement among raft nodes before linearized reading'  (duration: 1.036478349s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.732881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.696323Z","time spent":"1.036552821s","remote":"127.0.0.1:44454","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-02-17T19:55:46.733126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.308849ms","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-02-17T19:55:46.733155Z","caller":"traceutil/trace.go:171","msg":"trace[2053019381] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"190.371481ms","start":"2026-02-17T19:55:46.542774Z","end":"2026-02-17T19:55:46.733146Z","steps":["trace[2053019381] 'agreement among raft nodes before linearized reading'  (duration: 190.327829ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.733289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.651147ms","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-02-17T19:55:46.733313Z","caller":"traceutil/trace.go:171","msg":"trace[285335941] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"190.72023ms","start":"2026-02-17T19:55:46.542585Z","end":"2026-02-17T19:55:46.733306Z","steps":["trace[285335941] 'agreement among raft nodes before linearized reading'  (duration: 190.682089ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.733427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.722224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-17T19:55:46.733451Z","caller":"traceutil/trace.go:171","msg":"trace[21519773] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"936.802627ms","start":"2026-02-17T19:55:45.796641Z","end":"2026-02-17T19:55:46.733443Z","steps":["trace[21519773] 'agreement among raft nodes before linearized reading'  (duration: 936.768256ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.733479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.796623Z","time spent":"936.845447ms","remote":"127.0.0.1:44454","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-02-17T19:55:46.733581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.735779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-17T19:55:46.733609Z","caller":"traceutil/trace.go:171","msg":"trace[2135763625] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"987.769249ms","start":"2026-02-17T19:55:45.745829Z","end":"2026-02-17T19:55:46.733598Z","steps":["trace[2135763625] 'agreement among raft nodes before linearized reading'  (duration: 987.734278ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.733638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.745824Z","time spent":"987.80388ms","remote":"127.0.0.1:44436","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-02-17T19:55:46.733748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.130009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-17T19:55:46.733771Z","caller":"traceutil/trace.go:171","msg":"trace[517900050] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"989.161621ms","start":"2026-02-17T19:55:45.744602Z","end":"2026-02-17T19:55:46.733764Z","steps":["trace[517900050] 'agreement among raft nodes before linearized reading'  (duration: 989.12992ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.733913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.744596Z","time spent":"989.302744ms","remote":"127.0.0.1:44454","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-02-17T19:55:46.735272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.442089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-17T19:55:46.73532Z","caller":"traceutil/trace.go:171","msg":"trace[318127232] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:0; response_revision:11; }","duration":"993.531151ms","start":"2026-02-17T19:55:45.741781Z","end":"2026-02-17T19:55:46.735312Z","steps":["trace[318127232] 'agreement among raft nodes before linearized reading'  (duration: 993.46837ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.735341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.741759Z","time spent":"993.577212ms","remote":"127.0.0.1:44378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.57\" "}
{"level":"warn","ts":"2026-02-17T19:55:46.735457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0300201s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-17T19:55:46.735481Z","caller":"traceutil/trace.go:171","msg":"trace[2127043684] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.030056401s","start":"2026-02-17T19:55:45.705418Z","end":"2026-02-17T19:55:46.735474Z","steps":["trace[2127043684] 'agreement among raft nodes before linearized reading'  (duration: 1.03001984s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.735498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.705413Z","time spent":"1.030081311s","remote":"127.0.0.1:44454","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-02-17T19:55:46.735463Z","caller":"traceutil/trace.go:171","msg":"trace[1511930193] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.041361271s","start":"2026-02-17T19:55:45.694092Z","end":"2026-02-17T19:55:46.735453Z","steps":["trace[1511930193] 'process raft request'  (duration: 1.033520872s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.735823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.694084Z","time spent":"1.041673498s","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2846,"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:2812 >> failure:<>"}
{"level":"warn","ts":"2026-02-17T19:55:46.735736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.030529202s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-17T19:55:46.736019Z","caller":"traceutil/trace.go:171","msg":"trace[751812943] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.03082826s","start":"2026-02-17T19:55:45.70518Z","end":"2026-02-17T19:55:46.736009Z","steps":["trace[751812943] 'agreement among raft nodes before linearized reading'  (duration: 1.030541112s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:55:46.73606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:55:45.705175Z","time spent":"1.030877261s","remote":"127.0.0.1:44454","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-02-17T19:56:01.893827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.686746ms","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-02-17T19:56:01.893913Z","caller":"traceutil/trace.go:171","msg":"trace[1742645228] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:403; }","duration":"113.785778ms","start":"2026-02-17T19:56:01.780115Z","end":"2026-02-17T19:56:01.8939Z","steps":["trace[1742645228] 'range keys from in-memory index tree'  (duration: 113.672835ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:01.893933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.146943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-17T19:56:01.894045Z","caller":"traceutil/trace.go:171","msg":"trace[1056276061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:403; }","duration":"133.290297ms","start":"2026-02-17T19:56:01.760721Z","end":"2026-02-17T19:56:01.894011Z","steps":["trace[1056276061] 'range keys from in-memory index tree'  (duration: 133.018ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:07.678626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.699658ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446602142 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:357 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T19:56:07.678762Z","caller":"traceutil/trace.go:171","msg":"trace[579673922] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"177.745589ms","start":"2026-02-17T19:56:07.500991Z","end":"2026-02-17T19:56:07.678737Z","steps":["trace[579673922] 'process raft request'  (duration: 39.802525ms)","trace[579673922] 'compare'  (duration: 137.601636ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:14.198116Z","caller":"traceutil/trace.go:171","msg":"trace[1167071088] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"189.701145ms","start":"2026-02-17T19:56:14.008398Z","end":"2026-02-17T19:56:14.1981Z","steps":["trace[1167071088] 'process raft request'  (duration: 189.356946ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:16.729524Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101165446602251,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T19:56:17.230082Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101165446602251,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-17T19:56:17.666796Z","caller":"traceutil/trace.go:171","msg":"trace[352220971] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"1.437874084s","start":"2026-02-17T19:56:16.228896Z","end":"2026-02-17T19:56:17.66677Z","steps":["trace[352220971] 'read index received'  (duration: 1.437658559s)","trace[352220971] 'applied index is now lower than readState.Index'  (duration: 214.335µs)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:17.667183Z","caller":"traceutil/trace.go:171","msg":"trace[2086838820] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"1.460241759s","start":"2026-02-17T19:56:16.206928Z","end":"2026-02-17T19:56:17.667169Z","steps":["trace[2086838820] 'process raft request'  (duration: 1.459708237s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:17.667397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:16.206902Z","time spent":"1.460348092s","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:465 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-17T19:56:17.671071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.442168423s","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-02-17T19:56:17.671132Z","caller":"traceutil/trace.go:171","msg":"trace[1629823805] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:470; }","duration":"1.442250065s","start":"2026-02-17T19:56:16.228866Z","end":"2026-02-17T19:56:17.671116Z","steps":["trace[1629823805] 'agreement among raft nodes before linearized reading'  (duration: 1.44162936s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:17.671167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:16.228856Z","time spent":"1.442303416s","remote":"127.0.0.1:44632","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-02-17T19:56:17.671489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18685766s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-17T19:56:17.671526Z","caller":"traceutil/trace.go:171","msg":"trace[1178965025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:470; }","duration":"1.186926632s","start":"2026-02-17T19:56:16.484589Z","end":"2026-02-17T19:56:17.671515Z","steps":["trace[1178965025] 'agreement among raft nodes before linearized reading'  (duration: 1.186714966s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:17.671555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:16.484573Z","time spent":"1.186974992s","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-17T19:56:17.671761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.86863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-17T19:56:17.671794Z","caller":"traceutil/trace.go:171","msg":"trace[180327724] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:470; }","duration":"289.929532ms","start":"2026-02-17T19:56:17.381855Z","end":"2026-02-17T19:56:17.671785Z","steps":["trace[180327724] 'agreement among raft nodes before linearized reading'  (duration: 289.87443ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:17.671932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.17992914s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:17.67196Z","caller":"traceutil/trace.go:171","msg":"trace[773564455] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:470; }","duration":"1.179975141s","start":"2026-02-17T19:56:16.491975Z","end":"2026-02-17T19:56:17.67195Z","steps":["trace[773564455] 'agreement among raft nodes before linearized reading'  (duration: 1.179935331s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:17.671985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:16.491968Z","time spent":"1.180011092s","remote":"127.0.0.1:44346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-17T19:56:19.228427Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.336075543s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-17T19:56:19.243611Z","caller":"traceutil/trace.go:171","msg":"trace[575225503] linearizableReadLoop","detail":"{readStateIndex:486; appliedIndex:483; }","duration":"1.557936128s","start":"2026-02-17T19:56:17.685655Z","end":"2026-02-17T19:56:19.243591Z","steps":["trace[575225503] 'read index received'  (duration: 206.685125ms)","trace[575225503] 'applied index is now lower than readState.Index'  (duration: 1.351250183s)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:19.243829Z","caller":"traceutil/trace.go:171","msg":"trace[645869840] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"1.569026193s","start":"2026-02-17T19:56:17.674787Z","end":"2026-02-17T19:56:19.243813Z","steps":["trace[645869840] 'process raft request'  (duration: 1.553985996s)","trace[645869840] 'compare'  (duration: 14.470494ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:56:19.243919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:17.674777Z","time spent":"1.569080255s","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:467 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T19:56:19.244092Z","caller":"traceutil/trace.go:171","msg":"trace[1684947463] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"1.568487051s","start":"2026-02-17T19:56:17.675594Z","end":"2026-02-17T19:56:19.244081Z","steps":["trace[1684947463] 'process raft request'  (duration: 1.567903067s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:19.244144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:17.675585Z","time spent":"1.568529841s","remote":"127.0.0.1:44632","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:466 > 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-02-17T19:56:19.244249Z","caller":"traceutil/trace.go:171","msg":"trace[761397592] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"1.466708189s","start":"2026-02-17T19:56:17.777533Z","end":"2026-02-17T19:56:19.244241Z","steps":["trace[761397592] 'process raft request'  (duration: 1.466025154s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:19.244295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:17.777525Z","time spent":"1.4667436s","remote":"127.0.0.1:44632","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:416 > 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-02-17T19:56:19.244405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.558745326s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:19.244432Z","caller":"traceutil/trace.go:171","msg":"trace[1756615080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:473; }","duration":"1.558770756s","start":"2026-02-17T19:56:17.685653Z","end":"2026-02-17T19:56:19.244424Z","steps":["trace[1756615080] 'agreement among raft nodes before linearized reading'  (duration: 1.558728565s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:19.244463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:17.685626Z","time spent":"1.558828877s","remote":"127.0.0.1:44346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-17T19:56:19.258176Z","caller":"traceutil/trace.go:171","msg":"trace[1847286661] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"1.341299883s","start":"2026-02-17T19:56:17.916859Z","end":"2026-02-17T19:56:19.258159Z","steps":["trace[1847286661] 'process raft request'  (duration: 1.341230362s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:19.258245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.480744752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-17T19:56:19.258275Z","caller":"traceutil/trace.go:171","msg":"trace[1360036741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:474; }","duration":"1.480800253s","start":"2026-02-17T19:56:17.777466Z","end":"2026-02-17T19:56:19.258266Z","steps":["trace[1360036741] 'agreement among raft nodes before linearized reading'  (duration: 1.48069115s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:19.258274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:17.916842Z","time spent":"1.341385435s","remote":"127.0.0.1:44378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.57\" mod_revision:415 > success:<request_put:<key:\"/registry/masterleases/199.204.45.57\" value_size:66 lease:4098729128591826448 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.57\" > >"}
{"level":"warn","ts":"2026-02-17T19:56:19.258295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:17.777453Z","time spent":"1.480837844s","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-17T19:56:22.071957Z","caller":"traceutil/trace.go:171","msg":"trace[982252045] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"383.070132ms","start":"2026-02-17T19:56:21.688856Z","end":"2026-02-17T19:56:22.071926Z","steps":["trace[982252045] 'process raft request'  (duration: 382.938389ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:22.072102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:21.68884Z","time spent":"383.185936ms","remote":"127.0.0.1:44632","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:476 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-17T19:56:22.926566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.985908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:22.92664Z","caller":"traceutil/trace.go:171","msg":"trace[207461964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:481; }","duration":"432.107172ms","start":"2026-02-17T19:56:22.494521Z","end":"2026-02-17T19:56:22.926628Z","steps":["trace[207461964] 'range keys from in-memory index tree'  (duration: 431.911947ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:22.926662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:22.494505Z","time spent":"432.151552ms","remote":"127.0.0.1:44346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-17T19:56:23.24046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.794223ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446602286 > lease_revoke:<id:38e19c6d2c431d98>","response":"size:28"}
{"level":"info","ts":"2026-02-17T19:56:23.240563Z","caller":"traceutil/trace.go:171","msg":"trace[1858453550] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"312.885846ms","start":"2026-02-17T19:56:22.927658Z","end":"2026-02-17T19:56:23.240544Z","steps":["trace[1858453550] 'read index received'  (duration: 155.951131ms)","trace[1858453550] 'applied index is now lower than readState.Index'  (duration: 156.933175ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:56:23.240658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.98791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:23.240694Z","caller":"traceutil/trace.go:171","msg":"trace[580161442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:481; }","duration":"313.048121ms","start":"2026-02-17T19:56:22.927637Z","end":"2026-02-17T19:56:23.240685Z","steps":["trace[580161442] 'agreement among raft nodes before linearized reading'  (duration: 312.9794ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:23.240733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:22.927625Z","time spent":"313.099792ms","remote":"127.0.0.1:44336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-17T19:56:23.398663Z","caller":"traceutil/trace.go:171","msg":"trace[1298839078] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"129.304673ms","start":"2026-02-17T19:56:23.269337Z","end":"2026-02-17T19:56:23.398641Z","steps":["trace[1298839078] 'process raft request'  (duration: 129.16918ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:56:23.407908Z","caller":"traceutil/trace.go:171","msg":"trace[1026920473] linearizableReadLoop","detail":"{readStateIndex:498; appliedIndex:497; }","duration":"133.398129ms","start":"2026-02-17T19:56:23.274492Z","end":"2026-02-17T19:56:23.407891Z","steps":["trace[1026920473] 'read index received'  (duration: 124.667663ms)","trace[1026920473] 'applied index is now lower than readState.Index'  (duration: 8.729546ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:56:23.408082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.563133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-17T19:56:23.408103Z","caller":"traceutil/trace.go:171","msg":"trace[1165168957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:483; }","duration":"133.654315ms","start":"2026-02-17T19:56:23.274442Z","end":"2026-02-17T19:56:23.408097Z","steps":["trace[1165168957] 'agreement among raft nodes before linearized reading'  (duration: 133.514372ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:56:23.408188Z","caller":"traceutil/trace.go:171","msg":"trace[393799163] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"138.5285ms","start":"2026-02-17T19:56:23.269654Z","end":"2026-02-17T19:56:23.408182Z","steps":["trace[393799163] 'process raft request'  (duration: 138.11774ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:25.688435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.010425ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446602303 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:484 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T19:56:25.688514Z","caller":"traceutil/trace.go:171","msg":"trace[861774726] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"199.825848ms","start":"2026-02-17T19:56:25.488674Z","end":"2026-02-17T19:56:25.6885Z","steps":["trace[861774726] 'process raft request'  (duration: 48.685809ms)","trace[861774726] 'compare'  (duration: 150.914003ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:27.778417Z","caller":"traceutil/trace.go:171","msg":"trace[1192911645] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"327.919042ms","start":"2026-02-17T19:56:27.450481Z","end":"2026-02-17T19:56:27.7784Z","steps":["trace[1192911645] 'read index received'  (duration: 327.796529ms)","trace[1192911645] 'applied index is now lower than readState.Index'  (duration: 121.893µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:56:27.778805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.602206ms","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-02-17T19:56:27.778865Z","caller":"traceutil/trace.go:171","msg":"trace[61285279] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:494; }","duration":"308.694828ms","start":"2026-02-17T19:56:27.470163Z","end":"2026-02-17T19:56:27.778857Z","steps":["trace[61285279] 'agreement among raft nodes before linearized reading'  (duration: 308.563884ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:27.778995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:27.470152Z","time spent":"308.834592ms","remote":"127.0.0.1:44632","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-02-17T19:56:27.779393Z","caller":"traceutil/trace.go:171","msg":"trace[1611007502] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"343.05103ms","start":"2026-02-17T19:56:27.436333Z","end":"2026-02-17T19:56:27.779384Z","steps":["trace[1611007502] 'process raft request'  (duration: 341.990044ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:27.779548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:27.436315Z","time spent":"343.173523ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:486 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-17T19:56:27.779853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.375936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gdj78\" ","response":"range_response_count:1 size:16652"}
{"level":"info","ts":"2026-02-17T19:56:27.779962Z","caller":"traceutil/trace.go:171","msg":"trace[794207430] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gdj78; range_end:; response_count:1; response_revision:494; }","duration":"329.51338ms","start":"2026-02-17T19:56:27.45044Z","end":"2026-02-17T19:56:27.779954Z","steps":["trace[794207430] 'agreement among raft nodes before linearized reading'  (duration: 328.196318ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:27.780052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:27.450414Z","time spent":"329.629332ms","remote":"127.0.0.1:44532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16675,"request content":"key:\"/registry/pods/kube-system/cilium-gdj78\" "}
{"level":"warn","ts":"2026-02-17T19:56:28.597975Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101165446602323,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T19:56:29.09877Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101165446602323,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T19:56:29.396631Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.61121125s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-17T19:56:29.396998Z","caller":"traceutil/trace.go:171","msg":"trace[826788285] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"1.611625259s","start":"2026-02-17T19:56:27.785357Z","end":"2026-02-17T19:56:29.396982Z","steps":["trace[826788285] 'process raft request'  (duration: 1.611373933s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:29.397079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:27.785342Z","time spent":"1.61168579s","remote":"127.0.0.1:44632","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:488 > 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-02-17T19:56:29.521928Z","caller":"traceutil/trace.go:171","msg":"trace[846145897] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:511; }","duration":"1.424435671s","start":"2026-02-17T19:56:28.097476Z","end":"2026-02-17T19:56:29.521912Z","steps":["trace[846145897] 'read index received'  (duration: 1.299593813s)","trace[846145897] 'applied index is now lower than readState.Index'  (duration: 124.841238ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:29.522156Z","caller":"traceutil/trace.go:171","msg":"trace[918957673] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"251.072709ms","start":"2026-02-17T19:56:29.271039Z","end":"2026-02-17T19:56:29.522111Z","steps":["trace[918957673] 'process raft request'  (duration: 250.851033ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:29.522232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.424742238s","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-02-17T19:56:29.522252Z","caller":"traceutil/trace.go:171","msg":"trace[1653003150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:498; }","duration":"1.42481209s","start":"2026-02-17T19:56:28.097434Z","end":"2026-02-17T19:56:29.522247Z","steps":["trace[1653003150] 'agreement among raft nodes before linearized reading'  (duration: 1.424719738s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:29.52227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:28.097414Z","time spent":"1.42485173s","remote":"127.0.0.1:44632","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-02-17T19:56:29.522332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.146055128s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:29.522343Z","caller":"traceutil/trace.go:171","msg":"trace[1770506816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:498; }","duration":"1.146097539s","start":"2026-02-17T19:56:28.376241Z","end":"2026-02-17T19:56:29.522339Z","steps":["trace[1770506816] 'agreement among raft nodes before linearized reading'  (duration: 1.146081679s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:29.522353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:28.376212Z","time spent":"1.14613884s","remote":"127.0.0.1:44346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-17T19:56:29.522437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028000531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:29.522449Z","caller":"traceutil/trace.go:171","msg":"trace[440687091] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:498; }","duration":"1.028065422s","start":"2026-02-17T19:56:28.49438Z","end":"2026-02-17T19:56:29.522445Z","steps":["trace[440687091] 'agreement among raft nodes before linearized reading'  (duration: 1.028047792s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:29.52246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:28.494361Z","time spent":"1.028096993s","remote":"127.0.0.1:44336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-17T19:56:29.522492Z","caller":"traceutil/trace.go:171","msg":"trace[1977807504] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"1.737005639s","start":"2026-02-17T19:56:27.785475Z","end":"2026-02-17T19:56:29.522481Z","steps":["trace[1977807504] 'process raft request'  (duration: 1.736298433s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:29.522585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:27.785468Z","time spent":"1.737051621s","remote":"127.0.0.1:44632","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:487 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-17T19:56:29.522693Z","caller":"traceutil/trace.go:171","msg":"trace[1393294452] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"1.729063152s","start":"2026-02-17T19:56:27.793624Z","end":"2026-02-17T19:56:29.522687Z","steps":["trace[1393294452] 'process raft request'  (duration: 1.728237413s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:29.522739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:27.793616Z","time spent":"1.729091132s","remote":"127.0.0.1:44532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-gdj78\" mod_revision:460 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-gdj78\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-gdj78\" > >"}
{"level":"info","ts":"2026-02-17T19:56:33.728148Z","caller":"traceutil/trace.go:171","msg":"trace[898001934] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:573; }","duration":"194.402579ms","start":"2026-02-17T19:56:33.533721Z","end":"2026-02-17T19:56:33.728123Z","steps":["trace[898001934] 'read index received'  (duration: 123.69468ms)","trace[898001934] 'applied index is now lower than readState.Index'  (duration: 70.706809ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:33.728681Z","caller":"traceutil/trace.go:171","msg":"trace[1417544192] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"198.960847ms","start":"2026-02-17T19:56:33.529305Z","end":"2026-02-17T19:56:33.728266Z","steps":["trace[1417544192] 'process raft request'  (duration: 128.288539ms)","trace[1417544192] 'compare'  (duration: 70.046384ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:33.729081Z","caller":"traceutil/trace.go:171","msg":"trace[729265648] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"196.573592ms","start":"2026-02-17T19:56:33.532453Z","end":"2026-02-17T19:56:33.729026Z","steps":["trace[729265648] 'process raft request'  (duration: 195.578778ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:33.729533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.797143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:33.729732Z","caller":"traceutil/trace.go:171","msg":"trace[37631597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"196.016818ms","start":"2026-02-17T19:56:33.533698Z","end":"2026-02-17T19:56:33.729715Z","steps":["trace[37631597] 'agreement among raft nodes before linearized reading'  (duration: 195.788723ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:33.733457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.808412ms","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-02-17T19:56:33.734758Z","caller":"traceutil/trace.go:171","msg":"trace[1024659597] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:558; }","duration":"194.122684ms","start":"2026-02-17T19:56:33.540624Z","end":"2026-02-17T19:56:33.734747Z","steps":["trace[1024659597] 'agreement among raft nodes before linearized reading'  (duration: 192.754131ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:33.733788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.924731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-17T19:56:33.737286Z","caller":"traceutil/trace.go:171","msg":"trace[756698302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:558; }","duration":"187.446325ms","start":"2026-02-17T19:56:33.549828Z","end":"2026-02-17T19:56:33.737274Z","steps":["trace[756698302] 'agreement among raft nodes before linearized reading'  (duration: 183.916732ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:35.82373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.472951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"}
{"level":"warn","ts":"2026-02-17T19:56:35.823814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.54374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:35.823845Z","caller":"traceutil/trace.go:171","msg":"trace[1270493382] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:572; }","duration":"551.597803ms","start":"2026-02-17T19:56:35.272209Z","end":"2026-02-17T19:56:35.823806Z","steps":["trace[1270493382] 'range keys from in-memory index tree'  (duration: 551.293056ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:56:35.823858Z","caller":"traceutil/trace.go:171","msg":"trace[157656834] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"332.602582ms","start":"2026-02-17T19:56:35.491238Z","end":"2026-02-17T19:56:35.82384Z","steps":["trace[157656834] 'range keys from in-memory index tree'  (duration: 332.441058ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:35.823898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:35.49121Z","time spent":"332.680194ms","remote":"127.0.0.1:44346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-17T19:56:35.823926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:35.272196Z","time spent":"551.699256ms","remote":"127.0.0.1:44390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4356,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "}
{"level":"warn","ts":"2026-02-17T19:56:35.824112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.696425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gdj78\" ","response":"range_response_count:1 size:17914"}
{"level":"info","ts":"2026-02-17T19:56:35.824175Z","caller":"traceutil/trace.go:171","msg":"trace[459846407] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gdj78; range_end:; response_count:1; response_revision:572; }","duration":"321.799166ms","start":"2026-02-17T19:56:35.502365Z","end":"2026-02-17T19:56:35.824164Z","steps":["trace[459846407] 'range keys from in-memory index tree'  (duration: 321.589931ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:35.824207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:35.502329Z","time spent":"321.870858ms","remote":"127.0.0.1:44532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17937,"request content":"key:\"/registry/pods/kube-system/cilium-gdj78\" "}
{"level":"warn","ts":"2026-02-17T19:56:35.824259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.416052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-02-17T19:56:35.824279Z","caller":"traceutil/trace.go:171","msg":"trace[1668513327] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:572; }","duration":"951.471804ms","start":"2026-02-17T19:56:34.872801Z","end":"2026-02-17T19:56:35.824273Z","steps":["trace[1668513327] 'range keys from in-memory index tree'  (duration: 951.206798ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:35.824299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:34.872783Z","time spent":"951.511584ms","remote":"127.0.0.1:44390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4106,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "}
{"level":"warn","ts":"2026-02-17T19:56:35.824451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.939766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"info","ts":"2026-02-17T19:56:35.824467Z","caller":"traceutil/trace.go:171","msg":"trace[302415455] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:572; }","duration":"749.955727ms","start":"2026-02-17T19:56:35.074506Z","end":"2026-02-17T19:56:35.824462Z","steps":["trace[302415455] 'range keys from in-memory index tree'  (duration: 749.879425ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:35.824479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:35.074491Z","time spent":"749.985127ms","remote":"127.0.0.1:44390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4203,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "}
{"level":"warn","ts":"2026-02-17T19:56:35.82376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.832126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-17T19:56:35.824689Z","caller":"traceutil/trace.go:171","msg":"trace[1907829338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:572; }","duration":"366.823441ms","start":"2026-02-17T19:56:35.457856Z","end":"2026-02-17T19:56:35.824679Z","steps":["trace[1907829338] 'range keys from in-memory index tree'  (duration: 365.701263ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:35.824714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:35.457842Z","time spent":"366.865192ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-17T19:56:35.849063Z","caller":"traceutil/trace.go:171","msg":"trace[1269219962] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"340.14266ms","start":"2026-02-17T19:56:35.50891Z","end":"2026-02-17T19:56:35.849052Z","steps":["trace[1269219962] 'process raft request'  (duration: 339.929335ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:35.849156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:35.508898Z","time spent":"340.206852ms","remote":"127.0.0.1:44390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:187148 >> failure:<>"}
{"level":"info","ts":"2026-02-17T19:56:35.854527Z","caller":"traceutil/trace.go:171","msg":"trace[255759204] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:590; }","duration":"182.200862ms","start":"2026-02-17T19:56:35.672306Z","end":"2026-02-17T19:56:35.854507Z","steps":["trace[255759204] 'read index received'  (duration: 182.191891ms)","trace[255759204] 'applied index is now lower than readState.Index'  (duration: 7.771µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:56:35.85485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.532039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"}
{"level":"info","ts":"2026-02-17T19:56:35.854884Z","caller":"traceutil/trace.go:171","msg":"trace[1148954296] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:573; }","duration":"182.613891ms","start":"2026-02-17T19:56:35.672262Z","end":"2026-02-17T19:56:35.854876Z","steps":["trace[1148954296] 'agreement among raft nodes before linearized reading'  (duration: 182.332465ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:35.876222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.657246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-17T19:56:35.876266Z","caller":"traceutil/trace.go:171","msg":"trace[243854675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"100.738608ms","start":"2026-02-17T19:56:35.775518Z","end":"2026-02-17T19:56:35.876257Z","steps":["trace[243854675] 'agreement among raft nodes before linearized reading'  (duration: 100.613095ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:56:38.230372Z","caller":"traceutil/trace.go:171","msg":"trace[1400424664] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"460.027401ms","start":"2026-02-17T19:56:37.770321Z","end":"2026-02-17T19:56:38.230349Z","steps":["trace[1400424664] 'process raft request'  (duration: 459.952229ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:38.230459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:37.770306Z","time spent":"460.114713ms","remote":"127.0.0.1:44422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":614,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.189520e553ee80f9\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.189520e553ee80f9\" value_size:546 lease:4098729128591825905 >> failure:<>"}
{"level":"warn","ts":"2026-02-17T19:56:39.329609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.248846ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446602499 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:586 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4280 >> failure:<request_range:<key:\"/registry/minions/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T19:56:39.329678Z","caller":"traceutil/trace.go:171","msg":"trace[462779532] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"1.432440859s","start":"2026-02-17T19:56:37.897224Z","end":"2026-02-17T19:56:39.329665Z","steps":["trace[462779532] 'read index received'  (duration: 333.499234ms)","trace[462779532] 'applied index is now lower than readState.Index'  (duration: 1.098940865s)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:39.329826Z","caller":"traceutil/trace.go:171","msg":"trace[123560980] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.557402479s","start":"2026-02-17T19:56:37.772394Z","end":"2026-02-17T19:56:39.329797Z","steps":["trace[123560980] 'process raft request'  (duration: 1.393906029s)","trace[123560980] 'compare'  (duration: 163.172193ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:56:39.329867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:37.772387Z","time spent":"1.557459681s","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4314,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:586 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4280 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-17T19:56:39.330053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432827348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-17T19:56:39.330073Z","caller":"traceutil/trace.go:171","msg":"trace[1030963788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"1.43286421s","start":"2026-02-17T19:56:37.897203Z","end":"2026-02-17T19:56:39.330067Z","steps":["trace[1030963788] 'agreement among raft nodes before linearized reading'  (duration: 1.432772458s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:39.330099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:37.89719Z","time spent":"1.43290531s","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-17T19:56:39.830012Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101165446602501,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-17T19:56:39.941319Z","caller":"traceutil/trace.go:171","msg":"trace[347604470] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"691.141497ms","start":"2026-02-17T19:56:39.250163Z","end":"2026-02-17T19:56:39.941305Z","steps":["trace[347604470] 'process raft request'  (duration: 691.061246ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:39.941407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:39.250141Z","time spent":"691.22767ms","remote":"127.0.0.1:44422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-gdj78.189520e5ac2501ae\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-gdj78.189520e5ac2501ae\" value_size:704 lease:4098729128591825905 >> failure:<>"}
{"level":"info","ts":"2026-02-17T19:56:40.104261Z","caller":"traceutil/trace.go:171","msg":"trace[526983527] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"763.26652ms","start":"2026-02-17T19:56:39.34098Z","end":"2026-02-17T19:56:40.104246Z","steps":["trace[526983527] 'process raft request'  (duration: 763.222879ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:40.10436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:39.340966Z","time spent":"763.344392ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4201,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:590 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4167 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-17T19:56:40.104521Z","caller":"traceutil/trace.go:171","msg":"trace[987484430] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"766.176049ms","start":"2026-02-17T19:56:39.33834Z","end":"2026-02-17T19:56:40.104516Z","steps":["trace[987484430] 'process raft request'  (duration: 765.752699ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:40.104545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:39.338323Z","time spent":"766.208659ms","remote":"127.0.0.1:44632","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:574 > 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-02-17T19:56:40.104524Z","caller":"traceutil/trace.go:171","msg":"trace[1986910546] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:609; }","duration":"774.807112ms","start":"2026-02-17T19:56:39.329695Z","end":"2026-02-17T19:56:40.104502Z","steps":["trace[1986910546] 'read index received'  (duration: 611.878406ms)","trace[1986910546] 'applied index is now lower than readState.Index'  (duration: 162.927896ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:40.104679Z","caller":"traceutil/trace.go:171","msg":"trace[972274366] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"219.668156ms","start":"2026-02-17T19:56:39.885002Z","end":"2026-02-17T19:56:40.10467Z","steps":["trace[972274366] 'process raft request'  (duration: 219.223456ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:40.104828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.178917952s","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-02-17T19:56:40.104848Z","caller":"traceutil/trace.go:171","msg":"trace[1820364376] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"2.178955513s","start":"2026-02-17T19:56:37.925887Z","end":"2026-02-17T19:56:40.104842Z","steps":["trace[1820364376] 'agreement among raft nodes before linearized reading'  (duration: 2.178889922s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:40.104862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:37.925876Z","time spent":"2.178983214s","remote":"127.0.0.1:44632","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-02-17T19:56:40.104904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.180562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-17T19:56:40.104939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.155948031s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-17T19:56:40.104945Z","caller":"traceutil/trace.go:171","msg":"trace[1866441763] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:594; }","duration":"656.260404ms","start":"2026-02-17T19:56:39.448677Z","end":"2026-02-17T19:56:40.104937Z","steps":["trace[1866441763] 'agreement among raft nodes before linearized reading'  (duration: 656.184622ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:56:40.104952Z","caller":"traceutil/trace.go:171","msg":"trace[1447149322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"2.155969502s","start":"2026-02-17T19:56:37.948979Z","end":"2026-02-17T19:56:40.104949Z","steps":["trace[1447149322] 'agreement among raft nodes before linearized reading'  (duration: 2.155933501s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:40.104966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:37.948975Z","time spent":"2.155987212s","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-17T19:56:40.104969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:39.448664Z","time spent":"656.297356ms","remote":"127.0.0.1:48766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "}
{"level":"warn","ts":"2026-02-17T19:56:40.105039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.156519125s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-17T19:56:40.105052Z","caller":"traceutil/trace.go:171","msg":"trace[2041546826] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:594; }","duration":"2.156537075s","start":"2026-02-17T19:56:37.94851Z","end":"2026-02-17T19:56:40.105048Z","steps":["trace[2041546826] 'agreement among raft nodes before linearized reading'  (duration: 2.156499364s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:40.105064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:37.948507Z","time spent":"2.156554245s","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-17T19:56:40.105115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.156614016s","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-02-17T19:56:40.105127Z","caller":"traceutil/trace.go:171","msg":"trace[2060122381] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:594; }","duration":"2.156638658s","start":"2026-02-17T19:56:37.948484Z","end":"2026-02-17T19:56:40.105123Z","steps":["trace[2060122381] 'agreement among raft nodes before linearized reading'  (duration: 2.156607887s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:40.105134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.911388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-17T19:56:40.105141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:37.948473Z","time spent":"2.156663318s","remote":"127.0.0.1:44632","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-02-17T19:56:40.105152Z","caller":"traceutil/trace.go:171","msg":"trace[1089371636] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"611.965389ms","start":"2026-02-17T19:56:39.493181Z","end":"2026-02-17T19:56:40.105146Z","steps":["trace[1089371636] 'agreement among raft nodes before linearized reading'  (duration: 611.935339ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:40.105169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:39.493163Z","time spent":"612.00281ms","remote":"127.0.0.1:44346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-17T19:56:40.105318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.595572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:40.105333Z","caller":"traceutil/trace.go:171","msg":"trace[341533087] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:594; }","duration":"656.610993ms","start":"2026-02-17T19:56:39.448718Z","end":"2026-02-17T19:56:40.105329Z","steps":["trace[341533087] 'agreement among raft nodes before linearized reading'  (duration: 656.586312ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:40.105346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:39.448679Z","time spent":"656.663714ms","remote":"127.0.0.1:48766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "}
{"level":"info","ts":"2026-02-17T19:56:41.388234Z","caller":"traceutil/trace.go:171","msg":"trace[505906162] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"135.241294ms","start":"2026-02-17T19:56:41.252969Z","end":"2026-02-17T19:56:41.38821Z","steps":["trace[505906162] 'process raft request'  (duration: 135.150581ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:41.626395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.574357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:41.626457Z","caller":"traceutil/trace.go:171","msg":"trace[784685620] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"134.67678ms","start":"2026-02-17T19:56:41.491765Z","end":"2026-02-17T19:56:41.626442Z","steps":["trace[784685620] 'range keys from in-memory index tree'  (duration: 134.521976ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:42.405035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.308961ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446602534 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:598 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T19:56:42.405105Z","caller":"traceutil/trace.go:171","msg":"trace[282941989] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"218.620781ms","start":"2026-02-17T19:56:42.186472Z","end":"2026-02-17T19:56:42.405093Z","steps":["trace[282941989] 'process raft request'  (duration: 48.205428ms)","trace[282941989] 'compare'  (duration: 170.24487ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:56:42.40548Z","caller":"traceutil/trace.go:171","msg":"trace[932790100] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"215.649541ms","start":"2026-02-17T19:56:42.189825Z","end":"2026-02-17T19:56:42.405475Z","steps":["trace[932790100] 'process raft request'  (duration: 215.632721ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:56:42.406199Z","caller":"traceutil/trace.go:171","msg":"trace[1805016547] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"218.715553ms","start":"2026-02-17T19:56:42.187478Z","end":"2026-02-17T19:56:42.406193Z","steps":["trace[1805016547] 'process raft request'  (duration: 217.955715ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.735146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.944369ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446602692 > lease_revoke:<id:38e19c6d2c431ef7>","response":"size:28"}
{"level":"info","ts":"2026-02-17T19:56:53.735323Z","caller":"traceutil/trace.go:171","msg":"trace[1714821780] linearizableReadLoop","detail":"{readStateIndex:715; appliedIndex:714; }","duration":"590.087812ms","start":"2026-02-17T19:56:53.145163Z","end":"2026-02-17T19:56:53.735251Z","steps":["trace[1714821780] 'read index received'  (duration: 276.974319ms)","trace[1714821780] 'applied index is now lower than readState.Index'  (duration: 313.112063ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:56:53.73583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.646745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.735873Z","caller":"traceutil/trace.go:171","msg":"trace[919415592] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:693; }","duration":"590.718037ms","start":"2026-02-17T19:56:53.145148Z","end":"2026-02-17T19:56:53.735866Z","steps":["trace[919415592] 'agreement among raft nodes before linearized reading'  (duration: 590.624675ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.735892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:53.145145Z","time spent":"590.742788ms","remote":"127.0.0.1:33036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-02-17T19:56:53.749839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.614935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.749889Z","caller":"traceutil/trace.go:171","msg":"trace[1718257864] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:693; }","duration":"604.684297ms","start":"2026-02-17T19:56:53.145194Z","end":"2026-02-17T19:56:53.749878Z","steps":["trace[1718257864] 'agreement among raft nodes before linearized reading'  (duration: 604.602005ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.749917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:53.145192Z","time spent":"604.718698ms","remote":"127.0.0.1:33036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-17T19:56:53.750118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.878461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.750137Z","caller":"traceutil/trace.go:171","msg":"trace[922224637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:693; }","duration":"258.925073ms","start":"2026-02-17T19:56:53.491206Z","end":"2026-02-17T19:56:53.750131Z","steps":["trace[922224637] 'agreement among raft nodes before linearized reading'  (duration: 258.895192ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.750212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.973425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.750228Z","caller":"traceutil/trace.go:171","msg":"trace[2106105871] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:693; }","duration":"577.996566ms","start":"2026-02-17T19:56:53.172227Z","end":"2026-02-17T19:56:53.750223Z","steps":["trace[2106105871] 'agreement among raft nodes before linearized reading'  (duration: 577.969225ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.750247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:53.172225Z","time spent":"578.016866ms","remote":"127.0.0.1:33056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "}
{"level":"warn","ts":"2026-02-17T19:56:53.750327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.100078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.750346Z","caller":"traceutil/trace.go:171","msg":"trace[178395226] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:693; }","duration":"578.123798ms","start":"2026-02-17T19:56:53.172215Z","end":"2026-02-17T19:56:53.750339Z","steps":["trace[178395226] 'agreement among raft nodes before linearized reading'  (duration: 578.099968ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.750364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:53.172212Z","time spent":"578.147059ms","remote":"127.0.0.1:33056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-02-17T19:56:53.750429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.222621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.750444Z","caller":"traceutil/trace.go:171","msg":"trace[1851524635] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:693; }","duration":"578.238362ms","start":"2026-02-17T19:56:53.172201Z","end":"2026-02-17T19:56:53.75044Z","steps":["trace[1851524635] 'agreement among raft nodes before linearized reading'  (duration: 578.214721ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.750461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:53.172185Z","time spent":"578.271573ms","remote":"127.0.0.1:33056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "}
{"level":"warn","ts":"2026-02-17T19:56:53.750524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.693546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.750542Z","caller":"traceutil/trace.go:171","msg":"trace[78288180] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:693; }","duration":"587.728856ms","start":"2026-02-17T19:56:53.162807Z","end":"2026-02-17T19:56:53.750535Z","steps":["trace[78288180] 'agreement among raft nodes before linearized reading'  (duration: 587.704535ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.750558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:53.162802Z","time spent":"587.752076ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "}
{"level":"warn","ts":"2026-02-17T19:56:53.750649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.734665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.750668Z","caller":"traceutil/trace.go:171","msg":"trace[268009571] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:693; }","duration":"592.752535ms","start":"2026-02-17T19:56:53.157909Z","end":"2026-02-17T19:56:53.750662Z","steps":["trace[268009571] 'agreement among raft nodes before linearized reading'  (duration: 592.725054ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.750686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:53.157884Z","time spent":"592.797746ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "}
{"level":"warn","ts":"2026-02-17T19:56:53.750751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.886968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.750767Z","caller":"traceutil/trace.go:171","msg":"trace[106681190] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:693; }","duration":"592.917119ms","start":"2026-02-17T19:56:53.157845Z","end":"2026-02-17T19:56:53.750762Z","steps":["trace[106681190] 'agreement among raft nodes before linearized reading'  (duration: 592.892519ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.750782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:53.157838Z","time spent":"592.94035ms","remote":"127.0.0.1:33048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-02-17T19:56:53.750845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.632369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:53.750863Z","caller":"traceutil/trace.go:171","msg":"trace[111792202] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:693; }","duration":"605.647719ms","start":"2026-02-17T19:56:53.145208Z","end":"2026-02-17T19:56:53.750855Z","steps":["trace[111792202] 'agreement among raft nodes before linearized reading'  (duration: 605.624199ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:53.750879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:56:53.145038Z","time spent":"605.836614ms","remote":"127.0.0.1:33036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "}
{"level":"info","ts":"2026-02-17T19:56:53.923199Z","caller":"traceutil/trace.go:171","msg":"trace[1782225617] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"168.98093ms","start":"2026-02-17T19:56:53.754199Z","end":"2026-02-17T19:56:53.923179Z","steps":["trace[1782225617] 'process raft request'  (duration: 168.847376ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:54.713611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.824605ms","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-02-17T19:56:54.713671Z","caller":"traceutil/trace.go:171","msg":"trace[1749868931] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:696; }","duration":"251.933718ms","start":"2026-02-17T19:56:54.461723Z","end":"2026-02-17T19:56:54.713657Z","steps":["trace[1749868931] 'range keys from in-memory index tree'  (duration: 251.689652ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:54.71367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.986101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:56:54.713741Z","caller":"traceutil/trace.go:171","msg":"trace[1836848555] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:696; }","duration":"222.084324ms","start":"2026-02-17T19:56:54.491635Z","end":"2026-02-17T19:56:54.713719Z","steps":["trace[1836848555] 'range keys from in-memory index tree'  (duration: 221.9356ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:54.713889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.890931ms","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-02-17T19:56:54.713909Z","caller":"traceutil/trace.go:171","msg":"trace[1048401363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:696; }","duration":"258.944393ms","start":"2026-02-17T19:56:54.454958Z","end":"2026-02-17T19:56:54.713903Z","steps":["trace[1048401363] 'range keys from in-memory index tree'  (duration: 258.80836ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:56:54.714014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.014474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-17T19:56:54.714057Z","caller":"traceutil/trace.go:171","msg":"trace[1236720742] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:696; }","duration":"256.069235ms","start":"2026-02-17T19:56:54.45798Z","end":"2026-02-17T19:56:54.714049Z","steps":["trace[1236720742] 'range keys from in-memory index tree'  (duration: 255.941973ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:57:01.182539Z","caller":"traceutil/trace.go:171","msg":"trace[514600506] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"215.478147ms","start":"2026-02-17T19:57:00.967043Z","end":"2026-02-17T19:57:01.182521Z","steps":["trace[514600506] 'process raft request'  (duration: 215.346413ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:57:06.907308Z","caller":"traceutil/trace.go:171","msg":"trace[1154059343] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:757; }","duration":"443.666674ms","start":"2026-02-17T19:57:06.463621Z","end":"2026-02-17T19:57:06.907287Z","steps":["trace[1154059343] 'read index received'  (duration: 443.47982ms)","trace[1154059343] 'applied index is now lower than readState.Index'  (duration: 185.994µs)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:57:06.907581Z","caller":"traceutil/trace.go:171","msg":"trace[189949467] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"455.193867ms","start":"2026-02-17T19:57:06.452376Z","end":"2026-02-17T19:57:06.907569Z","steps":["trace[189949467] 'process raft request'  (duration: 454.786457ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:06.907702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:06.452358Z","time spent":"455.260598ms","remote":"127.0.0.1:44632","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:728 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-17T19:57:06.907891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.260788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T19:57:06.907923Z","caller":"traceutil/trace.go:171","msg":"trace[996056707] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:733; }","duration":"444.31362ms","start":"2026-02-17T19:57:06.463599Z","end":"2026-02-17T19:57:06.907913Z","steps":["trace[996056707] 'agreement among raft nodes before linearized reading'  (duration: 444.250428ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:06.907951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:06.463588Z","time spent":"444.355961ms","remote":"127.0.0.1:44782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-02-17T19:57:06.908106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.746285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:57:06.908257Z","caller":"traceutil/trace.go:171","msg":"trace[1014751802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:733; }","duration":"412.912848ms","start":"2026-02-17T19:57:06.49533Z","end":"2026-02-17T19:57:06.908243Z","steps":["trace[1014751802] 'agreement among raft nodes before linearized reading'  (duration: 412.755745ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:06.908292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:06.495315Z","time spent":"412.96593ms","remote":"127.0.0.1:44346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-17T19:57:06.909065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.872307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-17T19:57:06.909148Z","caller":"traceutil/trace.go:171","msg":"trace[458385254] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:733; }","duration":"107.97195ms","start":"2026-02-17T19:57:06.801162Z","end":"2026-02-17T19:57:06.909134Z","steps":["trace[458385254] 'agreement among raft nodes before linearized reading'  (duration: 107.842917ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:06.909296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.946713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:57:06.909364Z","caller":"traceutil/trace.go:171","msg":"trace[1729662660] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:733; }","duration":"120.051114ms","start":"2026-02-17T19:57:06.789299Z","end":"2026-02-17T19:57:06.90935Z","steps":["trace[1729662660] 'agreement among raft nodes before linearized reading'  (duration: 119.971092ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:06.909592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.627216ms","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-02-17T19:57:06.909627Z","caller":"traceutil/trace.go:171","msg":"trace[1106140488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:733; }","duration":"133.703547ms","start":"2026-02-17T19:57:06.775914Z","end":"2026-02-17T19:57:06.909618Z","steps":["trace[1106140488] 'agreement among raft nodes before linearized reading'  (duration: 133.583945ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:06.909845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.345994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-17T19:57:06.909882Z","caller":"traceutil/trace.go:171","msg":"trace[913317637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:733; }","duration":"395.437186ms","start":"2026-02-17T19:57:06.514436Z","end":"2026-02-17T19:57:06.909873Z","steps":["trace[913317637] 'agreement among raft nodes before linearized reading'  (duration: 395.301583ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:06.909914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:06.51442Z","time spent":"395.488467ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-17T19:57:07.236053Z","caller":"traceutil/trace.go:171","msg":"trace[1229722338] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"318.503799ms","start":"2026-02-17T19:57:06.917525Z","end":"2026-02-17T19:57:07.236029Z","steps":["trace[1229722338] 'process raft request'  (duration: 318.050318ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:07.236195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:06.917514Z","time spent":"318.608541ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:731 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T19:57:07.271817Z","caller":"traceutil/trace.go:171","msg":"trace[611522606] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"349.84429ms","start":"2026-02-17T19:57:06.921956Z","end":"2026-02-17T19:57:07.271801Z","steps":["trace[611522606] 'process raft request'  (duration: 349.809569ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:07.271926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:06.921948Z","time spent":"349.917251ms","remote":"127.0.0.1:44632","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:729 > 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-02-17T19:57:07.272236Z","caller":"traceutil/trace.go:171","msg":"trace[734077327] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"354.561961ms","start":"2026-02-17T19:57:06.917662Z","end":"2026-02-17T19:57:07.272224Z","steps":["trace[734077327] 'process raft request'  (duration: 353.960397ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:07.272296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:06.917656Z","time spent":"354.606351ms","remote":"127.0.0.1:44632","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:730 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-17T19:57:07.272413Z","caller":"traceutil/trace.go:171","msg":"trace[1687323385] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"352.672555ms","start":"2026-02-17T19:57:06.919732Z","end":"2026-02-17T19:57:07.272405Z","steps":["trace[1687323385] 'process raft request'  (duration: 351.994339ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:07.272463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:06.919723Z","time spent":"352.711146ms","remote":"127.0.0.1:44632","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:732 > 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-02-17T19:57:13.14908Z","caller":"traceutil/trace.go:171","msg":"trace[1537587790] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"214.607027ms","start":"2026-02-17T19:57:12.934185Z","end":"2026-02-17T19:57:13.148792Z","steps":["trace[1537587790] 'process raft request'  (duration: 214.421543ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:21.689444Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101165446603010,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T19:57:22.17523Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.013434596s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-17T19:57:22.175504Z","caller":"traceutil/trace.go:171","msg":"trace[645994364] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"1.013776215s","start":"2026-02-17T19:57:21.161714Z","end":"2026-02-17T19:57:22.17549Z","steps":["trace[645994364] 'process raft request'  (duration: 1.013674712s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:22.175581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:21.161696Z","time spent":"1.013834567s","remote":"127.0.0.1:44632","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:745 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-17T19:57:22.209056Z","caller":"traceutil/trace.go:171","msg":"trace[621899557] linearizableReadLoop","detail":"{readStateIndex:853; appliedIndex:852; }","duration":"1.020075353s","start":"2026-02-17T19:57:21.188969Z","end":"2026-02-17T19:57:22.209044Z","steps":["trace[621899557] 'read index received'  (duration: 986.893639ms)","trace[621899557] 'applied index is now lower than readState.Index'  (duration: 33.181194ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:57:22.209219Z","caller":"traceutil/trace.go:171","msg":"trace[2144392863] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"620.170362ms","start":"2026-02-17T19:57:21.589042Z","end":"2026-02-17T19:57:22.209212Z","steps":["trace[2144392863] 'process raft request'  (duration: 619.936756ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:22.20928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:21.589025Z","time spent":"620.211962ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:750 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-17T19:57:22.209414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020444821s","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-02-17T19:57:22.209435Z","caller":"traceutil/trace.go:171","msg":"trace[731962721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:824; }","duration":"1.020488583s","start":"2026-02-17T19:57:21.18894Z","end":"2026-02-17T19:57:22.209429Z","steps":["trace[731962721] 'agreement among raft nodes before linearized reading'  (duration: 1.020429441s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:22.209452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:21.188926Z","time spent":"1.020522543s","remote":"127.0.0.1:44632","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-02-17T19:57:22.209532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.802596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-17T19:57:22.20955Z","caller":"traceutil/trace.go:171","msg":"trace[33985496] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:824; }","duration":"919.842707ms","start":"2026-02-17T19:57:21.289703Z","end":"2026-02-17T19:57:22.209546Z","steps":["trace[33985496] 'agreement among raft nodes before linearized reading'  (duration: 919.800456ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:22.209562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:21.28969Z","time spent":"919.869537ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-17T19:57:22.2097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.146584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:57:22.209719Z","caller":"traceutil/trace.go:171","msg":"trace[2006937184] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:824; }","duration":"241.187525ms","start":"2026-02-17T19:57:21.968527Z","end":"2026-02-17T19:57:22.209715Z","steps":["trace[2006937184] 'agreement among raft nodes before linearized reading'  (duration: 241.159915ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:22.209805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.330172ms","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-02-17T19:57:22.209832Z","caller":"traceutil/trace.go:171","msg":"trace[1850886570] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:824; }","duration":"857.377662ms","start":"2026-02-17T19:57:21.35245Z","end":"2026-02-17T19:57:22.209828Z","steps":["trace[1850886570] 'agreement among raft nodes before linearized reading'  (duration: 857.326521ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:22.209844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:21.352439Z","time spent":"857.402532ms","remote":"127.0.0.1:44632","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-02-17T19:57:22.209956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.033499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-17T19:57:22.209975Z","caller":"traceutil/trace.go:171","msg":"trace[1729370813] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:824; }","duration":"861.07748ms","start":"2026-02-17T19:57:21.348892Z","end":"2026-02-17T19:57:22.209969Z","steps":["trace[1729370813] 'agreement among raft nodes before linearized reading'  (duration: 861.037029ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:22.20999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:21.348876Z","time spent":"861.111491ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-17T19:57:22.210091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.153835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T19:57:22.210109Z","caller":"traceutil/trace.go:171","msg":"trace[779420075] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:824; }","duration":"862.230797ms","start":"2026-02-17T19:57:21.347874Z","end":"2026-02-17T19:57:22.210105Z","steps":["trace[779420075] 'agreement among raft nodes before linearized reading'  (duration: 862.174665ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:22.210123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:21.347861Z","time spent":"862.256458ms","remote":"127.0.0.1:44860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":85,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-17T19:57:22.21021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.517761ms","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-02-17T19:57:22.210225Z","caller":"traceutil/trace.go:171","msg":"trace[1671027081] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:824; }","duration":"875.557952ms","start":"2026-02-17T19:57:21.334664Z","end":"2026-02-17T19:57:22.210222Z","steps":["trace[1671027081] 'agreement among raft nodes before linearized reading'  (duration: 875.518881ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:22.21024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:21.334638Z","time spent":"875.599913ms","remote":"127.0.0.1:44632","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-02-17T19:57:34.887354Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101165446603101,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-17T19:57:34.893519Z","caller":"traceutil/trace.go:171","msg":"trace[944745854] linearizableReadLoop","detail":"{readStateIndex:890; appliedIndex:889; }","duration":"506.366279ms","start":"2026-02-17T19:57:34.387137Z","end":"2026-02-17T19:57:34.893503Z","steps":["trace[944745854] 'read index received'  (duration: 506.257627ms)","trace[944745854] 'applied index is now lower than readState.Index'  (duration: 108.242µs)"],"step_count":2}
{"level":"info","ts":"2026-02-17T19:57:34.893698Z","caller":"traceutil/trace.go:171","msg":"trace[1003774888] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"514.139741ms","start":"2026-02-17T19:57:34.379553Z","end":"2026-02-17T19:57:34.893692Z","steps":["trace[1003774888] 'process raft request'  (duration: 513.875804ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:34.893753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.379536Z","time spent":"514.177171ms","remote":"127.0.0.1:44632","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:851 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-17T19:57:34.893883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.744798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-17T19:57:34.893898Z","caller":"traceutil/trace.go:171","msg":"trace[1967261629] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:858; }","duration":"506.780408ms","start":"2026-02-17T19:57:34.387113Z","end":"2026-02-17T19:57:34.893893Z","steps":["trace[1967261629] 'agreement among raft nodes before linearized reading'  (duration: 506.723937ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:34.893911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.387102Z","time spent":"506.806009ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-17T19:57:34.893994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.821613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-17T19:57:34.894005Z","caller":"traceutil/trace.go:171","msg":"trace[418558760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:858; }","duration":"490.887755ms","start":"2026-02-17T19:57:34.403114Z","end":"2026-02-17T19:57:34.894002Z","steps":["trace[418558760] 'agreement among raft nodes before linearized reading'  (duration: 490.853174ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:34.894016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.403104Z","time spent":"490.909846ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-17T19:57:34.894217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.738865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:57:34.894232Z","caller":"traceutil/trace.go:171","msg":"trace[1160879040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:858; }","duration":"401.788056ms","start":"2026-02-17T19:57:34.49244Z","end":"2026-02-17T19:57:34.894228Z","steps":["trace[1160879040] 'agreement among raft nodes before linearized reading'  (duration: 401.761995ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:34.894243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.492429Z","time spent":"401.811676ms","remote":"127.0.0.1:44346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-17T19:57:34.894329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.549221ms","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-02-17T19:57:34.894342Z","caller":"traceutil/trace.go:171","msg":"trace[762049006] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:858; }","duration":"462.582462ms","start":"2026-02-17T19:57:34.431756Z","end":"2026-02-17T19:57:34.894338Z","steps":["trace[762049006] 'agreement among raft nodes before linearized reading'  (duration: 462.545802ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:34.894374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.431746Z","time spent":"462.625323ms","remote":"127.0.0.1:44632","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-02-17T19:57:34.894452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.20206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-17T19:57:34.894465Z","caller":"traceutil/trace.go:171","msg":"trace[246175678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:858; }","duration":"464.23553ms","start":"2026-02-17T19:57:34.430225Z","end":"2026-02-17T19:57:34.894461Z","steps":["trace[246175678] 'agreement among raft nodes before linearized reading'  (duration: 464.200279ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:34.894475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.430215Z","time spent":"464.258471ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-17T19:57:35.239536Z","caller":"traceutil/trace.go:171","msg":"trace[1514279130] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"341.706086ms","start":"2026-02-17T19:57:34.897802Z","end":"2026-02-17T19:57:35.239508Z","steps":["trace[1514279130] 'process raft request'  (duration: 323.631541ms)","trace[1514279130] 'compare'  (duration: 17.783938ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:57:35.239667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.897794Z","time spent":"341.804838ms","remote":"127.0.0.1:44632","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:853 > 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-02-17T19:57:35.24365Z","caller":"traceutil/trace.go:171","msg":"trace[1303000663] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"341.096711ms","start":"2026-02-17T19:57:34.902535Z","end":"2026-02-17T19:57:35.243631Z","steps":["trace[1303000663] 'process raft request'  (duration: 340.901886ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:57:35.24372Z","caller":"traceutil/trace.go:171","msg":"trace[1247925190] linearizableReadLoop","detail":"{readStateIndex:894; appliedIndex:890; }","duration":"146.900415ms","start":"2026-02-17T19:57:35.096803Z","end":"2026-02-17T19:57:35.243704Z","steps":["trace[1247925190] 'read index received'  (duration: 124.642184ms)","trace[1247925190] 'applied index is now lower than readState.Index'  (duration: 22.257321ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:57:35.243756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.902529Z","time spent":"341.169103ms","remote":"127.0.0.1:44632","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:855 > 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":"warn","ts":"2026-02-17T19:57:35.243814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.996288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T19:57:35.243845Z","caller":"traceutil/trace.go:171","msg":"trace[1745534250] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:862; }","duration":"147.057719ms","start":"2026-02-17T19:57:35.096779Z","end":"2026-02-17T19:57:35.243836Z","steps":["trace[1745534250] 'agreement among raft nodes before linearized reading'  (duration: 146.980047ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:57:35.243967Z","caller":"traceutil/trace.go:171","msg":"trace[596129232] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"340.456785ms","start":"2026-02-17T19:57:34.903496Z","end":"2026-02-17T19:57:35.243953Z","steps":["trace[596129232] 'process raft request'  (duration: 340.134528ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:35.244007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.90349Z","time spent":"340.495146ms","remote":"127.0.0.1:44632","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:854 > 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-02-17T19:57:35.24404Z","caller":"traceutil/trace.go:171","msg":"trace[756828305] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"339.741159ms","start":"2026-02-17T19:57:34.904288Z","end":"2026-02-17T19:57:35.244029Z","steps":["trace[756828305] 'process raft request'  (duration: 339.383431ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:35.244102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T19:57:34.904283Z","time spent":"339.78255ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:852 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T19:57:38.087878Z","caller":"traceutil/trace.go:171","msg":"trace[1097228560] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"139.252906ms","start":"2026-02-17T19:57:37.94859Z","end":"2026-02-17T19:57:38.087843Z","steps":["trace[1097228560] 'process raft request'  (duration: 139.089311ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:57:41.064533Z","caller":"traceutil/trace.go:171","msg":"trace[1741311381] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"130.03502ms","start":"2026-02-17T19:57:40.934474Z","end":"2026-02-17T19:57:41.064509Z","steps":["trace[1741311381] 'process raft request'  (duration: 129.841285ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:57:42.608093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.896516ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446603188 > lease_revoke:<id:38e19c6d2c43212d>","response":"size:28"}
{"level":"info","ts":"2026-02-17T19:57:42.60819Z","caller":"traceutil/trace.go:171","msg":"trace[2147044049] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:931; }","duration":"113.045671ms","start":"2026-02-17T19:57:42.495127Z","end":"2026-02-17T19:57:42.608173Z","steps":["trace[2147044049] 'read index received'  (duration: 28.771µs)","trace[2147044049] 'applied index is now lower than readState.Index'  (duration: 113.01551ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T19:57:42.608261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.122913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T19:57:42.608288Z","caller":"traceutil/trace.go:171","msg":"trace[1506406304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:898; }","duration":"113.182235ms","start":"2026-02-17T19:57:42.495094Z","end":"2026-02-17T19:57:42.608276Z","steps":["trace[1506406304] 'agreement among raft nodes before linearized reading'  (duration: 113.125174ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T19:57:55.975604Z","caller":"traceutil/trace.go:171","msg":"trace[596331056] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"205.246764ms","start":"2026-02-17T19:57:55.770334Z","end":"2026-02-17T19:57:55.975581Z","steps":["trace[596331056] 'process raft request'  (duration: 205.116701ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T19:58:22.685863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.494566ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446603639 > lease_revoke:<id:38e19c6d2c4322d3>","response":"size:28"}
{"level":"info","ts":"2026-02-17T19:59:12.478891Z","caller":"traceutil/trace.go:171","msg":"trace[752210287] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"133.197186ms","start":"2026-02-17T19:59:12.345673Z","end":"2026-02-17T19:59:12.47887Z","steps":["trace[752210287] 'process raft request'  (duration: 133.081573ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T20:01:06.201872Z","caller":"traceutil/trace.go:171","msg":"trace[1064486767] transaction","detail":"{read_only:false; response_revision:1789; number_of_response:1; }","duration":"101.598497ms","start":"2026-02-17T20:01:06.10023Z","end":"2026-02-17T20:01:06.201829Z","steps":["trace[1064486767] 'process raft request'  (duration: 101.102484ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T20:01:06.755905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.941401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-02-17T20:01:06.756002Z","caller":"traceutil/trace.go:171","msg":"trace[14635761] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1790; }","duration":"446.114095ms","start":"2026-02-17T20:01:06.309866Z","end":"2026-02-17T20:01:06.75598Z","steps":["trace[14635761] 'range keys from in-memory index tree'  (duration: 445.690735ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T20:01:06.756409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T20:01:06.309839Z","time spent":"446.555285ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-17T20:01:06.757038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.000366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"}
{"level":"info","ts":"2026-02-17T20:01:06.760367Z","caller":"traceutil/trace.go:171","msg":"trace[23401744] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1790; }","duration":"338.388915ms","start":"2026-02-17T20:01:06.42196Z","end":"2026-02-17T20:01:06.760349Z","steps":["trace[23401744] 'range keys from in-memory index tree'  (duration: 334.801872ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T20:01:06.760903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T20:01:06.421937Z","time spent":"338.532129ms","remote":"127.0.0.1:44632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-17T20:01:06.757112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.423649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T20:01:06.761235Z","caller":"traceutil/trace.go:171","msg":"trace[311885021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1790; }","duration":"263.592925ms","start":"2026-02-17T20:01:06.497623Z","end":"2026-02-17T20:01:06.761216Z","steps":["trace[311885021] 'range keys from in-memory index tree'  (duration: 259.327096ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T20:01:06.757278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.788175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-17T20:01:06.75734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.701787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-02-17T20:01:06.762343Z","caller":"traceutil/trace.go:171","msg":"trace[411093232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1790; }","duration":"185.778556ms","start":"2026-02-17T20:01:06.576545Z","end":"2026-02-17T20:01:06.762323Z","steps":["trace[411093232] 'range keys from in-memory index tree'  (duration: 180.439951ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T20:01:06.757377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.76456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-17T20:01:06.762465Z","caller":"traceutil/trace.go:171","msg":"trace[1832285258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1790; }","duration":"165.884881ms","start":"2026-02-17T20:01:06.596571Z","end":"2026-02-17T20:01:06.762456Z","steps":["trace[1832285258] 'range keys from in-memory index tree'  (duration: 160.630998ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T20:01:06.757996Z","caller":"traceutil/trace.go:171","msg":"trace[441354278] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"130.063152ms","start":"2026-02-17T20:01:06.627912Z","end":"2026-02-17T20:01:06.757975Z","steps":["trace[441354278] 'process raft request'  (duration: 120.310644ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T20:01:06.761411Z","caller":"traceutil/trace.go:171","msg":"trace[1897475586] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1790; }","duration":"212.980492ms","start":"2026-02-17T20:01:06.548421Z","end":"2026-02-17T20:01:06.761402Z","steps":["trace[1897475586] 'range keys from in-memory index tree'  (duration: 208.631681ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T20:01:07.200351Z","caller":"traceutil/trace.go:171","msg":"trace[101501125] linearizableReadLoop","detail":"{readStateIndex:1873; appliedIndex:1872; }","duration":"149.685531ms","start":"2026-02-17T20:01:07.050646Z","end":"2026-02-17T20:01:07.200332Z","steps":["trace[101501125] 'read index received'  (duration: 149.495816ms)","trace[101501125] 'applied index is now lower than readState.Index'  (duration: 188.724µs)"],"step_count":2}
{"level":"info","ts":"2026-02-17T20:01:07.200474Z","caller":"traceutil/trace.go:171","msg":"trace[836393362] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"183.991784ms","start":"2026-02-17T20:01:07.016473Z","end":"2026-02-17T20:01:07.200465Z","steps":["trace[836393362] 'process raft request'  (duration: 183.706677ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T20:01:07.200772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.1041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-02-17T20:01:07.200798Z","caller":"traceutil/trace.go:171","msg":"trace[1870485663] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1798; }","duration":"150.162372ms","start":"2026-02-17T20:01:07.050624Z","end":"2026-02-17T20:01:07.200787Z","steps":["trace[1870485663] 'agreement among raft nodes before linearized reading'  (duration: 150.020669ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T20:01:07.202113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.00781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-02-17T20:01:07.202289Z","caller":"traceutil/trace.go:171","msg":"trace[912344952] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1798; }","duration":"130.841541ms","start":"2026-02-17T20:01:07.071424Z","end":"2026-02-17T20:01:07.202266Z","steps":["trace[912344952] 'agreement among raft nodes before linearized reading'  (duration: 129.613602ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T20:01:07.403133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.256031ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446605450 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1773 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:433 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T20:01:07.403741Z","caller":"traceutil/trace.go:171","msg":"trace[2094658793] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"195.248257ms","start":"2026-02-17T20:01:07.208425Z","end":"2026-02-17T20:01:07.403673Z","steps":["trace[2094658793] 'process raft request'  (duration: 51.32745ms)","trace[2094658793] 'compare'  (duration: 143.122428ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T20:01:07.404261Z","caller":"traceutil/trace.go:171","msg":"trace[1766751629] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"195.624896ms","start":"2026-02-17T20:01:07.208611Z","end":"2026-02-17T20:01:07.404236Z","steps":["trace[1766751629] 'process raft request'  (duration: 194.983451ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T20:01:07.736316Z","caller":"traceutil/trace.go:171","msg":"trace[181792878] linearizableReadLoop","detail":"{readStateIndex:1877; appliedIndex:1876; }","duration":"199.397924ms","start":"2026-02-17T20:01:07.536877Z","end":"2026-02-17T20:01:07.736274Z","steps":["trace[181792878] 'read index received'  (duration: 136.555134ms)","trace[181792878] 'applied index is now lower than readState.Index'  (duration: 62.84015ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T20:01:07.736595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.69575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:3021"}
{"level":"info","ts":"2026-02-17T20:01:07.736618Z","caller":"traceutil/trace.go:171","msg":"trace[1493853721] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1801; }","duration":"199.803033ms","start":"2026-02-17T20:01:07.536807Z","end":"2026-02-17T20:01:07.73661Z","steps":["trace[1493853721] 'agreement among raft nodes before linearized reading'  (duration: 199.578508ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T20:01:07.736822Z","caller":"traceutil/trace.go:171","msg":"trace[1409545439] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"298.866411ms","start":"2026-02-17T20:01:07.437925Z","end":"2026-02-17T20:01:07.736791Z","steps":["trace[1409545439] 'process raft request'  (duration: 235.58589ms)","trace[1409545439] 'compare'  (duration: 62.522662ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T20:01:07.950938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.398556ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13322101165446605461 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/default/test-pvc-pod\" mod_revision:1798 > success:<request_put:<key:\"/registry/pods/default/test-pvc-pod\" value_size:2963 >> failure:<request_range:<key:\"/registry/pods/default/test-pvc-pod\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T20:01:07.951298Z","caller":"traceutil/trace.go:171","msg":"trace[1387840094] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"139.284808ms","start":"2026-02-17T20:01:07.811991Z","end":"2026-02-17T20:01:07.951276Z","steps":["trace[1387840094] 'process raft request'  (duration: 36.457792ms)","trace[1387840094] 'compare'  (duration: 102.128139ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T20:01:08.073631Z","caller":"traceutil/trace.go:171","msg":"trace[639450134] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1802; }","duration":"118.485052ms","start":"2026-02-17T20:01:07.955124Z","end":"2026-02-17T20:01:08.073609Z","steps":["trace[639450134] 'process raft request'  (duration: 111.295534ms)"],"step_count":1}