{"level":"warn","ts":"2026-02-17T16:31:06.532168Z","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-17T16:31:06.532693Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-17T16:31:06.53297Z","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-17T16:31:06.533043Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-02-17T16:31:06.53608Z","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-17T16:31:06.557534Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-02-17T16:31:06.557753Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-17T16:31:06.569786Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.090207ms"} {"level":"info","ts":"2026-02-17T16:31:06.600328Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-02-17T16:31:06.60059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T16:31:06.600738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-02-17T16:31:06.600789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T16:31:06.60087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-02-17T16:31:06.600963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-02-17T16:31:06.608022Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T16:31:06.615697Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T16:31:06.619781Z","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-17T16:31:06.626257Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T16:31:06.632165Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T16:31:06.632698Z","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-17T16:31:06.63291Z","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-17T16:31:06.633029Z","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-17T16:31:06.635249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-02-17T16:31:06.635546Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-02-17T16:31:06.647212Z","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-17T16:31:06.647674Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T16:31:06.647484Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-02-17T16:31:06.654288Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-02-17T16:31:06.654313Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T16:31:07.605862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T16:31:07.60593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T16:31:07.605951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-02-17T16:31:07.605966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-02-17T16:31:07.605972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-02-17T16:31:07.605981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-02-17T16:31:07.605988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-02-17T16:31:07.610344Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:31:07.611235Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T16:31:07.611258Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T16:31:07.611559Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T16:31:07.611989Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:31:07.612043Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:31:07.612055Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:31:07.6135Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T16:31:07.615795Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-02-17T16:31:07.615849Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T16:31:07.615859Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T16:31:11.92471Z","caller":"traceutil/trace.go:171","msg":"trace[1795790583] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"459.647907ms","start":"2026-02-17T16:31:11.464773Z","end":"2026-02-17T16:31:11.92442Z","steps":["trace[1795790583] 'process raft request' (duration: 459.393261ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:11.925846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:11.464752Z","time spent":"460.111698ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:31:12.484733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.69369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:31:12.484862Z","caller":"traceutil/trace.go:171","msg":"trace[483803532] linearizableReadLoop","detail":"{readStateIndex:256; appliedIndex:254; }","duration":"600.378412ms","start":"2026-02-17T16:31:11.884464Z","end":"2026-02-17T16:31:12.484843Z","steps":["trace[483803532] 'read index received' (duration: 39.665239ms)","trace[483803532] 'applied index is now lower than readState.Index' (duration: 560.711362ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:31:12.484969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.509634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3180"} {"level":"info","ts":"2026-02-17T16:31:12.484996Z","caller":"traceutil/trace.go:171","msg":"trace[97692421] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:250; }","duration":"600.536895ms","start":"2026-02-17T16:31:11.884449Z","end":"2026-02-17T16:31:12.484985Z","steps":["trace[97692421] 'agreement among raft nodes before linearized reading' (duration: 600.468583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:12.485035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:11.884366Z","time spent":"600.659778ms","remote":"127.0.0.1:57304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3203,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-17T16:31:12.485015Z","caller":"traceutil/trace.go:171","msg":"trace[1617155178] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"1.01990003s","start":"2026-02-17T16:31:11.465057Z","end":"2026-02-17T16:31:12.484957Z","steps":["trace[1617155178] 'process raft request' (duration: 538.847355ms)","trace[1617155178] 'compare' (duration: 478.554387ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:31:12.48522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:11.465033Z","time spent":"1.020070474s","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:31:13.87006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.108931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-17T16:31:13.870208Z","caller":"traceutil/trace.go:171","msg":"trace[210143221] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:296; }","duration":"103.282904ms","start":"2026-02-17T16:31:13.766909Z","end":"2026-02-17T16:31:13.870192Z","steps":["trace[210143221] 'agreement among raft nodes before linearized reading' (duration: 101.898943ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:17.55399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.921401ms","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-17T16:31:17.554543Z","caller":"traceutil/trace.go:171","msg":"trace[957973554] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:340; }","duration":"161.511514ms","start":"2026-02-17T16:31:17.392982Z","end":"2026-02-17T16:31:17.554494Z","steps":["trace[957973554] 'range keys from in-memory index tree' (duration: 160.631794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:17.554679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.32242ms","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-17T16:31:17.560578Z","caller":"traceutil/trace.go:171","msg":"trace[669793802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:340; }","duration":"145.37121ms","start":"2026-02-17T16:31:17.415194Z","end":"2026-02-17T16:31:17.560566Z","steps":["trace[669793802] 'range keys from in-memory index tree' (duration: 139.170207ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:31:22.839848Z","caller":"traceutil/trace.go:171","msg":"trace[282938466] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"182.942521ms","start":"2026-02-17T16:31:22.656868Z","end":"2026-02-17T16:31:22.839811Z","steps":["trace[282938466] 'process raft request' (duration: 181.543119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:33.309584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.220377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:31:33.309675Z","caller":"traceutil/trace.go:171","msg":"trace[2032947766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:467; }","duration":"258.32889ms","start":"2026-02-17T16:31:33.051326Z","end":"2026-02-17T16:31:33.309655Z","steps":["trace[2032947766] 'range keys from in-memory index tree' (duration: 257.968251ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:31:38.334236Z","caller":"traceutil/trace.go:171","msg":"trace[1147476488] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"148.075483ms","start":"2026-02-17T16:31:38.186134Z","end":"2026-02-17T16:31:38.334209Z","steps":["trace[1147476488] 'process raft request' (duration: 147.93364ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:31:42.773303Z","caller":"traceutil/trace.go:171","msg":"trace[1167632541] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"116.636373ms","start":"2026-02-17T16:31:42.65663Z","end":"2026-02-17T16:31:42.773267Z","steps":["trace[1167632541] 'process raft request' (duration: 116.458069ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:43.348528Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6890116469488577927,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T16:31:43.813897Z","caller":"traceutil/trace.go:171","msg":"trace[620917281] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.035250844s","start":"2026-02-17T16:31:42.778609Z","end":"2026-02-17T16:31:43.81386Z","steps":["trace[620917281] 'process raft request' (duration: 967.009222ms)","trace[620917281] 'compare' (duration: 67.467635ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:31:43.814071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:42.77856Z","time spent":"1.035421599s","remote":"127.0.0.1:57194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5153,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:31:44.010883Z","caller":"traceutil/trace.go:171","msg":"trace[1822579623] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:566; }","duration":"1.16272945s","start":"2026-02-17T16:31:42.848124Z","end":"2026-02-17T16:31:44.010853Z","steps":["trace[1822579623] 'read index received' (duration: 897.50794ms)","trace[1822579623] 'applied index is now lower than readState.Index' (duration: 265.22033ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:31:44.011147Z","caller":"traceutil/trace.go:171","msg":"trace[1761737206] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"1.170593783s","start":"2026-02-17T16:31:42.84054Z","end":"2026-02-17T16:31:44.011134Z","steps":["trace[1761737206] 'process raft request' (duration: 1.169890746s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.011307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:42.840512Z","time spent":"1.170670405s","remote":"127.0.0.1:57194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:31:44.011472Z","caller":"traceutil/trace.go:171","msg":"trace[456283511] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"964.103585ms","start":"2026-02-17T16:31:43.047361Z","end":"2026-02-17T16:31:44.011465Z","steps":["trace[456283511] 'process raft request' (duration: 963.256455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.011509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:43.047348Z","time spent":"964.145586ms","remote":"127.0.0.1:57194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:31:44.011598Z","caller":"traceutil/trace.go:171","msg":"trace[2108696042] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"770.058516ms","start":"2026-02-17T16:31:43.24153Z","end":"2026-02-17T16:31:44.011589Z","steps":["trace[2108696042] 'process raft request' (duration: 769.132754ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.011639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:43.241501Z","time spent":"770.120067ms","remote":"127.0.0.1:57194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:31:44.011724Z","caller":"traceutil/trace.go:171","msg":"trace[941327231] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"346.224709ms","start":"2026-02-17T16:31:43.66549Z","end":"2026-02-17T16:31:44.011715Z","steps":["trace[941327231] 'process raft request' (duration: 345.277376ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.011822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:43.665462Z","time spent":"346.339722ms","remote":"127.0.0.1:57194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:31:44.012025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.163865818s","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-17T16:31:44.012107Z","caller":"traceutil/trace.go:171","msg":"trace[1840884543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"1.16399842s","start":"2026-02-17T16:31:42.848087Z","end":"2026-02-17T16:31:44.012086Z","steps":["trace[1840884543] 'agreement among raft nodes before linearized reading' (duration: 1.163770445s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.012148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:42.848075Z","time spent":"1.164066203s","remote":"127.0.0.1:57372","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-17T16:31:44.017443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.11223955s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-rd8bt\" ","response":"range_response_count:1 size:4822"} {"level":"warn","ts":"2026-02-17T16:31:44.017455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.872295ms","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-17T16:31:44.017492Z","caller":"traceutil/trace.go:171","msg":"trace[259948731] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-rd8bt; range_end:; response_count:1; response_revision:555; }","duration":"1.112297271s","start":"2026-02-17T16:31:42.905181Z","end":"2026-02-17T16:31:44.017478Z","steps":["trace[259948731] 'agreement among raft nodes before linearized reading' (duration: 1.112118177s)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:31:44.017503Z","caller":"traceutil/trace.go:171","msg":"trace[854564495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:555; }","duration":"171.938998ms","start":"2026-02-17T16:31:43.845552Z","end":"2026-02-17T16:31:44.017491Z","steps":["trace[854564495] 'agreement among raft nodes before linearized reading' (duration: 171.776624ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.017519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:42.905146Z","time spent":"1.112367613s","remote":"127.0.0.1:57308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4845,"request content":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-rd8bt\" "} {"level":"info","ts":"2026-02-17T16:31:44.017666Z","caller":"traceutil/trace.go:171","msg":"trace[1929064926] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"195.791101ms","start":"2026-02-17T16:31:43.821866Z","end":"2026-02-17T16:31:44.017657Z","steps":["trace[1929064926] 'process raft request' (duration: 195.35704ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.017697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.113543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-17T16:31:44.017724Z","caller":"traceutil/trace.go:171","msg":"trace[1881905459] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:555; }","duration":"179.174675ms","start":"2026-02-17T16:31:43.83854Z","end":"2026-02-17T16:31:44.017714Z","steps":["trace[1881905459] 'agreement among raft nodes before linearized reading' (duration: 179.101193ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.01779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.891197ms","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-17T16:31:44.017808Z","caller":"traceutil/trace.go:171","msg":"trace[1032329904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:555; }","duration":"165.921347ms","start":"2026-02-17T16:31:43.851881Z","end":"2026-02-17T16:31:44.017802Z","steps":["trace[1032329904] 'agreement among raft nodes before linearized reading' (duration: 165.871136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.017866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.505869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T16:31:44.017889Z","caller":"traceutil/trace.go:171","msg":"trace[1022176921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:555; }","duration":"454.580811ms","start":"2026-02-17T16:31:43.563302Z","end":"2026-02-17T16:31:44.017883Z","steps":["trace[1022176921] 'agreement among raft nodes before linearized reading' (duration: 454.510939ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.017908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:43.563277Z","time spent":"454.625972ms","remote":"127.0.0.1:57372","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-17T16:31:44.017962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.31758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:31:44.017978Z","caller":"traceutil/trace.go:171","msg":"trace[194279597] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:555; }","duration":"578.385921ms","start":"2026-02-17T16:31:43.439587Z","end":"2026-02-17T16:31:44.017973Z","steps":["trace[194279597] 'agreement among raft nodes before linearized reading' (duration: 578.359911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.017994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:43.439553Z","time spent":"578.436851ms","remote":"127.0.0.1:57194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-17T16:31:44.018095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.075397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:31:44.018111Z","caller":"traceutil/trace.go:171","msg":"trace[257636538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"971.129957ms","start":"2026-02-17T16:31:43.046976Z","end":"2026-02-17T16:31:44.018106Z","steps":["trace[257636538] 'agreement among raft nodes before linearized reading' (duration: 971.101226ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:44.018125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:43.046952Z","time spent":"971.170388ms","remote":"127.0.0.1:57168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T16:31:50.857758Z","caller":"traceutil/trace.go:171","msg":"trace[2139406024] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"236.778988ms","start":"2026-02-17T16:31:50.620946Z","end":"2026-02-17T16:31:50.857725Z","steps":["trace[2139406024] 'read index received' (duration: 236.44642ms)","trace[2139406024] 'applied index is now lower than readState.Index' (duration: 331.168µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:31:50.858036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.053775ms","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-17T16:31:50.858071Z","caller":"traceutil/trace.go:171","msg":"trace[1790686138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"237.164337ms","start":"2026-02-17T16:31:50.620896Z","end":"2026-02-17T16:31:50.85806Z","steps":["trace[1790686138] 'agreement among raft nodes before linearized reading' (duration: 236.958602ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:31:50.858178Z","caller":"traceutil/trace.go:171","msg":"trace[1060041371] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"326.95979ms","start":"2026-02-17T16:31:50.531156Z","end":"2026-02-17T16:31:50.858116Z","steps":["trace[1060041371] 'process raft request' (duration: 326.347916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:50.858437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:50.531119Z","time spent":"327.167315ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:31:51.066111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.572212ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:31:51.066233Z","caller":"traceutil/trace.go:171","msg":"trace[1102990179] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"138.209896ms","start":"2026-02-17T16:31:50.928003Z","end":"2026-02-17T16:31:51.066213Z","steps":["trace[1102990179] 'read index received' (duration: 18.393518ms)","trace[1102990179] 'applied index is now lower than readState.Index' (duration: 119.814438ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:31:51.066335Z","caller":"traceutil/trace.go:171","msg":"trace[7378170] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"198.175595ms","start":"2026-02-17T16:31:50.868148Z","end":"2026-02-17T16:31:51.066324Z","steps":["trace[7378170] 'process raft request' (duration: 78.262085ms)","trace[7378170] 'compare' (duration: 119.322757ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:31:51.066489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.990117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9mf7p\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-17T16:31:51.066563Z","caller":"traceutil/trace.go:171","msg":"trace[1174840834] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9mf7p; range_end:; response_count:1; response_revision:596; }","duration":"137.10578ms","start":"2026-02-17T16:31:50.92944Z","end":"2026-02-17T16:31:51.066546Z","steps":["trace[1174840834] 'agreement among raft nodes before linearized reading' (duration: 136.920405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:51.066836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.8352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T16:31:51.066875Z","caller":"traceutil/trace.go:171","msg":"trace[1151106392] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:596; }","duration":"138.923142ms","start":"2026-02-17T16:31:50.927939Z","end":"2026-02-17T16:31:51.066862Z","steps":["trace[1151106392] 'agreement among raft nodes before linearized reading' (duration: 138.754078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:51.993574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:51.17601Z","time spent":"817.552407ms","remote":"127.0.0.1:38106","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-17T16:31:52.557045Z","caller":"traceutil/trace.go:171","msg":"trace[284378641] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"438.699293ms","start":"2026-02-17T16:31:52.118317Z","end":"2026-02-17T16:31:52.557016Z","steps":["trace[284378641] 'read index received' (duration: 438.320414ms)","trace[284378641] 'applied index is now lower than readState.Index' (duration: 377.829µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:31:52.557257Z","caller":"traceutil/trace.go:171","msg":"trace[740315738] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"465.029874ms","start":"2026-02-17T16:31:52.092214Z","end":"2026-02-17T16:31:52.557244Z","steps":["trace[740315738] 'process raft request' (duration: 464.510282ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:52.557598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.178475ms","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-17T16:31:52.557693Z","caller":"traceutil/trace.go:171","msg":"trace[773812437] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:599; }","duration":"433.39544ms","start":"2026-02-17T16:31:52.124273Z","end":"2026-02-17T16:31:52.557668Z","steps":["trace[773812437] 'agreement among raft nodes before linearized reading' (duration: 433.218976ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:52.55774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:52.12426Z","time spent":"433.470472ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T16:31:52.557977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.668176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-17T16:31:52.558008Z","caller":"traceutil/trace.go:171","msg":"trace[882459824] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:599; }","duration":"439.698627ms","start":"2026-02-17T16:31:52.1183Z","end":"2026-02-17T16:31:52.557998Z","steps":["trace[882459824] 'agreement among raft nodes before linearized reading' (duration: 439.641006ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:52.558036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:52.118211Z","time spent":"439.81888ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T16:31:52.557426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:52.092188Z","time spent":"465.113737ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:31:52.558512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.036639ms","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-17T16:31:52.558554Z","caller":"traceutil/trace.go:171","msg":"trace[615030386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"432.096981ms","start":"2026-02-17T16:31:52.126447Z","end":"2026-02-17T16:31:52.558544Z","steps":["trace[615030386] 'agreement among raft nodes before linearized reading' (duration: 432.006809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:31:52.558586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:31:52.12644Z","time spent":"432.139292ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-17T16:31:52.840906Z","caller":"traceutil/trace.go:171","msg":"trace[1322199173] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"275.873767ms","start":"2026-02-17T16:31:52.565001Z","end":"2026-02-17T16:31:52.840874Z","steps":["trace[1322199173] 'process raft request' (duration: 275.621151ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:31:52.845604Z","caller":"traceutil/trace.go:171","msg":"trace[534334917] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"279.90519ms","start":"2026-02-17T16:31:52.565663Z","end":"2026-02-17T16:31:52.845568Z","steps":["trace[534334917] 'process raft request' (duration: 279.49949ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:31:52.845769Z","caller":"traceutil/trace.go:171","msg":"trace[768391583] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"277.524435ms","start":"2026-02-17T16:31:52.56797Z","end":"2026-02-17T16:31:52.845494Z","steps":["trace[768391583] 'process raft request' (duration: 277.341631ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:31:57.101231Z","caller":"traceutil/trace.go:171","msg":"trace[283530860] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"120.880614ms","start":"2026-02-17T16:31:56.980323Z","end":"2026-02-17T16:31:57.101203Z","steps":["trace[283530860] 'process raft request' (duration: 120.72767ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:31:57.146858Z","caller":"traceutil/trace.go:171","msg":"trace[89851660] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"118.408176ms","start":"2026-02-17T16:31:57.028434Z","end":"2026-02-17T16:31:57.146842Z","steps":["trace[89851660] 'process raft request' (duration: 113.423251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:02.763894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.283274ms","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-17T16:32:02.763993Z","caller":"traceutil/trace.go:171","msg":"trace[1214889063] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:660; }","duration":"128.456478ms","start":"2026-02-17T16:32:02.635508Z","end":"2026-02-17T16:32:02.763965Z","steps":["trace[1214889063] 'range keys from in-memory index tree' (duration: 128.049719ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:32:03.052108Z","caller":"traceutil/trace.go:171","msg":"trace[807699017] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:682; }","duration":"127.988648ms","start":"2026-02-17T16:32:02.924101Z","end":"2026-02-17T16:32:03.05209Z","steps":["trace[807699017] 'read index received' (duration: 127.805123ms)","trace[807699017] 'applied index is now lower than readState.Index' (duration: 182.745µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:32:03.052563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.416619ms","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-17T16:32:03.052668Z","caller":"traceutil/trace.go:171","msg":"trace[613884704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:661; }","duration":"123.575923ms","start":"2026-02-17T16:32:02.929079Z","end":"2026-02-17T16:32:03.052655Z","steps":["trace[613884704] 'agreement among raft nodes before linearized reading' (duration: 123.355227ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:03.052698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.540561ms","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-17T16:32:03.052797Z","caller":"traceutil/trace.go:171","msg":"trace[1647323314] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:661; }","duration":"128.727405ms","start":"2026-02-17T16:32:02.924048Z","end":"2026-02-17T16:32:03.052776Z","steps":["trace[1647323314] 'agreement among raft nodes before linearized reading' (duration: 128.386607ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:03.053148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.199343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T16:32:03.053171Z","caller":"traceutil/trace.go:171","msg":"trace[31408908] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"281.178635ms","start":"2026-02-17T16:32:02.771984Z","end":"2026-02-17T16:32:03.053163Z","steps":["trace[31408908] 'process raft request' (duration: 279.975317ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:32:03.0566Z","caller":"traceutil/trace.go:171","msg":"trace[2098568236] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:661; }","duration":"125.433686ms","start":"2026-02-17T16:32:02.929929Z","end":"2026-02-17T16:32:03.055363Z","steps":["trace[2098568236] 'agreement among raft nodes before linearized reading' (duration: 123.166042ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:03.311017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.601415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:32:03.311279Z","caller":"traceutil/trace.go:171","msg":"trace[1782455140] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"249.924681ms","start":"2026-02-17T16:32:03.061335Z","end":"2026-02-17T16:32:03.31126Z","steps":["trace[1782455140] 'process raft request' (duration: 122.925547ms)","trace[1782455140] 'compare' (duration: 124.264879ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:32:03.324107Z","caller":"traceutil/trace.go:171","msg":"trace[47536848] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:684; }","duration":"112.749154ms","start":"2026-02-17T16:32:03.211335Z","end":"2026-02-17T16:32:03.324084Z","steps":["trace[47536848] 'read index received' (duration: 112.514598ms)","trace[47536848] 'applied index is now lower than readState.Index' (duration: 233.346µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:32:03.324306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.947958ms","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-17T16:32:03.324326Z","caller":"traceutil/trace.go:171","msg":"trace[243490308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:664; }","duration":"113.035501ms","start":"2026-02-17T16:32:03.211283Z","end":"2026-02-17T16:32:03.324319Z","steps":["trace[243490308] 'agreement among raft nodes before linearized reading' (duration: 112.887457ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:32:03.324589Z","caller":"traceutil/trace.go:171","msg":"trace[494882094] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"262.311875ms","start":"2026-02-17T16:32:03.062269Z","end":"2026-02-17T16:32:03.324581Z","steps":["trace[494882094] 'process raft request' (duration: 261.605478ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:32:03.324658Z","caller":"traceutil/trace.go:171","msg":"trace[2144018256] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"261.176919ms","start":"2026-02-17T16:32:03.063476Z","end":"2026-02-17T16:32:03.324653Z","steps":["trace[2144018256] 'process raft request' (duration: 260.565394ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:32:15.588204Z","caller":"traceutil/trace.go:171","msg":"trace[2080388464] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"449.163755ms","start":"2026-02-17T16:32:15.139001Z","end":"2026-02-17T16:32:15.588165Z","steps":["trace[2080388464] 'process raft request' (duration: 448.93622ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:15.588481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.138989Z","time spent":"449.331169ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:32:15.91441Z","caller":"traceutil/trace.go:171","msg":"trace[289096234] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:775; }","duration":"527.329465ms","start":"2026-02-17T16:32:15.38705Z","end":"2026-02-17T16:32:15.914379Z","steps":["trace[289096234] 'read index received' (duration: 203.27054ms)","trace[289096234] 'applied index is now lower than readState.Index' (duration: 324.057705ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:32:15.914774Z","caller":"traceutil/trace.go:171","msg":"trace[83975313] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"562.991824ms","start":"2026-02-17T16:32:15.351767Z","end":"2026-02-17T16:32:15.914759Z","steps":["trace[83975313] 'process raft request' (duration: 528.666727ms)","trace[83975313] 'compare' (duration: 33.722023ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:32:15.914919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.35172Z","time spent":"563.092627ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:32:15.915271Z","caller":"traceutil/trace.go:171","msg":"trace[773993488] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"531.906293ms","start":"2026-02-17T16:32:15.38335Z","end":"2026-02-17T16:32:15.915256Z","steps":["trace[773993488] 'process raft request' (duration: 530.964961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:15.915329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.383329Z","time spent":"531.967385ms","remote":"127.0.0.1:57304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4769,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:32:15.915584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.536325ms","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-17T16:32:15.915624Z","caller":"traceutil/trace.go:171","msg":"trace[2066807649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:752; }","duration":"528.628337ms","start":"2026-02-17T16:32:15.386982Z","end":"2026-02-17T16:32:15.91561Z","steps":["trace[2066807649] 'agreement among raft nodes before linearized reading' (duration: 528.484853ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:15.915652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.386971Z","time spent":"528.674868ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T16:32:15.916027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.283557ms","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-17T16:32:15.916076Z","caller":"traceutil/trace.go:171","msg":"trace[665878597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:752; }","duration":"491.370168ms","start":"2026-02-17T16:32:15.424695Z","end":"2026-02-17T16:32:15.916065Z","steps":["trace[665878597] 'agreement among raft nodes before linearized reading' (duration: 491.205895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:15.916118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.424665Z","time spent":"491.44545ms","remote":"127.0.0.1:57372","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-17T16:32:15.91627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.095102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:32:15.916295Z","caller":"traceutil/trace.go:171","msg":"trace[1212842692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:752; }","duration":"281.163023ms","start":"2026-02-17T16:32:15.635124Z","end":"2026-02-17T16:32:15.916287Z","steps":["trace[1212842692] 'agreement among raft nodes before linearized reading' (duration: 281.122372ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:15.916496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.326062ms","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-17T16:32:15.916525Z","caller":"traceutil/trace.go:171","msg":"trace[969599460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:752; }","duration":"458.373953ms","start":"2026-02-17T16:32:15.458141Z","end":"2026-02-17T16:32:15.916515Z","steps":["trace[969599460] 'agreement among raft nodes before linearized reading' (duration: 458.292931ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:15.91655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.458134Z","time spent":"458.410523ms","remote":"127.0.0.1:57372","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-17T16:32:15.916728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.182663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T16:32:15.916755Z","caller":"traceutil/trace.go:171","msg":"trace[768875451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:752; }","duration":"459.240954ms","start":"2026-02-17T16:32:15.457505Z","end":"2026-02-17T16:32:15.916746Z","steps":["trace[768875451] 'agreement among raft nodes before linearized reading' (duration: 459.160012ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:15.91678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.457488Z","time spent":"459.285965ms","remote":"127.0.0.1:57372","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-17T16:32:17.107186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.41748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:32:17.107352Z","caller":"traceutil/trace.go:171","msg":"trace[1625656370] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"1.175063536s","start":"2026-02-17T16:32:15.932253Z","end":"2026-02-17T16:32:17.107317Z","steps":["trace[1625656370] 'process raft request' (duration: 331.444961ms)","trace[1625656370] 'compare' (duration: 843.037631ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:32:17.107538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.932228Z","time spent":"1.175198099s","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:32:17.10779Z","caller":"traceutil/trace.go:171","msg":"trace[2065168446] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"1.174686938s","start":"2026-02-17T16:32:15.933091Z","end":"2026-02-17T16:32:17.107778Z","steps":["trace[2065168446] 'process raft request' (duration: 1.174176546s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:17.107826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.933084Z","time spent":"1.174720509s","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:32:17.107949Z","caller":"traceutil/trace.go:171","msg":"trace[975513681] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"1.174744949s","start":"2026-02-17T16:32:15.933192Z","end":"2026-02-17T16:32:17.107937Z","steps":["trace[975513681] 'process raft request' (duration: 1.174118914s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:17.10798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.933185Z","time spent":"1.17477618s","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:32:17.109815Z","caller":"traceutil/trace.go:171","msg":"trace[1644731918] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"1.1760578s","start":"2026-02-17T16:32:15.933748Z","end":"2026-02-17T16:32:17.109805Z","steps":["trace[1644731918] 'process raft request' (duration: 1.173585392s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:17.109874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:15.933719Z","time spent":"1.176129212s","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:32:17.808171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.798556ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T16:32:17.808242Z","caller":"traceutil/trace.go:171","msg":"trace[1440065559] linearizableReadLoop","detail":"{readStateIndex:781; appliedIndex:777; }","duration":"1.756641003s","start":"2026-02-17T16:32:16.051585Z","end":"2026-02-17T16:32:17.808226Z","steps":["trace[1440065559] 'read index received' (duration: 212.162681ms)","trace[1440065559] 'applied index is now lower than readState.Index' (duration: 1.544477232s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:32:17.808336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.756753516s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:32:17.808353Z","caller":"traceutil/trace.go:171","msg":"trace[1823961776] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"1.756824028s","start":"2026-02-17T16:32:16.051523Z","end":"2026-02-17T16:32:17.808347Z","steps":["trace[1823961776] 'agreement among raft nodes before linearized reading' (duration: 1.756785937s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:17.808375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:16.051494Z","time spent":"1.756876899s","remote":"127.0.0.1:57172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:32:17.80854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.202249963s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:32:17.80856Z","caller":"traceutil/trace.go:171","msg":"trace[1996637289] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:756; }","duration":"1.202307514s","start":"2026-02-17T16:32:16.606246Z","end":"2026-02-17T16:32:17.808553Z","steps":["trace[1996637289] 'agreement among raft nodes before linearized reading' (duration: 1.202267504s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:17.808578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:16.606226Z","time spent":"1.202347386s","remote":"127.0.0.1:57630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":23,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:32:17.808752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.141322ms","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-17T16:32:17.808773Z","caller":"traceutil/trace.go:171","msg":"trace[636710602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"215.201453ms","start":"2026-02-17T16:32:17.593566Z","end":"2026-02-17T16:32:17.808767Z","steps":["trace[636710602] 'agreement among raft nodes before linearized reading' (duration: 215.123161ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:32:29.297454Z","caller":"traceutil/trace.go:171","msg":"trace[867782495] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"105.969243ms","start":"2026-02-17T16:32:29.191465Z","end":"2026-02-17T16:32:29.297434Z","steps":["trace[867782495] 'read index received' (duration: 105.813539ms)","trace[867782495] 'applied index is now lower than readState.Index' (duration: 154.834µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:32:29.297712Z","caller":"traceutil/trace.go:171","msg":"trace[2047417462] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"136.199123ms","start":"2026-02-17T16:32:29.161496Z","end":"2026-02-17T16:32:29.297695Z","steps":["trace[2047417462] 'process raft request' (duration: 135.835854ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:29.297985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.500945ms","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-17T16:32:29.298018Z","caller":"traceutil/trace.go:171","msg":"trace[1994087934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:791; }","duration":"106.569937ms","start":"2026-02-17T16:32:29.191438Z","end":"2026-02-17T16:32:29.298008Z","steps":["trace[1994087934] 'agreement among raft nodes before linearized reading' (duration: 106.437914ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:29.298192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.874181ms","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-17T16:32:29.29822Z","caller":"traceutil/trace.go:171","msg":"trace[1428245864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:791; }","duration":"105.967643ms","start":"2026-02-17T16:32:29.192244Z","end":"2026-02-17T16:32:29.298212Z","steps":["trace[1428245864] 'agreement among raft nodes before linearized reading' (duration: 105.891871ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:29.298465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.314796ms","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-17T16:32:29.298503Z","caller":"traceutil/trace.go:171","msg":"trace[1487913048] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:791; }","duration":"102.373907ms","start":"2026-02-17T16:32:29.196118Z","end":"2026-02-17T16:32:29.298492Z","steps":["trace[1487913048] 'agreement among raft nodes before linearized reading' (duration: 102.268225ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:32:29.79816Z","caller":"traceutil/trace.go:171","msg":"trace[583507659] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"491.551694ms","start":"2026-02-17T16:32:29.306582Z","end":"2026-02-17T16:32:29.798134Z","steps":["trace[583507659] 'process raft request' (duration: 466.644911ms)","trace[583507659] 'compare' (duration: 24.733578ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:32:29.798314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:29.306533Z","time spent":"491.681136ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:32:29.880164Z","caller":"traceutil/trace.go:171","msg":"trace[774798124] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"570.561315ms","start":"2026-02-17T16:32:29.309575Z","end":"2026-02-17T16:32:29.880136Z","steps":["trace[774798124] 'process raft request' (duration: 570.510174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:29.880453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:29.309566Z","time spent":"570.755419ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:32:29.881156Z","caller":"traceutil/trace.go:171","msg":"trace[1245304832] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"572.152242ms","start":"2026-02-17T16:32:29.308966Z","end":"2026-02-17T16:32:29.881118Z","steps":["trace[1245304832] 'process raft request' (duration: 570.953804ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:29.881333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:29.30896Z","time spent":"572.264735ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:32:37.995606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.655819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T16:32:37.995675Z","caller":"traceutil/trace.go:171","msg":"trace[225894689] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:814; }","duration":"166.789312ms","start":"2026-02-17T16:32:37.82887Z","end":"2026-02-17T16:32:37.995659Z","steps":["trace[225894689] 'range keys from in-memory index tree' (duration: 166.464304ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:32:38.550999Z","caller":"traceutil/trace.go:171","msg":"trace[1601600862] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:845; }","duration":"497.505594ms","start":"2026-02-17T16:32:38.053468Z","end":"2026-02-17T16:32:38.550974Z","steps":["trace[1601600862] 'read index received' (duration: 481.699718ms)","trace[1601600862] 'applied index is now lower than readState.Index' (duration: 15.804876ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:32:38.552023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.539569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:32:38.552072Z","caller":"traceutil/trace.go:171","msg":"trace[1139855748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:818; }","duration":"498.652912ms","start":"2026-02-17T16:32:38.053405Z","end":"2026-02-17T16:32:38.552058Z","steps":["trace[1139855748] 'agreement among raft nodes before linearized reading' (duration: 498.481968ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:38.552317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:38.053389Z","time spent":"498.912298ms","remote":"127.0.0.1:57168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T16:32:38.552809Z","caller":"traceutil/trace.go:171","msg":"trace[1349874120] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"550.278422ms","start":"2026-02-17T16:32:38.002514Z","end":"2026-02-17T16:32:38.552792Z","steps":["trace[1349874120] 'process raft request' (duration: 548.242283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:38.553065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:38.002508Z","time spent":"550.363814ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:32:38.553663Z","caller":"traceutil/trace.go:171","msg":"trace[2047668548] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"551.000879ms","start":"2026-02-17T16:32:38.002646Z","end":"2026-02-17T16:32:38.553646Z","steps":["trace[2047668548] 'process raft request' (duration: 548.250183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:38.553764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:38.002607Z","time spent":"551.116582ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:32:38.554314Z","caller":"traceutil/trace.go:171","msg":"trace[1736711833] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"550.427426ms","start":"2026-02-17T16:32:38.0024Z","end":"2026-02-17T16:32:38.552828Z","steps":["trace[1736711833] 'process raft request' (duration: 532.784556ms)","trace[1736711833] 'compare' (duration: 14.982677ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:32:38.555195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:38.002395Z","time spent":"552.596787ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:32:51.570354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.758672ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:32:51.570655Z","caller":"traceutil/trace.go:171","msg":"trace[1315729678] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"898.501813ms","start":"2026-02-17T16:32:50.672138Z","end":"2026-02-17T16:32:51.57064Z","steps":["trace[1315729678] 'read index received' (duration: 392.333431ms)","trace[1315729678] 'applied index is now lower than readState.Index' (duration: 506.167172ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:32:51.570731Z","caller":"traceutil/trace.go:171","msg":"trace[501193687] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"935.647387ms","start":"2026-02-17T16:32:50.635077Z","end":"2026-02-17T16:32:51.570725Z","steps":["trace[501193687] 'process raft request' (duration: 429.432034ms)","trace[501193687] 'compare' (duration: 505.616629ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:32:51.570768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:50.635059Z","time spent":"935.688458ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:32:51.570944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.805081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T16:32:51.570962Z","caller":"traceutil/trace.go:171","msg":"trace[1572144602] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:901; }","duration":"898.864322ms","start":"2026-02-17T16:32:50.672089Z","end":"2026-02-17T16:32:51.570953Z","steps":["trace[1572144602] 'agreement among raft nodes before linearized reading' (duration: 898.7681ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:51.570978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:50.672076Z","time spent":"898.897982ms","remote":"127.0.0.1:57372","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-17T16:32:51.571257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.91978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-02-17T16:32:51.571309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.64266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:32:51.571331Z","caller":"traceutil/trace.go:171","msg":"trace[1643569354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:901; }","duration":"524.706742ms","start":"2026-02-17T16:32:51.046618Z","end":"2026-02-17T16:32:51.571325Z","steps":["trace[1643569354] 'agreement among raft nodes before linearized reading' (duration: 524.671871ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:32:51.571333Z","caller":"traceutil/trace.go:171","msg":"trace[485497086] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:901; }","duration":"641.024202ms","start":"2026-02-17T16:32:50.930284Z","end":"2026-02-17T16:32:51.571308Z","steps":["trace[485497086] 'agreement among raft nodes before linearized reading' (duration: 640.829678ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:51.571348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:51.046603Z","time spent":"524.741793ms","remote":"127.0.0.1:57168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:32:51.571373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:50.93027Z","time spent":"641.095894ms","remote":"127.0.0.1:57182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.222\" "} {"level":"info","ts":"2026-02-17T16:32:54.568644Z","caller":"traceutil/trace.go:171","msg":"trace[2075168810] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"352.760119ms","start":"2026-02-17T16:32:54.21556Z","end":"2026-02-17T16:32:54.56832Z","steps":["trace[2075168810] 'process raft request' (duration: 352.503202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:32:54.568828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:32:54.215546Z","time spent":"353.180979ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:33:02.297001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.360675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:33:02.297095Z","caller":"traceutil/trace.go:171","msg":"trace[1685240011] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"649.652158ms","start":"2026-02-17T16:33:01.647427Z","end":"2026-02-17T16:33:02.297079Z","steps":["trace[1685240011] 'process raft request' (duration: 264.126929ms)","trace[1685240011] 'compare' (duration: 385.208641ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:33:02.297136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:33:01.647416Z","time spent":"649.702039ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:33:02.306541Z","caller":"traceutil/trace.go:171","msg":"trace[48230183] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"657.563116ms","start":"2026-02-17T16:33:01.648971Z","end":"2026-02-17T16:33:02.306534Z","steps":["trace[48230183] 'process raft request' (duration: 657.3169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:02.306635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:33:01.648965Z","time spent":"657.629787ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:33:02.306401Z","caller":"traceutil/trace.go:171","msg":"trace[814905844] linearizableReadLoop","detail":"{readStateIndex:970; appliedIndex:969; }","duration":"250.361651ms","start":"2026-02-17T16:33:02.056025Z","end":"2026-02-17T16:33:02.306387Z","steps":["trace[814905844] 'read index received' (duration: 250.32161ms)","trace[814905844] 'applied index is now lower than readState.Index' (duration: 39.291µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:33:02.306849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.824483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:33:02.306921Z","caller":"traceutil/trace.go:171","msg":"trace[1755849346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:932; }","duration":"250.936135ms","start":"2026-02-17T16:33:02.055977Z","end":"2026-02-17T16:33:02.306913Z","steps":["trace[1755849346] 'agreement among raft nodes before linearized reading' (duration: 250.851143ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:33:02.33362Z","caller":"traceutil/trace.go:171","msg":"trace[1542645693] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"247.690827ms","start":"2026-02-17T16:33:02.0859Z","end":"2026-02-17T16:33:02.333591Z","steps":["trace[1542645693] 'process raft request' (duration: 247.377749ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:03.483206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.925926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:33:03.483284Z","caller":"traceutil/trace.go:171","msg":"trace[1627425465] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:935; }","duration":"666.062648ms","start":"2026-02-17T16:33:02.817204Z","end":"2026-02-17T16:33:03.483266Z","steps":["trace[1627425465] 'count revisions from in-memory index tree' (duration: 665.855805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:03.483314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:33:02.817181Z","time spent":"666.12526ms","remote":"127.0.0.1:57308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:33:03.48348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.240238ms","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-17T16:33:03.483497Z","caller":"traceutil/trace.go:171","msg":"trace[1952972902] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:935; }","duration":"631.2889ms","start":"2026-02-17T16:33:02.852201Z","end":"2026-02-17T16:33:03.48349Z","steps":["trace[1952972902] 'count revisions from in-memory index tree' (duration: 631.180297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:03.483513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:33:02.85218Z","time spent":"631.326241ms","remote":"127.0.0.1:38098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:33:03.483998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.287161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:33:03.484014Z","caller":"traceutil/trace.go:171","msg":"trace[861642275] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:935; }","duration":"114.351062ms","start":"2026-02-17T16:33:03.369658Z","end":"2026-02-17T16:33:03.484009Z","steps":["trace[861642275] 'count revisions from in-memory index tree' (duration: 114.206579ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:33:08.557049Z","caller":"traceutil/trace.go:171","msg":"trace[1624565415] linearizableReadLoop","detail":"{readStateIndex:987; appliedIndex:986; }","duration":"233.303413ms","start":"2026-02-17T16:33:08.323728Z","end":"2026-02-17T16:33:08.557031Z","steps":["trace[1624565415] 'read index received' (duration: 233.106928ms)","trace[1624565415] 'applied index is now lower than readState.Index' (duration: 195.665µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:33:08.557245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.481567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T16:33:08.557281Z","caller":"traceutil/trace.go:171","msg":"trace[1899698275] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:948; }","duration":"233.566399ms","start":"2026-02-17T16:33:08.323705Z","end":"2026-02-17T16:33:08.557272Z","steps":["trace[1899698275] 'agreement among raft nodes before linearized reading' (duration: 233.410116ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:33:08.557336Z","caller":"traceutil/trace.go:171","msg":"trace[2118346440] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"242.288701ms","start":"2026-02-17T16:33:08.314997Z","end":"2026-02-17T16:33:08.557285Z","steps":["trace[2118346440] 'process raft request' (duration: 241.893971ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:33:10.668458Z","caller":"traceutil/trace.go:171","msg":"trace[2027932642] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"104.204392ms","start":"2026-02-17T16:33:10.56421Z","end":"2026-02-17T16:33:10.668414Z","steps":["trace[2027932642] 'process raft request' (duration: 104.062068ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:10.869614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.201088ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:33:10.869674Z","caller":"traceutil/trace.go:171","msg":"trace[2062347092] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1000; }","duration":"145.4494ms","start":"2026-02-17T16:33:10.724214Z","end":"2026-02-17T16:33:10.869663Z","steps":["trace[2062347092] 'read index received' (duration: 30.11506ms)","trace[2062347092] 'applied index is now lower than readState.Index' (duration: 115.33366ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:33:10.869781Z","caller":"traceutil/trace.go:171","msg":"trace[1073501599] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"196.6052ms","start":"2026-02-17T16:33:10.673169Z","end":"2026-02-17T16:33:10.869775Z","steps":["trace[1073501599] 'process raft request' (duration: 81.193607ms)","trace[1073501599] 'compare' (duration: 115.136376ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:33:10.869911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.701436ms","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-17T16:33:10.869925Z","caller":"traceutil/trace.go:171","msg":"trace[1081834695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:962; }","duration":"145.751067ms","start":"2026-02-17T16:33:10.724169Z","end":"2026-02-17T16:33:10.86992Z","steps":["trace[1081834695] 'agreement among raft nodes before linearized reading' (duration: 145.690126ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:10.870007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.979387ms","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-17T16:33:10.870019Z","caller":"traceutil/trace.go:171","msg":"trace[393575727] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:962; }","duration":"129.013438ms","start":"2026-02-17T16:33:10.741002Z","end":"2026-02-17T16:33:10.870016Z","steps":["trace[393575727] 'agreement among raft nodes before linearized reading' (duration: 128.977307ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:11.802677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.799752ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:33:11.802768Z","caller":"traceutil/trace.go:171","msg":"trace[530882700] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1001; }","duration":"872.024328ms","start":"2026-02-17T16:33:10.930735Z","end":"2026-02-17T16:33:11.80276Z","steps":["trace[530882700] 'read index received' (duration: 62.039432ms)","trace[530882700] 'applied index is now lower than readState.Index' (duration: 809.984266ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:33:11.80287Z","caller":"traceutil/trace.go:171","msg":"trace[2042319867] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"930.052296ms","start":"2026-02-17T16:33:10.872811Z","end":"2026-02-17T16:33:11.802863Z","steps":["trace[2042319867] 'process raft request' (duration: 120.02158ms)","trace[2042319867] 'compare' (duration: 809.201167ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:33:11.802899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:33:10.872787Z","time spent":"930.097127ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:33:11.802996Z","caller":"traceutil/trace.go:171","msg":"trace[1544922884] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"928.895249ms","start":"2026-02-17T16:33:10.874096Z","end":"2026-02-17T16:33:11.802992Z","steps":["trace[1544922884] 'process raft request' (duration: 928.635743ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:11.803019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:33:10.87409Z","time spent":"928.916101ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:33:11.803119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.382346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.222\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T16:33:11.803132Z","caller":"traceutil/trace.go:171","msg":"trace[2136836817] range","detail":"{range_begin:/registry/masterleases/199.204.45.222; range_end:; response_count:1; response_revision:964; }","duration":"872.416246ms","start":"2026-02-17T16:33:10.930711Z","end":"2026-02-17T16:33:11.803127Z","steps":["trace[2136836817] 'agreement among raft nodes before linearized reading' (duration: 872.362345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:11.803144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:33:10.9307Z","time spent":"872.441877ms","remote":"127.0.0.1:57182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.222\" "} {"level":"warn","ts":"2026-02-17T16:33:11.803219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.50851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:33:11.803232Z","caller":"traceutil/trace.go:171","msg":"trace[730351752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"755.552671ms","start":"2026-02-17T16:33:11.047675Z","end":"2026-02-17T16:33:11.803228Z","steps":["trace[730351752] 'agreement among raft nodes before linearized reading' (duration: 755.53323ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:11.803243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:33:11.047662Z","time spent":"755.578711ms","remote":"127.0.0.1:57168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T16:33:11.80339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.462601ms","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-17T16:33:11.803403Z","caller":"traceutil/trace.go:171","msg":"trace[909709412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:964; }","duration":"117.501272ms","start":"2026-02-17T16:33:11.685898Z","end":"2026-02-17T16:33:11.803399Z","steps":["trace[909709412] 'agreement among raft nodes before linearized reading' (duration: 117.462731ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:12.024629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.516608ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-17T16:33:12.024795Z","caller":"traceutil/trace.go:171","msg":"trace[346341089] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"216.155773ms","start":"2026-02-17T16:33:11.808626Z","end":"2026-02-17T16:33:12.024782Z","steps":["trace[346341089] 'process raft request' (duration: 216.072061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:17.154352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.555263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:33:17.154404Z","caller":"traceutil/trace.go:171","msg":"trace[591787803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"105.636004ms","start":"2026-02-17T16:33:17.048756Z","end":"2026-02-17T16:33:17.154392Z","steps":["trace[591787803] 'range keys from in-memory index tree' (duration: 105.505982ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:33:17.788999Z","caller":"traceutil/trace.go:171","msg":"trace[493585383] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"349.129923ms","start":"2026-02-17T16:33:17.439838Z","end":"2026-02-17T16:33:17.788968Z","steps":["trace[493585383] 'process raft request' (duration: 347.966137ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:17.78918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:33:17.43981Z","time spent":"349.267177ms","remote":"127.0.0.1:57304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5246,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:33:25.351071Z","caller":"traceutil/trace.go:171","msg":"trace[1047824124] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"119.901446ms","start":"2026-02-17T16:33:25.23115Z","end":"2026-02-17T16:33:25.351051Z","steps":["trace[1047824124] 'process raft request' (duration: 119.777513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:33:25.666436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.804526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-02-17T16:33:25.666524Z","caller":"traceutil/trace.go:171","msg":"trace[1973215506] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1059; }","duration":"172.93635ms","start":"2026-02-17T16:33:25.493565Z","end":"2026-02-17T16:33:25.666501Z","steps":["trace[1973215506] 'range keys from in-memory index tree' (duration: 172.628933ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:34:35.292018Z","caller":"traceutil/trace.go:171","msg":"trace[1022647623] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"109.338243ms","start":"2026-02-17T16:34:35.182659Z","end":"2026-02-17T16:34:35.291997Z","steps":["trace[1022647623] 'process raft request' (duration: 108.75943ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:36:36.233412Z","caller":"traceutil/trace.go:171","msg":"trace[782156285] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"124.10385ms","start":"2026-02-17T16:36:36.109284Z","end":"2026-02-17T16:36:36.233388Z","steps":["trace[782156285] 'process raft request' (duration: 31.775416ms)","trace[782156285] 'compare' (duration: 92.16828ms)"],"step_count":2}