{"level":"warn","ts":"2026-02-18T10:01:08.493764Z","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-18T10:01:08.494002Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.130:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.130:2380","--initial-cluster=instance=https://199.19.213.130:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.130:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.130: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-18T10:01:08.494121Z","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-18T10:01:08.494165Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.130:2380"]}
{"level":"info","ts":"2026-02-18T10:01:08.494197Z","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-18T10:01:08.494927Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.130:2379"]}
{"level":"info","ts":"2026-02-18T10:01:08.495061Z","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.19.213.130:2380"],"listen-peer-urls":["https://199.19.213.130:2380"],"advertise-client-urls":["https://199.19.213.130:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.130:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.130: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-18T10:01:08.501531Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.172277ms"}
{"level":"info","ts":"2026-02-18T10:01:08.508477Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a727d7e7ce5fe36a","cluster-id":"db8a5e7d54164af4"}
{"level":"info","ts":"2026-02-18T10:01:08.508539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a switched to configuration voters=()"}
{"level":"info","ts":"2026-02-18T10:01:08.508563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became follower at term 0"}
{"level":"info","ts":"2026-02-18T10:01:08.50858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a727d7e7ce5fe36a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-18T10:01:08.508596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became follower at term 1"}
{"level":"info","ts":"2026-02-18T10:01:08.508633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a switched to configuration voters=(12044833119025488746)"}
{"level":"warn","ts":"2026-02-18T10:01:08.528206Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-18T10:01:08.53781Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-18T10:01:08.539661Z","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-18T10:01:08.542766Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a727d7e7ce5fe36a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-18T10:01:08.545794Z","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-18T10:01:08.546156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a switched to configuration voters=(12044833119025488746)"}
{"level":"info","ts":"2026-02-18T10:01:08.546326Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"db8a5e7d54164af4","local-member-id":"a727d7e7ce5fe36a","added-peer-id":"a727d7e7ce5fe36a","added-peer-peer-urls":["https://199.19.213.130:2380"]}
{"level":"info","ts":"2026-02-18T10:01:08.546409Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a727d7e7ce5fe36a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-18T10:01:08.548201Z","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-18T10:01:08.548224Z","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-18T10:01:08.548233Z","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-18T10:01:08.548586Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.130:2380"}
{"level":"info","ts":"2026-02-18T10:01:08.5486Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.130:2380"}
{"level":"info","ts":"2026-02-18T10:01:08.551756Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a727d7e7ce5fe36a","initial-advertise-peer-urls":["https://199.19.213.130:2380"],"listen-peer-urls":["https://199.19.213.130:2380"],"advertise-client-urls":["https://199.19.213.130:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.130:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-18T10:01:08.551781Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-18T10:01:09.509603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a is starting a new election at term 1"}
{"level":"info","ts":"2026-02-18T10:01:09.509643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-18T10:01:09.509686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a received MsgPreVoteResp from a727d7e7ce5fe36a at term 1"}
{"level":"info","ts":"2026-02-18T10:01:09.509711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became candidate at term 2"}
{"level":"info","ts":"2026-02-18T10:01:09.509716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a received MsgVoteResp from a727d7e7ce5fe36a at term 2"}
{"level":"info","ts":"2026-02-18T10:01:09.509726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a727d7e7ce5fe36a became leader at term 2"}
{"level":"info","ts":"2026-02-18T10:01:09.509736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a727d7e7ce5fe36a elected leader a727d7e7ce5fe36a at term 2"}
{"level":"info","ts":"2026-02-18T10:01:09.512945Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a727d7e7ce5fe36a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.130:2379]}","request-path":"/0/members/a727d7e7ce5fe36a/attributes","cluster-id":"db8a5e7d54164af4","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-18T10:01:09.513088Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-18T10:01:09.513372Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-18T10:01:09.513466Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-18T10:01:09.51361Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-18T10:01:09.513623Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-18T10:01:09.516422Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-18T10:01:09.51655Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"db8a5e7d54164af4","local-member-id":"a727d7e7ce5fe36a","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-18T10:01:09.516603Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-18T10:01:09.516619Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-18T10:01:09.529866Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.130:2379"}
{"level":"info","ts":"2026-02-18T10:01:14.611844Z","caller":"traceutil/trace.go:171","msg":"trace[557685858] linearizableReadLoop","detail":"{readStateIndex:267; appliedIndex:266; }","duration":"108.807371ms","start":"2026-02-18T10:01:14.502995Z","end":"2026-02-18T10:01:14.611802Z","steps":["trace[557685858] 'read index received'  (duration: 27.082462ms)","trace[557685858] 'applied index is now lower than readState.Index'  (duration: 81.684069ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:01:14.612458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.394287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-18T10:01:14.612632Z","caller":"traceutil/trace.go:171","msg":"trace[3794051] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:260; }","duration":"109.570949ms","start":"2026-02-18T10:01:14.502944Z","end":"2026-02-18T10:01:14.612515Z","steps":["trace[3794051] 'agreement among raft nodes before linearized reading'  (duration: 109.034523ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:14.612714Z","caller":"traceutil/trace.go:171","msg":"trace[1677173015] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"161.809173ms","start":"2026-02-18T10:01:14.450758Z","end":"2026-02-18T10:01:14.612567Z","steps":["trace[1677173015] 'process raft request'  (duration: 79.273605ms)","trace[1677173015] 'compare'  (duration: 80.944652ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:14.831854Z","caller":"traceutil/trace.go:171","msg":"trace[1437016512] linearizableReadLoop","detail":"{readStateIndex:270; appliedIndex:269; }","duration":"118.115574ms","start":"2026-02-18T10:01:14.713703Z","end":"2026-02-18T10:01:14.831819Z","steps":["trace[1437016512] 'read index received'  (duration: 47.154832ms)","trace[1437016512] 'applied index is now lower than readState.Index'  (duration: 70.959022ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:01:14.832189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.441117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"}
{"level":"info","ts":"2026-02-18T10:01:14.832267Z","caller":"traceutil/trace.go:171","msg":"trace[526794808] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:263; }","duration":"118.581449ms","start":"2026-02-18T10:01:14.713675Z","end":"2026-02-18T10:01:14.832257Z","steps":["trace[526794808] 'agreement among raft nodes before linearized reading'  (duration: 118.360988ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:14.832604Z","caller":"traceutil/trace.go:171","msg":"trace[1504470374] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"119.930163ms","start":"2026-02-18T10:01:14.712662Z","end":"2026-02-18T10:01:14.832592Z","steps":["trace[1504470374] 'process raft request'  (duration: 48.340104ms)","trace[1504470374] 'compare'  (duration: 70.604419ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:14.955769Z","caller":"traceutil/trace.go:171","msg":"trace[176646536] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"102.441747ms","start":"2026-02-18T10:01:14.853308Z","end":"2026-02-18T10:01:14.95575Z","steps":["trace[176646536] 'process raft request'  (duration: 95.577279ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:15.21885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.028096ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834599022 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:265 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:01:15.218962Z","caller":"traceutil/trace.go:171","msg":"trace[1902256052] linearizableReadLoop","detail":"{readStateIndex:276; appliedIndex:273; }","duration":"176.424848ms","start":"2026-02-18T10:01:15.042528Z","end":"2026-02-18T10:01:15.218952Z","steps":["trace[1902256052] 'read index received'  (duration: 17.972319ms)","trace[1902256052] 'applied index is now lower than readState.Index'  (duration: 158.452029ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:15.219065Z","caller":"traceutil/trace.go:171","msg":"trace[453733645] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"212.268044ms","start":"2026-02-18T10:01:15.006792Z","end":"2026-02-18T10:01:15.21906Z","steps":["trace[453733645] 'process raft request'  (duration: 53.699662ms)","trace[453733645] 'compare'  (duration: 157.466491ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:15.219149Z","caller":"traceutil/trace.go:171","msg":"trace[412248723] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"209.645929ms","start":"2026-02-18T10:01:15.009499Z","end":"2026-02-18T10:01:15.219145Z","steps":["trace[412248723] 'process raft request'  (duration: 209.408956ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:15.219222Z","caller":"traceutil/trace.go:171","msg":"trace[835642476] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"208.806459ms","start":"2026-02-18T10:01:15.010412Z","end":"2026-02-18T10:01:15.219218Z","steps":["trace[835642476] 'process raft request'  (duration: 208.519916ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:15.219287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.757962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-18T10:01:15.2193Z","caller":"traceutil/trace.go:171","msg":"trace[399571206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:269; }","duration":"176.797752ms","start":"2026-02-18T10:01:15.042498Z","end":"2026-02-18T10:01:15.219296Z","steps":["trace[399571206] 'agreement among raft nodes before linearized reading'  (duration: 176.771342ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:15.228106Z","caller":"traceutil/trace.go:171","msg":"trace[304621329] transaction","detail":"{read_only:false; number_of_response:0; response_revision:269; }","duration":"136.894956ms","start":"2026-02-18T10:01:15.091197Z","end":"2026-02-18T10:01:15.228092Z","steps":["trace[304621329] 'process raft request'  (duration: 136.714404ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:15.228327Z","caller":"traceutil/trace.go:171","msg":"trace[111103903] transaction","detail":"{read_only:false; number_of_response:0; response_revision:269; }","duration":"137.067159ms","start":"2026-02-18T10:01:15.091256Z","end":"2026-02-18T10:01:15.228323Z","steps":["trace[111103903] 'process raft request'  (duration: 136.750395ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:15.228442Z","caller":"traceutil/trace.go:171","msg":"trace[585731682] transaction","detail":"{read_only:false; number_of_response:0; response_revision:269; }","duration":"137.090329ms","start":"2026-02-18T10:01:15.091346Z","end":"2026-02-18T10:01:15.228437Z","steps":["trace[585731682] 'process raft request'  (duration: 136.744615ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:15.228839Z","caller":"traceutil/trace.go:171","msg":"trace[249446907] transaction","detail":"{read_only:false; number_of_response:0; response_revision:269; }","duration":"137.440522ms","start":"2026-02-18T10:01:15.091383Z","end":"2026-02-18T10:01:15.228823Z","steps":["trace[249446907] 'process raft request'  (duration: 136.731065ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:15.228983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.847836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3958"}
{"level":"info","ts":"2026-02-18T10:01:15.229006Z","caller":"traceutil/trace.go:171","msg":"trace[1692168870] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:270; }","duration":"137.921227ms","start":"2026-02-18T10:01:15.09108Z","end":"2026-02-18T10:01:15.229001Z","steps":["trace[1692168870] 'agreement among raft nodes before linearized reading'  (duration: 137.830046ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:15.228896Z","caller":"traceutil/trace.go:171","msg":"trace[152368567] transaction","detail":"{read_only:false; number_of_response:0; response_revision:269; }","duration":"137.14222ms","start":"2026-02-18T10:01:15.091746Z","end":"2026-02-18T10:01:15.228888Z","steps":["trace[152368567] 'process raft request'  (duration: 136.802026ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:39.669142Z","caller":"traceutil/trace.go:171","msg":"trace[1846481278] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"161.711686ms","start":"2026-02-18T10:01:39.507415Z","end":"2026-02-18T10:01:39.669127Z","steps":["trace[1846481278] 'process raft request'  (duration: 161.631346ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:40.129731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.774093ms","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-18T10:01:40.129804Z","caller":"traceutil/trace.go:171","msg":"trace[1046345202] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"160.884984ms","start":"2026-02-18T10:01:39.968901Z","end":"2026-02-18T10:01:40.129786Z","steps":["trace[1046345202] 'range keys from in-memory index tree'  (duration: 160.701432ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:42.037154Z","caller":"traceutil/trace.go:171","msg":"trace[886349246] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:496; }","duration":"403.286704ms","start":"2026-02-18T10:01:41.633852Z","end":"2026-02-18T10:01:42.037139Z","steps":["trace[886349246] 'read index received'  (duration: 375.603287ms)","trace[886349246] 'applied index is now lower than readState.Index'  (duration: 27.682807ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:42.037336Z","caller":"traceutil/trace.go:171","msg":"trace[2073855875] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"480.856903ms","start":"2026-02-18T10:01:41.556469Z","end":"2026-02-18T10:01:42.037326Z","steps":["trace[2073855875] 'process raft request'  (duration: 452.989315ms)","trace[2073855875] 'compare'  (duration: 27.188983ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:01:42.037411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:01:41.556455Z","time spent":"480.899943ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:421 > 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-18T10:01:42.03757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.719286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:01:42.037592Z","caller":"traceutil/trace.go:171","msg":"trace[1893013516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:479; }","duration":"403.763398ms","start":"2026-02-18T10:01:41.633822Z","end":"2026-02-18T10:01:42.037585Z","steps":["trace[1893013516] 'agreement among raft nodes before linearized reading'  (duration: 403.723227ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:42.037612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:01:41.633791Z","time spent":"403.816488ms","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:01:42.037713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.444776ms","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-18T10:01:42.037729Z","caller":"traceutil/trace.go:171","msg":"trace[1636536322] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:479; }","duration":"365.484116ms","start":"2026-02-18T10:01:41.67224Z","end":"2026-02-18T10:01:42.037725Z","steps":["trace[1636536322] 'agreement among raft nodes before linearized reading'  (duration: 365.452676ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:42.037746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:01:41.672228Z","time spent":"365.513787ms","remote":"127.0.0.1:56084","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-18T10:01:46.186054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.144436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-18T10:01:46.186119Z","caller":"traceutil/trace.go:171","msg":"trace[1905112815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:514; }","duration":"136.237047ms","start":"2026-02-18T10:01:46.049868Z","end":"2026-02-18T10:01:46.186105Z","steps":["trace[1905112815] 'range keys from in-memory index tree'  (duration: 135.979465ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:46.418224Z","caller":"traceutil/trace.go:171","msg":"trace[1556217515] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"225.89065ms","start":"2026-02-18T10:01:46.192315Z","end":"2026-02-18T10:01:46.418206Z","steps":["trace[1556217515] 'process raft request'  (duration: 225.760618ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:46.551942Z","caller":"traceutil/trace.go:171","msg":"trace[1092156169] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"355.442156ms","start":"2026-02-18T10:01:46.196483Z","end":"2026-02-18T10:01:46.551925Z","steps":["trace[1092156169] 'process raft request'  (duration: 355.408175ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:46.552049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:01:46.196475Z","time spent":"355.520057ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:507 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-18T10:01:46.552341Z","caller":"traceutil/trace.go:171","msg":"trace[1445594275] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"356.504814ms","start":"2026-02-18T10:01:46.195828Z","end":"2026-02-18T10:01:46.552333Z","steps":["trace[1445594275] 'process raft request'  (duration: 355.967839ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:46.552379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:01:46.195811Z","time spent":"356.546504ms","remote":"127.0.0.1:56000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-vdkhg\" mod_revision:463 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-vdkhg\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-vdkhg\" > >"}
{"level":"warn","ts":"2026-02-18T10:01:46.91618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.927433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:01:46.916231Z","caller":"traceutil/trace.go:171","msg":"trace[738898800] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"283.039375ms","start":"2026-02-18T10:01:46.633178Z","end":"2026-02-18T10:01:46.916218Z","steps":["trace[738898800] 'range keys from in-memory index tree'  (duration: 282.848233ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:47.692208Z","caller":"traceutil/trace.go:171","msg":"trace[1818662358] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:536; }","duration":"279.820488ms","start":"2026-02-18T10:01:47.41237Z","end":"2026-02-18T10:01:47.692191Z","steps":["trace[1818662358] 'read index received'  (duration: 279.762467ms)","trace[1818662358] 'applied index is now lower than readState.Index'  (duration: 57.211µs)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:47.692292Z","caller":"traceutil/trace.go:171","msg":"trace[155883439] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"317.700884ms","start":"2026-02-18T10:01:47.374584Z","end":"2026-02-18T10:01:47.692285Z","steps":["trace[155883439] 'process raft request'  (duration: 317.484333ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:47.692377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:01:47.374572Z","time spent":"317.738615ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:510 > 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-18T10:01:47.692431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.04766ms","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-18T10:01:47.692473Z","caller":"traceutil/trace.go:171","msg":"trace[209077391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"280.12442ms","start":"2026-02-18T10:01:47.412338Z","end":"2026-02-18T10:01:47.692463Z","steps":["trace[209077391] 'agreement among raft nodes before linearized reading'  (duration: 280.01608ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:48.126216Z","caller":"traceutil/trace.go:171","msg":"trace[373244532] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"430.986049ms","start":"2026-02-18T10:01:47.695212Z","end":"2026-02-18T10:01:48.126198Z","steps":["trace[373244532] 'process raft request'  (duration: 430.880468ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:48.126326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:01:47.695196Z","time spent":"431.071819ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:511 > 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-18T10:01:48.126485Z","caller":"traceutil/trace.go:171","msg":"trace[1310995456] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"434.220775ms","start":"2026-02-18T10:01:47.692257Z","end":"2026-02-18T10:01:48.126478Z","steps":["trace[1310995456] 'read index received'  (duration: 422.141603ms)","trace[1310995456] 'applied index is now lower than readState.Index'  (duration: 12.076842ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:01:48.126531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.469765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:01:48.126549Z","caller":"traceutil/trace.go:171","msg":"trace[1254543298] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"492.522555ms","start":"2026-02-18T10:01:47.634021Z","end":"2026-02-18T10:01:48.126543Z","steps":["trace[1254543298] 'agreement among raft nodes before linearized reading'  (duration: 492.480945ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:48.126567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:01:47.634002Z","time spent":"492.561186ms","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:01:49.794723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.757222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:01:49.794789Z","caller":"traceutil/trace.go:171","msg":"trace[718071638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"161.857152ms","start":"2026-02-18T10:01:49.632916Z","end":"2026-02-18T10:01:49.794773Z","steps":["trace[718071638] 'range keys from in-memory index tree'  (duration: 161.707311ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:51.371274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.631292ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834599599 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/cilium-vdkhg.18954f04eaae8982\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-vdkhg.18954f04eaae8982\" value_size:624 lease:7163710162979823119 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:01:51.371353Z","caller":"traceutil/trace.go:171","msg":"trace[847275933] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:557; }","duration":"176.397597ms","start":"2026-02-18T10:01:51.194944Z","end":"2026-02-18T10:01:51.371341Z","steps":["trace[847275933] 'read index received'  (duration: 24.46µs)","trace[847275933] 'applied index is now lower than readState.Index'  (duration: 176.371947ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:51.371382Z","caller":"traceutil/trace.go:171","msg":"trace[1742139619] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"393.479337ms","start":"2026-02-18T10:01:50.977874Z","end":"2026-02-18T10:01:51.371353Z","steps":["trace[1742139619] 'process raft request'  (duration: 94.725023ms)","trace[1742139619] 'compare'  (duration: 298.400471ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:01:51.371456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.508258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vdkhg\" ","response":"range_response_count:1 size:17415"}
{"level":"info","ts":"2026-02-18T10:01:51.371476Z","caller":"traceutil/trace.go:171","msg":"trace[732136895] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vdkhg; range_end:; response_count:1; response_revision:538; }","duration":"176.558138ms","start":"2026-02-18T10:01:51.194912Z","end":"2026-02-18T10:01:51.37147Z","steps":["trace[732136895] 'agreement among raft nodes before linearized reading'  (duration: 176.461177ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:51.371542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:01:50.977857Z","time spent":"393.613348ms","remote":"127.0.0.1:55896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-vdkhg.18954f04eaae8982\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-vdkhg.18954f04eaae8982\" value_size:624 lease:7163710162979823119 >> failure:<>"}
{"level":"info","ts":"2026-02-18T10:01:52.174084Z","caller":"traceutil/trace.go:171","msg":"trace[587069201] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"110.081102ms","start":"2026-02-18T10:01:52.063983Z","end":"2026-02-18T10:01:52.174064Z","steps":["trace[587069201] 'process raft request'  (duration: 81.36326ms)","trace[587069201] 'compare'  (duration: 28.173518ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:01:52.458074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.536251ms","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-18T10:01:52.458174Z","caller":"traceutil/trace.go:171","msg":"trace[698814790] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:552; }","duration":"153.645872ms","start":"2026-02-18T10:01:52.304514Z","end":"2026-02-18T10:01:52.458159Z","steps":["trace[698814790] 'range keys from in-memory index tree'  (duration: 153.526631ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:52.458517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.002475ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834599626 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:549 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:5070 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:01:52.458624Z","caller":"traceutil/trace.go:171","msg":"trace[1966249938] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:572; }","duration":"248.532643ms","start":"2026-02-18T10:01:52.210078Z","end":"2026-02-18T10:01:52.458611Z","steps":["trace[1966249938] 'read index received'  (duration: 9.418509ms)","trace[1966249938] 'applied index is now lower than readState.Index'  (duration: 239.113054ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:52.458846Z","caller":"traceutil/trace.go:171","msg":"trace[1067467358] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"248.888156ms","start":"2026-02-18T10:01:52.209934Z","end":"2026-02-18T10:01:52.458822Z","steps":["trace[1067467358] 'process raft request'  (duration: 113.526318ms)","trace[1067467358] 'compare'  (duration: 134.930354ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:52.459012Z","caller":"traceutil/trace.go:171","msg":"trace[938082899] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"249.014725ms","start":"2026-02-18T10:01:52.209987Z","end":"2026-02-18T10:01:52.459002Z","steps":["trace[938082899] 'process raft request'  (duration: 248.580432ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:52.459174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.096346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vdkhg\" ","response":"range_response_count:1 size:17577"}
{"level":"info","ts":"2026-02-18T10:01:52.459208Z","caller":"traceutil/trace.go:171","msg":"trace[405881887] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vdkhg; range_end:; response_count:1; response_revision:554; }","duration":"249.154477ms","start":"2026-02-18T10:01:52.210045Z","end":"2026-02-18T10:01:52.4592Z","steps":["trace[405881887] 'agreement among raft nodes before linearized reading'  (duration: 249.052456ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:52.459344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.953263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:01:52.459378Z","caller":"traceutil/trace.go:171","msg":"trace[1086277304] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:554; }","duration":"208.011324ms","start":"2026-02-18T10:01:52.251358Z","end":"2026-02-18T10:01:52.459369Z","steps":["trace[1086277304] 'agreement among raft nodes before linearized reading'  (duration: 207.967044ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:52.459681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.283246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.130\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-18T10:01:52.45971Z","caller":"traceutil/trace.go:171","msg":"trace[474924816] range","detail":"{range_begin:/registry/masterleases/199.19.213.130; range_end:; response_count:1; response_revision:554; }","duration":"105.312656ms","start":"2026-02-18T10:01:52.35439Z","end":"2026-02-18T10:01:52.459702Z","steps":["trace[474924816] 'agreement among raft nodes before linearized reading'  (duration: 105.262036ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:55.269257Z","caller":"traceutil/trace.go:171","msg":"trace[778030905] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"190.618648ms","start":"2026-02-18T10:01:55.078613Z","end":"2026-02-18T10:01:55.269232Z","steps":["trace[778030905] 'process raft request'  (duration: 149.128487ms)","trace[778030905] 'compare'  (duration: 41.067559ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:55.858267Z","caller":"traceutil/trace.go:171","msg":"trace[497042609] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"136.221101ms","start":"2026-02-18T10:01:55.72203Z","end":"2026-02-18T10:01:55.858251Z","steps":["trace[497042609] 'process raft request'  (duration: 136.09907ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:55.863738Z","caller":"traceutil/trace.go:171","msg":"trace[2144677585] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:627; }","duration":"140.744034ms","start":"2026-02-18T10:01:55.722968Z","end":"2026-02-18T10:01:55.863712Z","steps":["trace[2144677585] 'read index received'  (duration: 135.126244ms)","trace[2144677585] 'applied index is now lower than readState.Index'  (duration: 5.61705ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:55.863932Z","caller":"traceutil/trace.go:171","msg":"trace[398872617] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"141.573429ms","start":"2026-02-18T10:01:55.722352Z","end":"2026-02-18T10:01:55.863926Z","steps":["trace[398872617] 'process raft request'  (duration: 141.274876ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:55.864295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.313068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:01:55.864384Z","caller":"traceutil/trace.go:171","msg":"trace[2054743084] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:608; }","duration":"141.431438ms","start":"2026-02-18T10:01:55.722946Z","end":"2026-02-18T10:01:55.864377Z","steps":["trace[2054743084] 'agreement among raft nodes before linearized reading'  (duration: 141.287198ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:55.864649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.630759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:01:55.864838Z","caller":"traceutil/trace.go:171","msg":"trace[449022382] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:608; }","duration":"141.83932ms","start":"2026-02-18T10:01:55.722993Z","end":"2026-02-18T10:01:55.864832Z","steps":["trace[449022382] 'agreement among raft nodes before linearized reading'  (duration: 141.628839ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:55.865248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.220643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:01:55.865326Z","caller":"traceutil/trace.go:171","msg":"trace[1499245038] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:608; }","duration":"142.309154ms","start":"2026-02-18T10:01:55.723007Z","end":"2026-02-18T10:01:55.865316Z","steps":["trace[1499245038] 'agreement among raft nodes before linearized reading'  (duration: 142.154723ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:55.988202Z","caller":"traceutil/trace.go:171","msg":"trace[639124575] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"120.411866ms","start":"2026-02-18T10:01:55.867769Z","end":"2026-02-18T10:01:55.988181Z","steps":["trace[639124575] 'process raft request'  (duration: 120.230074ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:56.149726Z","caller":"traceutil/trace.go:171","msg":"trace[948102594] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"120.294621ms","start":"2026-02-18T10:01:56.029416Z","end":"2026-02-18T10:01:56.149711Z","steps":["trace[948102594] 'process raft request'  (duration: 120.268881ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:56.150281Z","caller":"traceutil/trace.go:171","msg":"trace[868576036] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"149.584521ms","start":"2026-02-18T10:01:56.000679Z","end":"2026-02-18T10:01:56.150263Z","steps":["trace[868576036] 'process raft request'  (duration: 148.983217ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:56.150406Z","caller":"traceutil/trace.go:171","msg":"trace[742272317] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:631; }","duration":"122.372476ms","start":"2026-02-18T10:01:56.028024Z","end":"2026-02-18T10:01:56.150397Z","steps":["trace[742272317] 'read index received'  (duration: 78.487418ms)","trace[742272317] 'applied index is now lower than readState.Index'  (duration: 43.883648ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:56.150428Z","caller":"traceutil/trace.go:171","msg":"trace[383688955] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"151.242993ms","start":"2026-02-18T10:01:55.998744Z","end":"2026-02-18T10:01:56.149987Z","steps":["trace[383688955] 'process raft request'  (duration: 150.899691ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:56.150597Z","caller":"traceutil/trace.go:171","msg":"trace[728350566] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"151.957268ms","start":"2026-02-18T10:01:55.998633Z","end":"2026-02-18T10:01:56.15059Z","steps":["trace[728350566] 'process raft request'  (duration: 107.872129ms)","trace[728350566] 'compare'  (duration: 43.030732ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:56.150619Z","caller":"traceutil/trace.go:171","msg":"trace[567699232] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"151.884538ms","start":"2026-02-18T10:01:55.998728Z","end":"2026-02-18T10:01:56.150612Z","steps":["trace[567699232] 'process raft request'  (duration: 150.885391ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:56.150779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.742509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-8n9jw\" ","response":"range_response_count:1 size:3849"}
{"level":"info","ts":"2026-02-18T10:01:56.151971Z","caller":"traceutil/trace.go:171","msg":"trace[806925229] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-8n9jw; range_end:; response_count:1; response_revision:615; }","duration":"123.971197ms","start":"2026-02-18T10:01:56.02799Z","end":"2026-02-18T10:01:56.151961Z","steps":["trace[806925229] 'agreement among raft nodes before linearized reading'  (duration: 122.432846ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:56.336859Z","caller":"traceutil/trace.go:171","msg":"trace[1060074761] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:637; }","duration":"132.911781ms","start":"2026-02-18T10:01:56.203931Z","end":"2026-02-18T10:01:56.336843Z","steps":["trace[1060074761] 'read index received'  (duration: 81.6817ms)","trace[1060074761] 'applied index is now lower than readState.Index'  (duration: 51.229351ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:56.33689Z","caller":"traceutil/trace.go:171","msg":"trace[1840176911] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"162.698157ms","start":"2026-02-18T10:01:56.174157Z","end":"2026-02-18T10:01:56.336855Z","steps":["trace[1840176911] 'process raft request'  (duration: 111.425916ms)","trace[1840176911] 'compare'  (duration: 51.12824ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:01:56.337263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.320166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-4f4lc\" ","response":"range_response_count:1 size:3849"}
{"level":"info","ts":"2026-02-18T10:01:56.337295Z","caller":"traceutil/trace.go:171","msg":"trace[1392344830] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-4f4lc; range_end:; response_count:1; response_revision:618; }","duration":"133.381956ms","start":"2026-02-18T10:01:56.203907Z","end":"2026-02-18T10:01:56.337289Z","steps":["trace[1392344830] 'agreement among raft nodes before linearized reading'  (duration: 133.206515ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:56.337383Z","caller":"traceutil/trace.go:171","msg":"trace[360412485] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"145.457963ms","start":"2026-02-18T10:01:56.19192Z","end":"2026-02-18T10:01:56.337378Z","steps":["trace[360412485] 'process raft request'  (duration: 144.893659ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:01:56.556099Z","caller":"traceutil/trace.go:171","msg":"trace[8069123] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"101.177843ms","start":"2026-02-18T10:01:56.454902Z","end":"2026-02-18T10:01:56.55608Z","steps":["trace[8069123] 'read index received'  (duration: 100.720469ms)","trace[8069123] 'applied index is now lower than readState.Index'  (duration: 456.764µs)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:01:56.556339Z","caller":"traceutil/trace.go:171","msg":"trace[1250016838] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"104.188285ms","start":"2026-02-18T10:01:56.452143Z","end":"2026-02-18T10:01:56.556331Z","steps":["trace[1250016838] 'process raft request'  (duration: 103.53587ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:01:56.556533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.616746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"}
{"level":"info","ts":"2026-02-18T10:01:56.556558Z","caller":"traceutil/trace.go:171","msg":"trace[1994820310] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:624; }","duration":"101.683876ms","start":"2026-02-18T10:01:56.454865Z","end":"2026-02-18T10:01:56.556549Z","steps":["trace[1994820310] 'agreement among raft nodes before linearized reading'  (duration: 101.587015ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:09.014407Z","caller":"traceutil/trace.go:171","msg":"trace[1613100318] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:962; }","duration":"117.177531ms","start":"2026-02-18T10:03:08.89721Z","end":"2026-02-18T10:03:09.014388Z","steps":["trace[1613100318] 'read index received'  (duration: 25.588878ms)","trace[1613100318] 'applied index is now lower than readState.Index'  (duration: 91.587793ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:09.014983Z","caller":"traceutil/trace.go:171","msg":"trace[630395120] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"135.200628ms","start":"2026-02-18T10:03:08.879766Z","end":"2026-02-18T10:03:09.014967Z","steps":["trace[630395120] 'process raft request'  (duration: 43.059012ms)","trace[630395120] 'compare'  (duration: 91.465991ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:09.015722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.48773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:09.016053Z","caller":"traceutil/trace.go:171","msg":"trace[1080139417] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:924; }","duration":"118.627343ms","start":"2026-02-18T10:03:08.897137Z","end":"2026-02-18T10:03:09.015764Z","steps":["trace[1080139417] 'agreement among raft nodes before linearized reading'  (duration: 118.50215ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:09.919928Z","caller":"traceutil/trace.go:171","msg":"trace[1099148067] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:964; }","duration":"192.049096ms","start":"2026-02-18T10:03:09.727855Z","end":"2026-02-18T10:03:09.919904Z","steps":["trace[1099148067] 'read index received'  (duration: 103.738421ms)","trace[1099148067] 'applied index is now lower than readState.Index'  (duration: 88.309455ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:09.920298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.428044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:09.920492Z","caller":"traceutil/trace.go:171","msg":"trace[1396448797] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:926; }","duration":"192.694621ms","start":"2026-02-18T10:03:09.727783Z","end":"2026-02-18T10:03:09.920478Z","steps":["trace[1396448797] 'agreement among raft nodes before linearized reading'  (duration: 192.388684ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:09.921093Z","caller":"traceutil/trace.go:171","msg":"trace[1587686345] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"823.489939ms","start":"2026-02-18T10:03:09.097584Z","end":"2026-02-18T10:03:09.921074Z","steps":["trace[1587686345] 'process raft request'  (duration: 734.140862ms)","trace[1587686345] 'compare'  (duration: 88.036129ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:09.921316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:09.097559Z","time spent":"823.667155ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:915 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-18T10:03:11.093154Z","caller":"traceutil/trace.go:171","msg":"trace[1681150359] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:966; }","duration":"168.92044ms","start":"2026-02-18T10:03:10.924208Z","end":"2026-02-18T10:03:11.093128Z","steps":["trace[1681150359] 'read index received'  (duration: 163.688144ms)","trace[1681150359] 'applied index is now lower than readState.Index'  (duration: 5.230486ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:11.09522Z","caller":"traceutil/trace.go:171","msg":"trace[1437592259] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"214.925349ms","start":"2026-02-18T10:03:10.880258Z","end":"2026-02-18T10:03:11.095183Z","steps":["trace[1437592259] 'process raft request'  (duration: 207.70195ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:11.095595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.365543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-18T10:03:11.095652Z","caller":"traceutil/trace.go:171","msg":"trace[827824383] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:928; }","duration":"171.477646ms","start":"2026-02-18T10:03:10.924162Z","end":"2026-02-18T10:03:11.095639Z","steps":["trace[827824383] 'agreement among raft nodes before linearized reading'  (duration: 171.388644ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:13.256648Z","caller":"traceutil/trace.go:171","msg":"trace[1357354396] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"113.023044ms","start":"2026-02-18T10:03:13.143603Z","end":"2026-02-18T10:03:13.256626Z","steps":["trace[1357354396] 'process raft request'  (duration: 112.947733ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:13.257534Z","caller":"traceutil/trace.go:171","msg":"trace[507990667] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"114.984786ms","start":"2026-02-18T10:03:13.142307Z","end":"2026-02-18T10:03:13.257292Z","steps":["trace[507990667] 'process raft request'  (duration: 49.453698ms)","trace[507990667] 'compare'  (duration: 64.424963ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:15.07809Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600565,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:15.568668Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.052720554s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-18T10:03:15.569203Z","caller":"traceutil/trace.go:171","msg":"trace[307710963] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"1.053341648s","start":"2026-02-18T10:03:14.515837Z","end":"2026-02-18T10:03:15.569179Z","steps":["trace[307710963] 'process raft request'  (duration: 1.053160574s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:15.569794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:14.515824Z","time spent":"1.05388789s","remote":"127.0.0.1:56000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2560,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/default/test-pvc-pod\" mod_revision:918 > success:<request_put:<key:\"/registry/pods/default/test-pvc-pod\" value_size:2517 >> failure:<request_range:<key:\"/registry/pods/default/test-pvc-pod\" > >"}
{"level":"info","ts":"2026-02-18T10:03:15.569462Z","caller":"traceutil/trace.go:171","msg":"trace[496935718] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:982; }","duration":"992.226748ms","start":"2026-02-18T10:03:14.57722Z","end":"2026-02-18T10:03:15.569447Z","steps":["trace[496935718] 'read index received'  (duration: 992.219998ms)","trace[496935718] 'applied index is now lower than readState.Index'  (duration: 5.59µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:15.569673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.422482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-02-18T10:03:15.570487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.351734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"}
{"level":"info","ts":"2026-02-18T10:03:15.570571Z","caller":"traceutil/trace.go:171","msg":"trace[717980860] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:942; }","duration":"960.464136ms","start":"2026-02-18T10:03:14.610094Z","end":"2026-02-18T10:03:15.570558Z","steps":["trace[717980860] 'agreement among raft nodes before linearized reading'  (duration: 960.242472ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:15.570703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:14.610079Z","time spent":"960.611779ms","remote":"127.0.0.1:55976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":1489,"request content":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" "}
{"level":"warn","ts":"2026-02-18T10:03:15.571031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.937818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:15.571205Z","caller":"traceutil/trace.go:171","msg":"trace[1546110304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:942; }","duration":"934.122281ms","start":"2026-02-18T10:03:14.63707Z","end":"2026-02-18T10:03:15.571193Z","steps":["trace[1546110304] 'agreement among raft nodes before linearized reading'  (duration: 933.930587ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:15.571338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:14.637063Z","time spent":"934.263454ms","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-18T10:03:15.570471Z","caller":"traceutil/trace.go:171","msg":"trace[1928295197] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:942; }","duration":"993.076166ms","start":"2026-02-18T10:03:14.577213Z","end":"2026-02-18T10:03:15.570289Z","steps":["trace[1928295197] 'agreement among raft nodes before linearized reading'  (duration: 992.277969ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:15.571508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.280215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-02-18T10:03:15.571699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:14.577139Z","time spent":"994.498776ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-18T10:03:15.5721Z","caller":"traceutil/trace.go:171","msg":"trace[1889367877] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:942; }","duration":"425.51334ms","start":"2026-02-18T10:03:15.146158Z","end":"2026-02-18T10:03:15.571671Z","steps":["trace[1889367877] 'agreement among raft nodes before linearized reading'  (duration: 424.678011ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:15.572176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:15.14613Z","time spent":"426.01776ms","remote":"127.0.0.1:56084","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-18T10:03:15.572595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.656135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-18T10:03:15.572699Z","caller":"traceutil/trace.go:171","msg":"trace[2100732523] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:942; }","duration":"308.799758ms","start":"2026-02-18T10:03:15.263891Z","end":"2026-02-18T10:03:15.572691Z","steps":["trace[2100732523] 'agreement among raft nodes before linearized reading'  (duration: 308.648135ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:15.572833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:15.26386Z","time spent":"308.964531ms","remote":"127.0.0.1:56084","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-18T10:03:15.572608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.835867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-18T10:03:15.576787Z","caller":"traceutil/trace.go:171","msg":"trace[488173841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:942; }","duration":"312.037117ms","start":"2026-02-18T10:03:15.26474Z","end":"2026-02-18T10:03:15.576777Z","steps":["trace[488173841] 'agreement among raft nodes before linearized reading'  (duration: 307.791127ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:15.576874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:15.264725Z","time spent":"312.138759ms","remote":"127.0.0.1:56084","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-18T10:03:15.825199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.401278ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834600571 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:933 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:03:15.827035Z","caller":"traceutil/trace.go:171","msg":"trace[235766796] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"244.622972ms","start":"2026-02-18T10:03:15.582384Z","end":"2026-02-18T10:03:15.827007Z","steps":["trace[235766796] 'process raft request'  (duration: 77.300824ms)","trace[235766796] 'compare'  (duration: 165.244204ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:15.828855Z","caller":"traceutil/trace.go:171","msg":"trace[2001651306] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"245.873619ms","start":"2026-02-18T10:03:15.582964Z","end":"2026-02-18T10:03:15.828837Z","steps":["trace[2001651306] 'process raft request'  (duration: 244.724205ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:15.831599Z","caller":"traceutil/trace.go:171","msg":"trace[1666887828] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"246.584854ms","start":"2026-02-18T10:03:15.585Z","end":"2026-02-18T10:03:15.831585Z","steps":["trace[1666887828] 'process raft request'  (duration: 243.792784ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:15.831803Z","caller":"traceutil/trace.go:171","msg":"trace[1530249167] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"245.750786ms","start":"2026-02-18T10:03:15.58604Z","end":"2026-02-18T10:03:15.831791Z","steps":["trace[1530249167] 'process raft request'  (duration: 245.493911ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:16.579074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.62986ms","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-18T10:03:16.580003Z","caller":"traceutil/trace.go:171","msg":"trace[406674394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:946; }","duration":"637.60498ms","start":"2026-02-18T10:03:15.942377Z","end":"2026-02-18T10:03:16.579982Z","steps":["trace[406674394] 'range keys from in-memory index tree'  (duration: 636.451685ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:16.580198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:15.94236Z","time spent":"637.821915ms","remote":"127.0.0.1:56084","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-18T10:03:16.830082Z","caller":"traceutil/trace.go:171","msg":"trace[1994723286] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"244.194091ms","start":"2026-02-18T10:03:16.585864Z","end":"2026-02-18T10:03:16.830058Z","steps":["trace[1994723286] 'process raft request'  (duration: 244.028207ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:16.831075Z","caller":"traceutil/trace.go:171","msg":"trace[1194775451] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:987; }","duration":"195.203638ms","start":"2026-02-18T10:03:16.635838Z","end":"2026-02-18T10:03:16.831042Z","steps":["trace[1194775451] 'read index received'  (duration: 195.196828ms)","trace[1194775451] 'applied index is now lower than readState.Index'  (duration: 5.43µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:16.831184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.31734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:16.831238Z","caller":"traceutil/trace.go:171","msg":"trace[155451396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:947; }","duration":"195.421482ms","start":"2026-02-18T10:03:16.635801Z","end":"2026-02-18T10:03:16.831222Z","steps":["trace[155451396] 'agreement among raft nodes before linearized reading'  (duration: 195.32199ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:17.151596Z","caller":"traceutil/trace.go:171","msg":"trace[1293515469] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:987; }","duration":"318.710328ms","start":"2026-02-18T10:03:16.832864Z","end":"2026-02-18T10:03:17.151575Z","steps":["trace[1293515469] 'read index received'  (duration: 286.091346ms)","trace[1293515469] 'applied index is now lower than readState.Index'  (duration: 32.617621ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:17.151764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.874982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:17.15183Z","caller":"traceutil/trace.go:171","msg":"trace[347705092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:948; }","duration":"318.997134ms","start":"2026-02-18T10:03:16.832822Z","end":"2026-02-18T10:03:17.151819Z","steps":["trace[347705092] 'agreement among raft nodes before linearized reading'  (duration: 318.890172ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:17.151856Z","caller":"traceutil/trace.go:171","msg":"trace[321454996] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"476.18695ms","start":"2026-02-18T10:03:16.67565Z","end":"2026-02-18T10:03:17.151837Z","steps":["trace[321454996] 'process raft request'  (duration: 443.276541ms)","trace[321454996] 'compare'  (duration: 32.546671ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:17.151874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:16.83278Z","time spent":"319.086116ms","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:17.151969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:16.675615Z","time spent":"476.290002ms","remote":"127.0.0.1:55996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5261,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:742 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5227 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-18T10:03:17.159473Z","caller":"traceutil/trace.go:171","msg":"trace[1049402913] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"225.466669ms","start":"2026-02-18T10:03:16.933984Z","end":"2026-02-18T10:03:17.159451Z","steps":["trace[1049402913] 'process raft request'  (duration: 225.281754ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:19.010196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.560381ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834600588 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:946 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:03:19.010648Z","caller":"traceutil/trace.go:171","msg":"trace[2142613363] linearizableReadLoop","detail":"{readStateIndex:994; appliedIndex:991; }","duration":"802.970645ms","start":"2026-02-18T10:03:18.20766Z","end":"2026-02-18T10:03:19.010631Z","steps":["trace[2142613363] 'read index received'  (duration: 137.796011ms)","trace[2142613363] 'applied index is now lower than readState.Index'  (duration: 665.173694ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:19.011394Z","caller":"traceutil/trace.go:171","msg":"trace[858876779] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"1.128031401s","start":"2026-02-18T10:03:17.883342Z","end":"2026-02-18T10:03:19.011373Z","steps":["trace[858876779] 'process raft request'  (duration: 462.213504ms)","trace[858876779] 'compare'  (duration: 664.0027ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:19.011632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:17.883329Z","time spent":"1.128181354s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:946 > 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-18T10:03:19.012044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.012306ms","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-18T10:03:19.012121Z","caller":"traceutil/trace.go:171","msg":"trace[1520048071] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:953; }","duration":"804.481285ms","start":"2026-02-18T10:03:18.207622Z","end":"2026-02-18T10:03:19.012104Z","steps":["trace[1520048071] 'agreement among raft nodes before linearized reading'  (duration: 803.997845ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:19.012166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:18.207604Z","time spent":"804.548217ms","remote":"127.0.0.1:56234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-02-18T10:03:19.01261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.612273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2575"}
{"level":"info","ts":"2026-02-18T10:03:19.012881Z","caller":"traceutil/trace.go:171","msg":"trace[768817701] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:953; }","duration":"691.920209ms","start":"2026-02-18T10:03:18.320947Z","end":"2026-02-18T10:03:19.012867Z","steps":["trace[768817701] 'agreement among raft nodes before linearized reading'  (duration: 691.048851ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:19.012969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:18.320928Z","time spent":"692.027411ms","remote":"127.0.0.1:56000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2599,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "}
{"level":"warn","ts":"2026-02-18T10:03:19.013506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.692516ms","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-18T10:03:19.013625Z","caller":"traceutil/trace.go:171","msg":"trace[1948000099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:953; }","duration":"177.91051ms","start":"2026-02-18T10:03:18.835703Z","end":"2026-02-18T10:03:19.013613Z","steps":["trace[1948000099] 'agreement among raft nodes before linearized reading'  (duration: 177.741397ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:19.01391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.200167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:19.014Z","caller":"traceutil/trace.go:171","msg":"trace[1840399504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:953; }","duration":"376.32551ms","start":"2026-02-18T10:03:18.637662Z","end":"2026-02-18T10:03:19.013988Z","steps":["trace[1840399504] 'agreement among raft nodes before linearized reading'  (duration: 376.214796ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:19.014128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:18.637642Z","time spent":"376.475792ms","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-18T10:03:19.014843Z","caller":"traceutil/trace.go:171","msg":"trace[1211598656] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"1.131326089s","start":"2026-02-18T10:03:17.883505Z","end":"2026-02-18T10:03:19.014831Z","steps":["trace[1211598656] 'process raft request'  (duration: 1.127083541s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:19.015001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:17.883483Z","time spent":"1.131441141s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:945 > 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-18T10:03:19.014195Z","caller":"traceutil/trace.go:171","msg":"trace[1712366008] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"1.130077623s","start":"2026-02-18T10:03:17.883461Z","end":"2026-02-18T10:03:19.013538Z","steps":["trace[1712366008] 'process raft request'  (duration: 1.126924668s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:19.015772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:17.883455Z","time spent":"1.132099134s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:943 > 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-18T10:03:20.62064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124989792s","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834600596 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:947 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:03:20.621026Z","caller":"traceutil/trace.go:171","msg":"trace[1434113076] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:995; }","duration":"1.508895707s","start":"2026-02-18T10:03:19.112078Z","end":"2026-02-18T10:03:20.620974Z","steps":["trace[1434113076] 'read index received'  (duration: 383.493116ms)","trace[1434113076] 'applied index is now lower than readState.Index'  (duration: 1.125400441s)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:20.621062Z","caller":"traceutil/trace.go:171","msg":"trace[2003999384] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"1.596999111s","start":"2026-02-18T10:03:19.02403Z","end":"2026-02-18T10:03:20.621029Z","steps":["trace[2003999384] 'process raft request'  (duration: 471.529659ms)","trace[2003999384] 'compare'  (duration: 1.124733417s)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:20.621625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:19.024025Z","time spent":"1.597531752s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:947 > 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-18T10:03:20.623715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.511610602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2587"}
{"level":"info","ts":"2026-02-18T10:03:20.623756Z","caller":"traceutil/trace.go:171","msg":"trace[756766396] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:955; }","duration":"1.511699965s","start":"2026-02-18T10:03:19.112046Z","end":"2026-02-18T10:03:20.623746Z","steps":["trace[756766396] 'agreement among raft nodes before linearized reading'  (duration: 1.509070551s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:20.623778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:19.112031Z","time spent":"1.511742095s","remote":"127.0.0.1:56000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2611,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "}
{"level":"warn","ts":"2026-02-18T10:03:21.122265Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600598,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:21.623058Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600598,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:22.123558Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600598,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:22.623859Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600598,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:22.634569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00085443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-18T10:03:22.634617Z","caller":"traceutil/trace.go:171","msg":"trace[1041245033] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000933351s","start":"2026-02-18T10:03:20.633669Z","end":"2026-02-18T10:03:22.634603Z","steps":["trace[1041245033] 'agreement among raft nodes before linearized reading'  (duration: 2.00086465s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:22.634886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:20.633653Z","time spent":"2.001181516s","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:23.124224Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600598,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:23.267579Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.77208934s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-18T10:03:23.927144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999422383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-18T10:03:23.929614Z","caller":"traceutil/trace.go:171","msg":"trace[943602843] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001977056s","start":"2026-02-18T10:03:21.927615Z","end":"2026-02-18T10:03:23.929592Z","steps":["trace[943602843] 'agreement among raft nodes before linearized reading'  (duration: 1.999474995s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:23.930322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:21.927585Z","time spent":"2.002710441s","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/18 10:03:23 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:24.634719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999668781s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-18T10:03:24.635245Z","caller":"traceutil/trace.go:171","msg":"trace[439485880] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999776543s","start":"2026-02-18T10:03:22.634992Z","end":"2026-02-18T10:03:24.634768Z","steps":["trace[439485880] 'agreement among raft nodes before linearized reading'  (duration: 1.999684791s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:24.635278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:22.634903Z","time spent":"2.000368484s","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:24.936937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999551969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-18T10:03:24.937275Z","caller":"traceutil/trace.go:171","msg":"trace[670928423] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999949375s","start":"2026-02-18T10:03:19.937305Z","end":"2026-02-18T10:03:24.937254Z","steps":["trace[670928423] 'agreement among raft nodes before linearized reading'  (duration: 4.999586719s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:24.938239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:19.937283Z","time spent":"5.000872376s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/02/18 10:03:24 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:25.718676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000537185s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-18T10:03:25.719254Z","caller":"traceutil/trace.go:171","msg":"trace[567394464] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001181018s","start":"2026-02-18T10:03:23.718052Z","end":"2026-02-18T10:03:25.719233Z","steps":["trace[567394464] 'agreement among raft nodes before linearized reading'  (duration: 2.000565256s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:25.720012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:23.718032Z","time spent":"2.001962894s","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/18 10:03:25 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:26.022833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999919782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-18T10:03:26.022921Z","caller":"traceutil/trace.go:171","msg":"trace[464142580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000051524s","start":"2026-02-18T10:03:21.022839Z","end":"2026-02-18T10:03:26.022891Z","steps":["trace[464142580] 'agreement among raft nodes before linearized reading'  (duration: 4.999955763s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:26.02297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:21.022819Z","time spent":"5.000141036s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-18T10:03:26.022964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998226856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
2026/02/18 10:03:26 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-02-18T10:03:26.023021Z","caller":"traceutil/trace.go:171","msg":"trace[1552509294] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.998326259s","start":"2026-02-18T10:03:21.02468Z","end":"2026-02-18T10:03:26.023006Z","steps":["trace[1552509294] 'agreement among raft nodes before linearized reading'  (duration: 4.998249237s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:26.023057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:21.02467Z","time spent":"4.998380559s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/18 10:03:26 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:26.112538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:19.112183Z","time spent":"7.000347712s","remote":"127.0.0.1:55896","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-18T10:03:26.422804Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.837107338s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-18T10:03:26.640029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000827966s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-18T10:03:26.640114Z","caller":"traceutil/trace.go:171","msg":"trace[1082770222] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000952129s","start":"2026-02-18T10:03:24.639146Z","end":"2026-02-18T10:03:26.640098Z","steps":["trace[1082770222] 'agreement among raft nodes before linearized reading'  (duration: 2.000843627s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:26.640163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:24.639136Z","time spent":"2.00101506s","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:27.05463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.750201381s","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-18T10:03:27.054749Z","caller":"traceutil/trace.go:171","msg":"trace[1975847342] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:955; }","duration":"4.750333924s","start":"2026-02-18T10:03:22.304396Z","end":"2026-02-18T10:03:27.05473Z","steps":["trace[1975847342] 'range keys from in-memory index tree'  (duration: 4.750184041s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:27.057705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.789728837s","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834600597 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/test-pvc-pod.18954f196f7599bf\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/test-pvc-pod.18954f196f7599bf\" value_size:633 lease:7163710162979824588 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:03:27.071378Z","caller":"traceutil/trace.go:171","msg":"trace[801798666] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"2.753533489s","start":"2026-02-18T10:03:24.31783Z","end":"2026-02-18T10:03:27.071363Z","steps":["trace[801798666] 'process raft request'  (duration: 2.753454948s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:27.071486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:24.317805Z","time spent":"2.753627432s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:941 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-18T10:03:27.071617Z","caller":"traceutil/trace.go:171","msg":"trace[2146335050] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:996; }","duration":"6.450345736s","start":"2026-02-18T10:03:20.621251Z","end":"2026-02-18T10:03:27.071597Z","steps":["trace[2146335050] 'read index received'  (duration: 2.646578938s)","trace[2146335050] 'applied index is now lower than readState.Index'  (duration: 3.803766118s)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:27.071749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.602900171s","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-18T10:03:27.071766Z","caller":"traceutil/trace.go:171","msg":"trace[260650658] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:957; }","duration":"6.602959652s","start":"2026-02-18T10:03:20.468801Z","end":"2026-02-18T10:03:27.071761Z","steps":["trace[260650658] 'agreement among raft nodes before linearized reading'  (duration: 6.602925301s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:27.071782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:20.468779Z","time spent":"6.602998163s","remote":"127.0.0.1:43034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-02-18T10:03:27.071828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.94600145s","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-18T10:03:27.071845Z","caller":"traceutil/trace.go:171","msg":"trace[1697782795] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:957; }","duration":"7.946056451s","start":"2026-02-18T10:03:19.125785Z","end":"2026-02-18T10:03:27.071842Z","steps":["trace[1697782795] 'agreement among raft nodes before linearized reading'  (duration: 7.94602691s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:27.071857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:19.125764Z","time spent":"7.946090171s","remote":"127.0.0.1:56220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-02-18T10:03:27.476782Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.053789152s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-18T10:03:28.648839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000911898s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-18T10:03:28.649027Z","caller":"traceutil/trace.go:171","msg":"trace[1396341384] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001142362s","start":"2026-02-18T10:03:26.64786Z","end":"2026-02-18T10:03:28.649003Z","steps":["trace[1396341384] 'agreement among raft nodes before linearized reading'  (duration: 2.000930119s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:28.649163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:26.647841Z","time spent":"2.001305575s","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:29.956207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.014868048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-18T10:03:29.956353Z","caller":"traceutil/trace.go:171","msg":"trace[1880731251] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"3.015087713s","start":"2026-02-18T10:03:26.941249Z","end":"2026-02-18T10:03:29.956337Z","steps":["trace[1880731251] 'agreement among raft nodes before linearized reading'  (duration: 3.01492243s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:29.95644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:26.941225Z","time spent":"3.015203915s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/02/18 10:03:29 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:30.378823Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.807770368s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-18T10:03:30.378852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.901587235s","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834600600 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" value_size:672 lease:7163710162979824588 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:03:30.378955Z","caller":"traceutil/trace.go:171","msg":"trace[1172229460] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:998; }","duration":"3.307310308s","start":"2026-02-18T10:03:27.071629Z","end":"2026-02-18T10:03:30.378939Z","steps":["trace[1172229460] 'read index received'  (duration: 405.580911ms)","trace[1172229460] 'applied index is now lower than readState.Index'  (duration: 2.901723876s)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:30.379017Z","caller":"traceutil/trace.go:171","msg":"trace[479224504] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"4.259006597s","start":"2026-02-18T10:03:26.120001Z","end":"2026-02-18T10:03:30.379008Z","steps":["trace[479224504] 'process raft request'  (duration: 1.357194588s)","trace[479224504] 'compare'  (duration: 2.900985573s)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:30.379064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:26.11998Z","time spent":"4.259061537s","remote":"127.0.0.1:55896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" value_size:672 lease:7163710162979824588 >> failure:<>"}
{"level":"warn","ts":"2026-02-18T10:03:30.379291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.99282274s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-18T10:03:30.379321Z","caller":"traceutil/trace.go:171","msg":"trace[2143168588] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:958; }","duration":"5.992859961s","start":"2026-02-18T10:03:24.386452Z","end":"2026-02-18T10:03:30.379312Z","steps":["trace[2143168588] 'agreement among raft nodes before linearized reading'  (duration: 5.992757599s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:30.37935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:24.386332Z","time spent":"5.993010015s","remote":"127.0.0.1:49838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-02-18T10:03:30.379488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.063999375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:30.379514Z","caller":"traceutil/trace.go:171","msg":"trace[2120039846] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:958; }","duration":"7.064127837s","start":"2026-02-18T10:03:23.315377Z","end":"2026-02-18T10:03:30.379504Z","steps":["trace[2120039846] 'agreement among raft nodes before linearized reading'  (duration: 7.064089647s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:30.379544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:23.315361Z","time spent":"7.064177708s","remote":"127.0.0.1:55966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/test-pv\" "}
{"level":"warn","ts":"2026-02-18T10:03:30.379732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.75245811s","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-18T10:03:30.379758Z","caller":"traceutil/trace.go:171","msg":"trace[2004530314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:958; }","duration":"7.752523732s","start":"2026-02-18T10:03:22.627226Z","end":"2026-02-18T10:03:30.37975Z","steps":["trace[2004530314] 'agreement among raft nodes before linearized reading'  (duration: 7.75242012s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:30.379781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:22.627202Z","time spent":"7.752574002s","remote":"127.0.0.1:56084","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-18T10:03:30.379938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.021381149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.130\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-18T10:03:30.379962Z","caller":"traceutil/trace.go:171","msg":"trace[735012988] range","detail":"{range_begin:/registry/masterleases/199.19.213.130; range_end:; response_count:1; response_revision:958; }","duration":"8.021425539s","start":"2026-02-18T10:03:22.358529Z","end":"2026-02-18T10:03:30.379955Z","steps":["trace[735012988] 'agreement among raft nodes before linearized reading'  (duration: 8.021357758s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:30.379987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:22.358514Z","time spent":"8.021465941s","remote":"127.0.0.1:55842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.130\" "}
{"level":"warn","ts":"2026-02-18T10:03:30.380166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.338551626s","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-18T10:03:30.380192Z","caller":"traceutil/trace.go:171","msg":"trace[304988907] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:958; }","duration":"9.338609987s","start":"2026-02-18T10:03:21.041573Z","end":"2026-02-18T10:03:30.380183Z","steps":["trace[304988907] 'agreement among raft nodes before linearized reading'  (duration: 9.338531086s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:30.380218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:21.041556Z","time spent":"9.338654308s","remote":"127.0.0.1:55896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":101,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-18T10:03:30.380364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.355914377s","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-18T10:03:30.380388Z","caller":"traceutil/trace.go:171","msg":"trace[29582762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:958; }","duration":"9.35599964s","start":"2026-02-18T10:03:21.02438Z","end":"2026-02-18T10:03:30.38038Z","steps":["trace[29582762] 'agreement among raft nodes before linearized reading'  (duration: 9.355925819s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:30.380411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:21.024323Z","time spent":"9.356082621s","remote":"127.0.0.1:56084","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-18T10:03:30.381214Z","caller":"traceutil/trace.go:171","msg":"trace[1674576896] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"3.016575628s","start":"2026-02-18T10:03:27.364628Z","end":"2026-02-18T10:03:30.381203Z","steps":["trace[1674576896] 'process raft request'  (duration: 3.016506337s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:30.381331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:27.364584Z","time spent":"3.01665846s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:949 > 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-18T10:03:30.650452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000153644s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-18T10:03:30.650854Z","caller":"traceutil/trace.go:171","msg":"trace[566504085] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000819967s","start":"2026-02-18T10:03:28.65002Z","end":"2026-02-18T10:03:30.65084Z","steps":["trace[566504085] 'agreement among raft nodes before linearized reading'  (duration: 2.000185195s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:30.650954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:28.649998Z","time spent":"2.000943829s","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/18 10:03:30 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:30.879866Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600604,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:31.023798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.000457214s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-18T10:03:31.023877Z","caller":"traceutil/trace.go:171","msg":"trace[1167070098] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"3.000591167s","start":"2026-02-18T10:03:28.023267Z","end":"2026-02-18T10:03:31.023858Z","steps":["trace[1167070098] 'agreement among raft nodes before linearized reading'  (duration: 3.000493195s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:31.023937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:28.023245Z","time spent":"3.000682588s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/02/18 10:03:31 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:31.025074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997374444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-18T10:03:31.025237Z","caller":"traceutil/trace.go:171","msg":"trace[1872456614] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.997586308s","start":"2026-02-18T10:03:28.02764Z","end":"2026-02-18T10:03:31.025227Z","steps":["trace[1872456614] 'agreement among raft nodes before linearized reading'  (duration: 2.997410645s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:31.025324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:28.027619Z","time spent":"2.997697989s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/18 10:03:31 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:31.025168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:30.388298Z","time spent":"636.866093ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/18 10:03:31 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:31.38175Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600604,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:31.882999Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600604,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:32.383411Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834600604,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:32.414571Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.035591408s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-18T10:03:32.626921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:30.389401Z","time spent":"2.237514043s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/18 10:03:32 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-18T10:03:32.65887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00009448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-18T10:03:32.659084Z","caller":"traceutil/trace.go:171","msg":"trace[790361121] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000355075s","start":"2026-02-18T10:03:30.658712Z","end":"2026-02-18T10:03:32.659067Z","steps":["trace[790361121] 'agreement among raft nodes before linearized reading'  (duration: 2.000128661s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:32.65932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:30.65869Z","time spent":"2.000615799s","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:32.838854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.885463ms","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-18T10:03:32.838987Z","caller":"traceutil/trace.go:171","msg":"trace[1307936275] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:959; }","duration":"534.036525ms","start":"2026-02-18T10:03:32.304932Z","end":"2026-02-18T10:03:32.838968Z","steps":["trace[1307936275] 'range keys from in-memory index tree'  (duration: 533.858912ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.031912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.220074ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834600603 > lease_revoke:<id:636a9c703244a45b>","response":"size:29"}
{"level":"warn","ts":"2026-02-18T10:03:33.032324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:30.384485Z","time spent":"2.647835446s","remote":"127.0.0.1:55842","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-18T10:03:33.033003Z","caller":"traceutil/trace.go:171","msg":"trace[1062421985] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"2.644567704s","start":"2026-02-18T10:03:30.388401Z","end":"2026-02-18T10:03:33.032969Z","steps":["trace[1062421985] 'process raft request'  (duration: 2.644433162s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.033843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:30.388397Z","time spent":"2.644714267s","remote":"127.0.0.1:55896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1af9db88e6\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1af9db88e6\" value_size:671 lease:7163710162979824588 >> failure:<>"}
{"level":"warn","ts":"2026-02-18T10:03:33.231554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.500187ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834600609 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:955 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:03:33.232004Z","caller":"traceutil/trace.go:171","msg":"trace[860987521] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"2.207844748s","start":"2026-02-18T10:03:31.024138Z","end":"2026-02-18T10:03:33.231982Z","steps":["trace[860987521] 'process raft request'  (duration: 2.207710395s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.232462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:31.024112Z","time spent":"2.208290147s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:952 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:366 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-18T10:03:33.232752Z","caller":"traceutil/trace.go:171","msg":"trace[191424976] transaction","detail":"{read_only:false; number_of_response:1; response_revision:965; }","duration":"198.062439ms","start":"2026-02-18T10:03:33.034658Z","end":"2026-02-18T10:03:33.232721Z","steps":["trace[191424976] 'process raft request'  (duration: 198.015767ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:33.233088Z","caller":"traceutil/trace.go:171","msg":"trace[84864980] transaction","detail":"{read_only:false; number_of_response:1; response_revision:964; }","duration":"2.208843787s","start":"2026-02-18T10:03:31.024227Z","end":"2026-02-18T10:03:33.233071Z","steps":["trace[84864980] 'process raft request'  (duration: 2.207717646s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.233233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:31.024205Z","time spent":"2.208915978s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":48,"response count":0,"response size":471,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:953 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:361 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-18T10:03:33.23334Z","caller":"traceutil/trace.go:171","msg":"trace[140284479] transaction","detail":"{read_only:false; number_of_response:1; response_revision:965; }","duration":"604.020039ms","start":"2026-02-18T10:03:32.629309Z","end":"2026-02-18T10:03:33.233329Z","steps":["trace[140284479] 'process raft request'  (duration: 602.9707ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.233398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:32.629291Z","time spent":"604.077959ms","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":46,"response count":0,"response size":468,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:955 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:361 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-18T10:03:33.237728Z","caller":"traceutil/trace.go:171","msg":"trace[1560849472] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"2.211455144s","start":"2026-02-18T10:03:31.026243Z","end":"2026-02-18T10:03:33.237699Z","steps":["trace[1560849472] 'process raft request'  (duration: 2.205870481s)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:33.23811Z","caller":"traceutil/trace.go:171","msg":"trace[1702210226] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1000; }","duration":"2.859064262s","start":"2026-02-18T10:03:30.378979Z","end":"2026-02-18T10:03:33.238043Z","steps":["trace[1702210226] 'read index received'  (duration: 2.035706231s)","trace[1702210226] 'applied index is now lower than readState.Index'  (duration: 823.351851ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:33.237805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:31.026235Z","time spent":"2.211534707s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":456,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:390 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-18T10:03:33.256844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.711549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:33.256922Z","caller":"traceutil/trace.go:171","msg":"trace[1324506648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:965; }","duration":"596.824442ms","start":"2026-02-18T10:03:32.660082Z","end":"2026-02-18T10:03:33.256907Z","steps":["trace[1324506648] 'agreement among raft nodes before linearized reading'  (duration: 596.71378ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.256982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:32.660065Z","time spent":"596.911483ms","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:33.257232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.665081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-18T10:03:33.257281Z","caller":"traceutil/trace.go:171","msg":"trace[1187694130] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82; range_end:; response_count:1; response_revision:965; }","duration":"218.722753ms","start":"2026-02-18T10:03:33.038525Z","end":"2026-02-18T10:03:33.257248Z","steps":["trace[1187694130] 'agreement among raft nodes before linearized reading'  (duration: 218.59942ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.25763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.599227885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7045"}
{"level":"info","ts":"2026-02-18T10:03:33.257685Z","caller":"traceutil/trace.go:171","msg":"trace[843417721] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:965; }","duration":"2.599299417s","start":"2026-02-18T10:03:30.658361Z","end":"2026-02-18T10:03:33.25766Z","steps":["trace[843417721] 'agreement among raft nodes before linearized reading'  (duration: 2.599231736s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.257764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.868247737s","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-18T10:03:33.257816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:30.658331Z","time spent":"2.599388488s","remote":"127.0.0.1:56000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7069,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "}
{"level":"info","ts":"2026-02-18T10:03:33.257905Z","caller":"traceutil/trace.go:171","msg":"trace[951826297] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:965; }","duration":"2.86839977s","start":"2026-02-18T10:03:30.389499Z","end":"2026-02-18T10:03:33.257899Z","steps":["trace[951826297] 'agreement among raft nodes before linearized reading'  (duration: 2.867261979s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.257928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:30.389493Z","time spent":"2.868430072s","remote":"127.0.0.1:55966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/test-pv\" "}
{"level":"info","ts":"2026-02-18T10:03:33.424585Z","caller":"traceutil/trace.go:171","msg":"trace[1231854978] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1011; }","duration":"137.978987ms","start":"2026-02-18T10:03:33.286584Z","end":"2026-02-18T10:03:33.424563Z","steps":["trace[1231854978] 'read index received'  (duration: 26.014882ms)","trace[1231854978] 'applied index is now lower than readState.Index'  (duration: 111.963115ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:33.424672Z","caller":"traceutil/trace.go:171","msg":"trace[149219497] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"149.920547ms","start":"2026-02-18T10:03:33.274747Z","end":"2026-02-18T10:03:33.424667Z","steps":["trace[149219497] 'process raft request'  (duration: 149.763924ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:33.424931Z","caller":"traceutil/trace.go:171","msg":"trace[118267761] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"155.47653ms","start":"2026-02-18T10:03:33.269418Z","end":"2026-02-18T10:03:33.424894Z","steps":["trace[118267761] 'process raft request'  (duration: 154.948ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.425009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.390054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:33.425038Z","caller":"traceutil/trace.go:171","msg":"trace[1176048158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:968; }","duration":"138.487575ms","start":"2026-02-18T10:03:33.28654Z","end":"2026-02-18T10:03:33.425028Z","steps":["trace[1176048158] 'agreement among raft nodes before linearized reading'  (duration: 138.402694ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:33.425188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.440078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-18T10:03:33.425203Z","caller":"traceutil/trace.go:171","msg":"trace[1955285877] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82; range_end:; response_count:1; response_revision:968; }","duration":"108.4851ms","start":"2026-02-18T10:03:33.316713Z","end":"2026-02-18T10:03:33.425198Z","steps":["trace[1955285877] 'agreement among raft nodes before linearized reading'  (duration: 108.406949ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:33.587337Z","caller":"traceutil/trace.go:171","msg":"trace[1194993785] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1015; }","duration":"131.2113ms","start":"2026-02-18T10:03:33.456102Z","end":"2026-02-18T10:03:33.587313Z","steps":["trace[1194993785] 'read index received'  (duration: 85.684077ms)","trace[1194993785] 'applied index is now lower than readState.Index'  (duration: 45.526433ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:33.587533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.405364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.130\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-18T10:03:33.587561Z","caller":"traceutil/trace.go:171","msg":"trace[777722531] range","detail":"{range_begin:/registry/masterleases/199.19.213.130; range_end:; response_count:1; response_revision:970; }","duration":"131.466294ms","start":"2026-02-18T10:03:33.456087Z","end":"2026-02-18T10:03:33.587553Z","steps":["trace[777722531] 'agreement among raft nodes before linearized reading'  (duration: 131.310422ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:33.58777Z","caller":"traceutil/trace.go:171","msg":"trace[521617107] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"131.861434ms","start":"2026-02-18T10:03:33.4559Z","end":"2026-02-18T10:03:33.587762Z","steps":["trace[521617107] 'process raft request'  (duration: 85.968083ms)","trace[521617107] 'compare'  (duration: 45.266809ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:33.588409Z","caller":"traceutil/trace.go:171","msg":"trace[572867797] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"130.527578ms","start":"2026-02-18T10:03:33.457851Z","end":"2026-02-18T10:03:33.588378Z","steps":["trace[572867797] 'process raft request'  (duration: 130.365895ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:47.68304Z","caller":"traceutil/trace.go:171","msg":"trace[1598526362] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"187.392471ms","start":"2026-02-18T10:03:47.495617Z","end":"2026-02-18T10:03:47.68301Z","steps":["trace[1598526362] 'process raft request'  (duration: 187.214628ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:47.683492Z","caller":"traceutil/trace.go:171","msg":"trace[1819141062] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1083; }","duration":"157.950467ms","start":"2026-02-18T10:03:47.525353Z","end":"2026-02-18T10:03:47.683304Z","steps":["trace[1819141062] 'read index received'  (duration: 157.940206ms)","trace[1819141062] 'applied index is now lower than readState.Index'  (duration: 8.111µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:47.683919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.539166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:namespace-controller\" ","response":"range_response_count:1 size:723"}
{"level":"info","ts":"2026-02-18T10:03:47.684122Z","caller":"traceutil/trace.go:171","msg":"trace[303998239] range","detail":"{range_begin:/registry/clusterroles/system:controller:namespace-controller; range_end:; response_count:1; response_revision:1035; }","duration":"158.77713ms","start":"2026-02-18T10:03:47.52532Z","end":"2026-02-18T10:03:47.684097Z","steps":["trace[303998239] 'agreement among raft nodes before linearized reading'  (duration: 158.481374ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:47.701693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.151523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:job-controller\" ","response":"range_response_count:1 size:780"}
{"level":"info","ts":"2026-02-18T10:03:47.701786Z","caller":"traceutil/trace.go:171","msg":"trace[30139306] range","detail":"{range_begin:/registry/clusterroles/system:controller:job-controller; range_end:; response_count:1; response_revision:1036; }","duration":"176.305726ms","start":"2026-02-18T10:03:47.525466Z","end":"2026-02-18T10:03:47.701772Z","steps":["trace[30139306] 'agreement among raft nodes before linearized reading'  (duration: 176.146543ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:47.702325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.445147ms","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-18T10:03:47.702498Z","caller":"traceutil/trace.go:171","msg":"trace[2036492277] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1036; }","duration":"109.646671ms","start":"2026-02-18T10:03:47.59284Z","end":"2026-02-18T10:03:47.702487Z","steps":["trace[2036492277] 'agreement among raft nodes before linearized reading'  (duration: 109.397537ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:48.938029Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834601062,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:49.439095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834601062,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:49.939768Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834601062,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:50.440432Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834601062,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:50.941243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834601062,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:51.441865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834601062,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-18T10:03:51.714612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001119742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-18T10:03:51.714962Z","caller":"traceutil/trace.go:171","msg":"trace[2012349442] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001501998s","start":"2026-02-18T10:03:49.713416Z","end":"2026-02-18T10:03:51.714918Z","steps":["trace[2012349442] 'agreement among raft nodes before linearized reading'  (duration: 2.001154083s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:51.715148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:49.713407Z","time spent":"2.001683572s","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:51.912934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.208731246s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-18T10:03:51.915245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.721286298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-18T10:03:51.915492Z","caller":"traceutil/trace.go:171","msg":"trace[835410706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1036; }","duration":"3.721496872s","start":"2026-02-18T10:03:48.193908Z","end":"2026-02-18T10:03:51.915405Z","steps":["trace[835410706] 'range keys from in-memory index tree'  (duration: 3.721117216s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:51.915711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:48.193898Z","time spent":"3.721803597s","remote":"127.0.0.1:56084","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-18T10:03:51.915999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.209967215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:job-controller\" ","response":"range_response_count:1 size:780"}
{"level":"info","ts":"2026-02-18T10:03:51.916055Z","caller":"traceutil/trace.go:171","msg":"trace[402029377] range","detail":"{range_begin:/registry/clusterroles/system:controller:job-controller; range_end:; response_count:1; response_revision:1036; }","duration":"4.210033996s","start":"2026-02-18T10:03:47.706012Z","end":"2026-02-18T10:03:51.916046Z","steps":["trace[402029377] 'range keys from in-memory index tree'  (duration: 4.209921114s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:51.916136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:47.706002Z","time spent":"4.210126167s","remote":"127.0.0.1:56144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":804,"request content":"key:\"/registry/clusterroles/system:controller:job-controller\" "}
{"level":"info","ts":"2026-02-18T10:03:51.913063Z","caller":"traceutil/trace.go:171","msg":"trace[1606279198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1036; }","duration":"4.208884438s","start":"2026-02-18T10:03:47.704144Z","end":"2026-02-18T10:03:51.913028Z","steps":["trace[1606279198] 'range keys from in-memory index tree'  (duration: 4.208682044s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:51.91678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.154042701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:namespace-controller\" ","response":"range_response_count:1 size:723"}
{"level":"info","ts":"2026-02-18T10:03:51.916839Z","caller":"traceutil/trace.go:171","msg":"trace[1075039407] range","detail":"{range_begin:/registry/clusterroles/system:controller:namespace-controller; range_end:; response_count:1; response_revision:1036; }","duration":"4.154131362s","start":"2026-02-18T10:03:47.762696Z","end":"2026-02-18T10:03:51.916827Z","steps":["trace[1075039407] 'range keys from in-memory index tree'  (duration: 4.1539752s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:51.916918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:47.762677Z","time spent":"4.154233064s","remote":"127.0.0.1:56144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":747,"request content":"key:\"/registry/clusterroles/system:controller:namespace-controller\" "}
{"level":"warn","ts":"2026-02-18T10:03:51.91706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:47.704131Z","time spent":"4.212872103s","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:51.917674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.732103299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-18T10:03:51.91774Z","caller":"traceutil/trace.go:171","msg":"trace[2103571689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1036; }","duration":"3.732232211s","start":"2026-02-18T10:03:48.185498Z","end":"2026-02-18T10:03:51.91773Z","steps":["trace[2103571689] 'range keys from in-memory index tree'  (duration: 3.731970828s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:51.917817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:48.185467Z","time spent":"3.732342033s","remote":"127.0.0.1:56084","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-18T10:03:51.942655Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.660437311s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-18T10:03:51.942765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16387082199834601062,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-18T10:03:52.105878Z","caller":"traceutil/trace.go:171","msg":"trace[699411784] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"1.093263677s","start":"2026-02-18T10:03:51.012585Z","end":"2026-02-18T10:03:52.105849Z","steps":["trace[699411784] 'process raft request'  (duration: 1.092997542s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.106056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:51.012562Z","time spent":"1.093395629s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1020 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-18T10:03:52.10623Z","caller":"traceutil/trace.go:171","msg":"trace[1791118209] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"177.164327ms","start":"2026-02-18T10:03:51.929058Z","end":"2026-02-18T10:03:52.106222Z","steps":["trace[1791118209] 'process raft request'  (duration: 176.7421ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:52.106506Z","caller":"traceutil/trace.go:171","msg":"trace[1415464379] linearizableReadLoop","detail":"{readStateIndex:1088; appliedIndex:1084; }","duration":"3.669493172s","start":"2026-02-18T10:03:48.436976Z","end":"2026-02-18T10:03:52.10647Z","steps":["trace[1415464379] 'read index received'  (duration: 3.506382938s)","trace[1415464379] 'applied index is now lower than readState.Index'  (duration: 163.109064ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:52.106618Z","caller":"etcdserver/v3_server.go:874","msg":"ignored out-of-date read index response; local node read indexes queueing up and waiting to be in sync with leader","sent-request-id":16387082199834601069,"received-request-id":16387082199834601062}
{"level":"warn","ts":"2026-02-18T10:03:52.10677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.669804628s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:52.106828Z","caller":"traceutil/trace.go:171","msg":"trace[2068728142] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1039; }","duration":"3.669901669s","start":"2026-02-18T10:03:48.436916Z","end":"2026-02-18T10:03:52.106817Z","steps":["trace[2068728142] 'agreement among raft nodes before linearized reading'  (duration: 3.669821417s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.106864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:48.436893Z","time spent":"3.66996224s","remote":"127.0.0.1:49856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"info","ts":"2026-02-18T10:03:52.106995Z","caller":"traceutil/trace.go:171","msg":"trace[655626851] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"175.197044ms","start":"2026-02-18T10:03:51.931791Z","end":"2026-02-18T10:03:52.106988Z","steps":["trace[655626851] 'process raft request'  (duration: 174.399411ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.107036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.482878592s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4374"}
{"level":"info","ts":"2026-02-18T10:03:52.107095Z","caller":"traceutil/trace.go:171","msg":"trace[1310603666] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:1039; }","duration":"3.482981254s","start":"2026-02-18T10:03:48.624092Z","end":"2026-02-18T10:03:52.107073Z","steps":["trace[1310603666] 'agreement among raft nodes before linearized reading'  (duration: 3.482769861s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.107137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:48.624069Z","time spent":"3.483059656s","remote":"127.0.0.1:56000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4398,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"warn","ts":"2026-02-18T10:03:52.107382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.252925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-18T10:03:52.107392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.83116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:52.107428Z","caller":"traceutil/trace.go:171","msg":"trace[1990666940] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1039; }","duration":"257.374957ms","start":"2026-02-18T10:03:51.850046Z","end":"2026-02-18T10:03:52.107421Z","steps":["trace[1990666940] 'agreement among raft nodes before linearized reading'  (duration: 257.253425ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.107498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.383963041s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:52.107548Z","caller":"traceutil/trace.go:171","msg":"trace[1808488172] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1039; }","duration":"2.384015182s","start":"2026-02-18T10:03:49.723522Z","end":"2026-02-18T10:03:52.107537Z","steps":["trace[1808488172] 'agreement among raft nodes before linearized reading'  (duration: 2.383942911s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.107583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:49.723479Z","time spent":"2.384096174s","remote":"127.0.0.1:56248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"warn","ts":"2026-02-18T10:03:52.107667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.755567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:node-controller\" ","response":"range_response_count:1 size:835"}
{"level":"info","ts":"2026-02-18T10:03:52.107755Z","caller":"traceutil/trace.go:171","msg":"trace[183611577] range","detail":"{range_begin:/registry/clusterroles/system:controller:node-controller; range_end:; response_count:1; response_revision:1039; }","duration":"103.886029ms","start":"2026-02-18T10:03:52.003863Z","end":"2026-02-18T10:03:52.107749Z","steps":["trace[183611577] 'agreement among raft nodes before linearized reading'  (duration: 103.744147ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.107836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.39468222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-18T10:03:52.107876Z","caller":"traceutil/trace.go:171","msg":"trace[200392921] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82; range_end:; response_count:1; response_revision:1039; }","duration":"2.394789502s","start":"2026-02-18T10:03:49.713075Z","end":"2026-02-18T10:03:52.107865Z","steps":["trace[200392921] 'agreement among raft nodes before linearized reading'  (duration: 2.394676959s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.107906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:49.713045Z","time spent":"2.394854063s","remote":"127.0.0.1:55896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":798,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" "}
{"level":"warn","ts":"2026-02-18T10:03:52.108006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.988157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:namespace-controller\" ","response":"range_response_count:1 size:723"}
{"level":"info","ts":"2026-02-18T10:03:52.10805Z","caller":"traceutil/trace.go:171","msg":"trace[1812558057] range","detail":"{range_begin:/registry/clusterroles/system:controller:namespace-controller; range_end:; response_count:1; response_revision:1039; }","duration":"176.052209ms","start":"2026-02-18T10:03:51.931991Z","end":"2026-02-18T10:03:52.108043Z","steps":["trace[1812558057] 'agreement among raft nodes before linearized reading'  (duration: 175.917057ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:52.107445Z","caller":"traceutil/trace.go:171","msg":"trace[1639532942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1039; }","duration":"391.882071ms","start":"2026-02-18T10:03:51.715553Z","end":"2026-02-18T10:03:52.107435Z","steps":["trace[1639532942] 'agreement among raft nodes before linearized reading'  (duration: 391.81363ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.108129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.419069326s","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-18T10:03:52.108179Z","caller":"traceutil/trace.go:171","msg":"trace[1340776997] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1039; }","duration":"2.419174928s","start":"2026-02-18T10:03:49.688994Z","end":"2026-02-18T10:03:52.108169Z","steps":["trace[1340776997] 'agreement among raft nodes before linearized reading'  (duration: 2.419069916s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.108191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:51.715493Z","time spent":"392.667664ms","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-18T10:03:52.108216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:49.688963Z","time spent":"2.419243729s","remote":"127.0.0.1:56084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-18T10:03:52.108484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.483740076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-18T10:03:52.108521Z","caller":"traceutil/trace.go:171","msg":"trace[37609539] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1039; }","duration":"3.483791688s","start":"2026-02-18T10:03:48.624721Z","end":"2026-02-18T10:03:52.108513Z","steps":["trace[37609539] 'agreement among raft nodes before linearized reading'  (duration: 3.483687205s)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.10857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-18T10:03:48.624716Z","time spent":"3.483846839s","remote":"127.0.0.1:56084","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-18T10:03:52.292074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.839203ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16387082199834601071 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" mod_revision:972 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" value_size:672 lease:7163710162979824588 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.18954f1ab942ee82\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-18T10:03:52.292568Z","caller":"traceutil/trace.go:171","msg":"trace[1371645651] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1090; }","duration":"152.85946ms","start":"2026-02-18T10:03:52.139695Z","end":"2026-02-18T10:03:52.292555Z","steps":["trace[1371645651] 'read index received'  (duration: 27.457559ms)","trace[1371645651] 'applied index is now lower than readState.Index'  (duration: 125.400811ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:52.292718Z","caller":"traceutil/trace.go:171","msg":"trace[690287325] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"167.36588ms","start":"2026-02-18T10:03:52.125262Z","end":"2026-02-18T10:03:52.292628Z","steps":["trace[690287325] 'process raft request'  (duration: 166.965373ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:52.293015Z","caller":"traceutil/trace.go:171","msg":"trace[1121527519] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"164.566742ms","start":"2026-02-18T10:03:52.128439Z","end":"2026-02-18T10:03:52.293006Z","steps":["trace[1121527519] 'process raft request'  (duration: 164.065364ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:52.293238Z","caller":"traceutil/trace.go:171","msg":"trace[2101755068] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"151.387587ms","start":"2026-02-18T10:03:52.141842Z","end":"2026-02-18T10:03:52.29323Z","steps":["trace[2101755068] 'process raft request'  (duration: 150.684815ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:52.29346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.762076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:03:52.293488Z","caller":"traceutil/trace.go:171","msg":"trace[1991834445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1044; }","duration":"153.817567ms","start":"2026-02-18T10:03:52.139664Z","end":"2026-02-18T10:03:52.293481Z","steps":["trace[1991834445] 'agreement among raft nodes before linearized reading'  (duration: 153.751486ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:52.293584Z","caller":"traceutil/trace.go:171","msg":"trace[558203477] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"179.537867ms","start":"2026-02-18T10:03:52.113413Z","end":"2026-02-18T10:03:52.292951Z","steps":["trace[558203477] 'process raft request'  (duration: 53.745919ms)","trace[558203477] 'compare'  (duration: 124.746451ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:52.294642Z","caller":"traceutil/trace.go:171","msg":"trace[512113358] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"169.522914ms","start":"2026-02-18T10:03:52.12511Z","end":"2026-02-18T10:03:52.294633Z","steps":["trace[512113358] 'process raft request'  (duration: 167.078144ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:53.726699Z","caller":"traceutil/trace.go:171","msg":"trace[1359494730] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1098; }","duration":"251.873388ms","start":"2026-02-18T10:03:53.474796Z","end":"2026-02-18T10:03:53.726669Z","steps":["trace[1359494730] 'read index received'  (duration: 251.690945ms)","trace[1359494730] 'applied index is now lower than readState.Index'  (duration: 179.233µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:53.727367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.548828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-02-18T10:03:53.727429Z","caller":"traceutil/trace.go:171","msg":"trace[457354554] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:1047; }","duration":"252.649249ms","start":"2026-02-18T10:03:53.474756Z","end":"2026-02-18T10:03:53.727406Z","steps":["trace[457354554] 'agreement among raft nodes before linearized reading'  (duration: 252.527528ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:53.727748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.252089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node\" ","response":"range_response_count:1 size:603"}
{"level":"info","ts":"2026-02-18T10:03:53.727792Z","caller":"traceutil/trace.go:171","msg":"trace[1074256545] range","detail":"{range_begin:/registry/clusterrolebindings/system:node; range_end:; response_count:1; response_revision:1047; }","duration":"210.338371ms","start":"2026-02-18T10:03:53.517443Z","end":"2026-02-18T10:03:53.727781Z","steps":["trace[1074256545] 'agreement among raft nodes before linearized reading'  (duration: 210.25898ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:53.729401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.83509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node-proxier\" ","response":"range_response_count:1 size:699"}
{"level":"info","ts":"2026-02-18T10:03:53.733205Z","caller":"traceutil/trace.go:171","msg":"trace[1809964938] range","detail":"{range_begin:/registry/clusterrolebindings/system:node-proxier; range_end:; response_count:1; response_revision:1047; }","duration":"195.019283ms","start":"2026-02-18T10:03:53.53452Z","end":"2026-02-18T10:03:53.729539Z","steps":["trace[1809964938] 'agreement among raft nodes before linearized reading'  (duration: 194.780249ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:53.878427Z","caller":"traceutil/trace.go:171","msg":"trace[1301090849] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1100; }","duration":"118.01316ms","start":"2026-02-18T10:03:53.760389Z","end":"2026-02-18T10:03:53.878403Z","steps":["trace[1301090849] 'read index received'  (duration: 55.009055ms)","trace[1301090849] 'applied index is now lower than readState.Index'  (duration: 63.002385ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:53.878514Z","caller":"traceutil/trace.go:171","msg":"trace[239097407] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"128.419599ms","start":"2026-02-18T10:03:53.750061Z","end":"2026-02-18T10:03:53.878481Z","steps":["trace[239097407] 'process raft request'  (duration: 65.403704ms)","trace[239097407] 'compare'  (duration: 62.681919ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:53.87861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.199803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-02-18T10:03:53.87864Z","caller":"traceutil/trace.go:171","msg":"trace[1620088875] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1049; }","duration":"118.265913ms","start":"2026-02-18T10:03:53.760366Z","end":"2026-02-18T10:03:53.878632Z","steps":["trace[1620088875] 'agreement among raft nodes before linearized reading'  (duration: 118.153592ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:03:54.649086Z","caller":"traceutil/trace.go:171","msg":"trace[1373376479] linearizableReadLoop","detail":"{readStateIndex:1106; appliedIndex:1105; }","duration":"209.315095ms","start":"2026-02-18T10:03:54.439742Z","end":"2026-02-18T10:03:54.649057Z","steps":["trace[1373376479] 'read index received'  (duration: 150.633887ms)","trace[1373376479] 'applied index is now lower than readState.Index'  (duration: 58.679848ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:03:54.649384Z","caller":"traceutil/trace.go:171","msg":"trace[1664711899] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"243.322876ms","start":"2026-02-18T10:03:54.406047Z","end":"2026-02-18T10:03:54.649369Z","steps":["trace[1664711899] 'process raft request'  (duration: 184.433554ms)","trace[1664711899] 'compare'  (duration: 58.248451ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:03:54.649737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.94924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:public-info-viewer\" ","response":"range_response_count:1 size:783"}
{"level":"info","ts":"2026-02-18T10:03:54.649854Z","caller":"traceutil/trace.go:171","msg":"trace[1936223876] range","detail":"{range_begin:/registry/clusterrolebindings/system:public-info-viewer; range_end:; response_count:1; response_revision:1054; }","duration":"188.080632ms","start":"2026-02-18T10:03:54.46174Z","end":"2026-02-18T10:03:54.64982Z","steps":["trace[1936223876] 'agreement among raft nodes before linearized reading'  (duration: 187.892339ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-18T10:03:54.650129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.334912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-account-controller\" ","response":"range_response_count:1 size:677"}
{"level":"info","ts":"2026-02-18T10:03:54.650229Z","caller":"traceutil/trace.go:171","msg":"trace[476692026] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-account-controller; range_end:; response_count:1; response_revision:1054; }","duration":"210.508135ms","start":"2026-02-18T10:03:54.439707Z","end":"2026-02-18T10:03:54.650215Z","steps":["trace[476692026] 'agreement among raft nodes before linearized reading'  (duration: 210.222901ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:04:02.563868Z","caller":"traceutil/trace.go:171","msg":"trace[865568682] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"132.458267ms","start":"2026-02-18T10:04:02.431381Z","end":"2026-02-18T10:04:02.563839Z","steps":["trace[865568682] 'read index received'  (duration: 53.564187ms)","trace[865568682] 'applied index is now lower than readState.Index'  (duration: 78.89286ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:04:02.564855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.446163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-18T10:04:02.566904Z","caller":"traceutil/trace.go:171","msg":"trace[1195269931] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1074; }","duration":"135.529855ms","start":"2026-02-18T10:04:02.43134Z","end":"2026-02-18T10:04:02.56687Z","steps":["trace[1195269931] 'agreement among raft nodes before linearized reading'  (duration: 133.321081ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:04:02.565021Z","caller":"traceutil/trace.go:171","msg":"trace[21310854] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"173.825589ms","start":"2026-02-18T10:04:02.391179Z","end":"2026-02-18T10:04:02.565005Z","steps":["trace[21310854] 'process raft request'  (duration: 93.77608ms)","trace[21310854] 'compare'  (duration: 78.499584ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:04:02.565677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.845337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/kube-system/\" range_end:\"/registry/ingress/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-18T10:04:02.570336Z","caller":"traceutil/trace.go:171","msg":"trace[850267599] range","detail":"{range_begin:/registry/ingress/kube-system/; range_end:/registry/ingress/kube-system0; response_count:0; response_revision:1074; }","duration":"120.922349ms","start":"2026-02-18T10:04:02.446787Z","end":"2026-02-18T10:04:02.567709Z","steps":["trace[850267599] 'agreement among raft nodes before linearized reading'  (duration: 118.849617ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:04:04.471384Z","caller":"traceutil/trace.go:171","msg":"trace[1963232613] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"106.867105ms","start":"2026-02-18T10:04:04.364485Z","end":"2026-02-18T10:04:04.471352Z","steps":["trace[1963232613] 'process raft request'  (duration: 41.737428ms)","trace[1963232613] 'compare'  (duration: 64.966944ms)"],"step_count":2}
{"level":"info","ts":"2026-02-18T10:04:12.642877Z","caller":"traceutil/trace.go:171","msg":"trace[571286370] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"105.394298ms","start":"2026-02-18T10:04:12.537454Z","end":"2026-02-18T10:04:12.642848Z","steps":["trace[571286370] 'process raft request'  (duration: 105.200304ms)"],"step_count":1}
{"level":"info","ts":"2026-02-18T10:04:12.642937Z","caller":"traceutil/trace.go:171","msg":"trace[522141241] linearizableReadLoop","detail":"{readStateIndex:1155; appliedIndex:1155; }","duration":"104.17782ms","start":"2026-02-18T10:04:12.538707Z","end":"2026-02-18T10:04:12.642885Z","steps":["trace[522141241] 'read index received'  (duration: 104.16603ms)","trace[522141241] 'applied index is now lower than readState.Index'  (duration: 9.68µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-18T10:04:12.643627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.893401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-02-18T10:04:12.643787Z","caller":"traceutil/trace.go:171","msg":"trace[545576503] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:1; response_revision:1100; }","duration":"105.049623ms","start":"2026-02-18T10:04:12.538669Z","end":"2026-02-18T10:04:12.643718Z","steps":["trace[545576503] 'agreement among raft nodes before linearized reading'  (duration: 104.811069ms)"],"step_count":1}