{"level":"warn","ts":"2026-02-09T18:50:29.718024Z","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-09T18:50:29.718185Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95: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.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-09T18:50:29.718302Z","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-09T18:50:29.71837Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]}
{"level":"info","ts":"2026-02-09T18:50:29.718419Z","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-09T18:50:29.719302Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]}
{"level":"info","ts":"2026-02-09T18:50:29.719449Z","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.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-09T18:50:29.724799Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.091135ms"}
{"level":"info","ts":"2026-02-09T18:50:29.740098Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"}
{"level":"info","ts":"2026-02-09T18:50:29.74021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"}
{"level":"info","ts":"2026-02-09T18:50:29.740295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"}
{"level":"info","ts":"2026-02-09T18:50:29.740347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-09T18:50:29.740402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"}
{"level":"info","ts":"2026-02-09T18:50:29.740505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"}
{"level":"warn","ts":"2026-02-09T18:50:29.74594Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-09T18:50:29.746845Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-09T18:50:29.74785Z","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-09T18:50:29.750537Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-09T18:50:29.752849Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-09T18:50:29.753282Z","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-09T18:50:29.753441Z","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-09T18:50:29.753526Z","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-09T18:50:29.754361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"}
{"level":"info","ts":"2026-02-09T18:50:29.756363Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]}
{"level":"info","ts":"2026-02-09T18:50:29.761085Z","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-09T18:50:29.761327Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-09T18:50:29.761409Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-09T18:50:29.761553Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"}
{"level":"info","ts":"2026-02-09T18:50:29.761616Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"}
{"level":"info","ts":"2026-02-09T18:50:30.541032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"}
{"level":"info","ts":"2026-02-09T18:50:30.541076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-09T18:50:30.541102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"}
{"level":"info","ts":"2026-02-09T18:50:30.541115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"}
{"level":"info","ts":"2026-02-09T18:50:30.54112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"}
{"level":"info","ts":"2026-02-09T18:50:30.54113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"}
{"level":"info","ts":"2026-02-09T18:50:30.541137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"}
{"level":"info","ts":"2026-02-09T18:50:30.546425Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-09T18:50:30.557111Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-09T18:50:30.557214Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-09T18:50:30.559681Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-09T18:50:30.564091Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-09T18:50:30.564107Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-09T18:50:30.565494Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-09T18:50:30.566824Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"}
{"level":"info","ts":"2026-02-09T18:50:30.566893Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-09T18:50:30.566931Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-09T18:50:30.566944Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-09T18:50:58.710533Z","caller":"traceutil/trace.go:171","msg":"trace[855904483] linearizableReadLoop","detail":"{readStateIndex:520; appliedIndex:519; }","duration":"426.102247ms","start":"2026-02-09T18:50:58.284415Z","end":"2026-02-09T18:50:58.710518Z","steps":["trace[855904483] 'read index received'  (duration: 425.969346ms)","trace[855904483] 'applied index is now lower than readState.Index'  (duration: 131.421µs)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:50:58.710737Z","caller":"traceutil/trace.go:171","msg":"trace[284984704] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"433.670501ms","start":"2026-02-09T18:50:58.277061Z","end":"2026-02-09T18:50:58.710731Z","steps":["trace[284984704] 'process raft request'  (duration: 433.368159ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:50:58.711046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:50:58.277025Z","time spent":"433.726901ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:470 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-09T18:50:58.71117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.751113ms","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-09T18:50:58.711191Z","caller":"traceutil/trace.go:171","msg":"trace[439423795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"426.785813ms","start":"2026-02-09T18:50:58.284399Z","end":"2026-02-09T18:50:58.711185Z","steps":["trace[439423795] 'agreement among raft nodes before linearized reading'  (duration: 426.751042ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:50:58.711206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:50:58.28439Z","time spent":"426.811713ms","remote":"127.0.0.1:43164","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-09T18:50:58.711284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.273846ms","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-09T18:50:58.711296Z","caller":"traceutil/trace.go:171","msg":"trace[1724874884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:508; }","duration":"330.308528ms","start":"2026-02-09T18:50:58.380984Z","end":"2026-02-09T18:50:58.711292Z","steps":["trace[1724874884] 'agreement among raft nodes before linearized reading'  (duration: 330.285747ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:50:58.711308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:50:58.380972Z","time spent":"330.333088ms","remote":"127.0.0.1:43164","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-09T18:50:58.711398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.293063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:50:58.71141Z","caller":"traceutil/trace.go:171","msg":"trace[748969649] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"143.328403ms","start":"2026-02-09T18:50:58.568078Z","end":"2026-02-09T18:50:58.711406Z","steps":["trace[748969649] 'agreement among raft nodes before linearized reading'  (duration: 143.309513ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:02.207103Z","caller":"traceutil/trace.go:171","msg":"trace[1454680807] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"135.837974ms","start":"2026-02-09T18:51:02.071247Z","end":"2026-02-09T18:51:02.207085Z","steps":["trace[1454680807] 'process raft request'  (duration: 135.751253ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:02.892857Z","caller":"traceutil/trace.go:171","msg":"trace[1964606783] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:566; }","duration":"167.895233ms","start":"2026-02-09T18:51:02.724949Z","end":"2026-02-09T18:51:02.892844Z","steps":["trace[1964606783] 'read index received'  (duration: 166.24085ms)","trace[1964606783] 'applied index is now lower than readState.Index'  (duration: 1.653453ms)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:51:02.893026Z","caller":"traceutil/trace.go:171","msg":"trace[2027466865] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"209.422908ms","start":"2026-02-09T18:51:02.683592Z","end":"2026-02-09T18:51:02.893015Z","steps":["trace[2027466865] 'process raft request'  (duration: 207.662553ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:02.894884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.815507ms","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-09T18:51:02.895493Z","caller":"traceutil/trace.go:171","msg":"trace[850729875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:555; }","duration":"166.444652ms","start":"2026-02-09T18:51:02.729037Z","end":"2026-02-09T18:51:02.895482Z","steps":["trace[850729875] 'agreement among raft nodes before linearized reading'  (duration: 165.788216ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:02.893095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.144115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-02-09T18:51:02.893122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.207595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-09T18:51:02.896017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.87237ms","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-09T18:51:02.896272Z","caller":"traceutil/trace.go:171","msg":"trace[549266691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:555; }","duration":"164.166493ms","start":"2026-02-09T18:51:02.732083Z","end":"2026-02-09T18:51:02.89625Z","steps":["trace[549266691] 'agreement among raft nodes before linearized reading'  (duration: 163.86425ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:02.896453Z","caller":"traceutil/trace.go:171","msg":"trace[225275226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:555; }","duration":"171.541272ms","start":"2026-02-09T18:51:02.724904Z","end":"2026-02-09T18:51:02.896446Z","steps":["trace[225275226] 'agreement among raft nodes before linearized reading'  (duration: 168.162265ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:02.896563Z","caller":"traceutil/trace.go:171","msg":"trace[844129231] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:555; }","duration":"171.670923ms","start":"2026-02-09T18:51:02.724885Z","end":"2026-02-09T18:51:02.896556Z","steps":["trace[844129231] 'agreement among raft nodes before linearized reading'  (duration: 168.225355ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:03.801066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.141316ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:51:03.801165Z","caller":"traceutil/trace.go:171","msg":"trace[1249992525] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:582; }","duration":"103.249117ms","start":"2026-02-09T18:51:03.697903Z","end":"2026-02-09T18:51:03.801152Z","steps":["trace[1249992525] 'range keys from in-memory index tree'  (duration: 103.130026ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:03.801954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.046649ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576313785502396619 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.95\" mod_revision:464 > success:<request_put:<key:\"/registry/masterleases/199.204.45.95\" value_size:66 lease:8352941748647620809 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.95\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-09T18:51:03.801995Z","caller":"traceutil/trace.go:171","msg":"trace[67155764] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"136.2035ms","start":"2026-02-09T18:51:03.665784Z","end":"2026-02-09T18:51:03.801988Z","steps":["trace[67155764] 'read index received'  (duration: 25.00889ms)","trace[67155764] 'applied index is now lower than readState.Index'  (duration: 111.19381ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:51:03.802052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.266481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"info","ts":"2026-02-09T18:51:03.802069Z","caller":"traceutil/trace.go:171","msg":"trace[1911670241] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:583; }","duration":"136.310562ms","start":"2026-02-09T18:51:03.665752Z","end":"2026-02-09T18:51:03.802063Z","steps":["trace[1911670241] 'agreement among raft nodes before linearized reading'  (duration: 136.257291ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:03.802201Z","caller":"traceutil/trace.go:171","msg":"trace[837239548] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"214.365827ms","start":"2026-02-09T18:51:03.587828Z","end":"2026-02-09T18:51:03.802194Z","steps":["trace[837239548] 'process raft request'  (duration: 102.933095ms)","trace[837239548] 'compare'  (duration: 110.663776ms)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:51:05.366992Z","caller":"traceutil/trace.go:171","msg":"trace[34702316] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"128.064485ms","start":"2026-02-09T18:51:05.238913Z","end":"2026-02-09T18:51:05.366977Z","steps":["trace[34702316] 'process raft request'  (duration: 127.930884ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:05.368811Z","caller":"traceutil/trace.go:171","msg":"trace[1990715373] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:602; }","duration":"110.102843ms","start":"2026-02-09T18:51:05.258696Z","end":"2026-02-09T18:51:05.368799Z","steps":["trace[1990715373] 'read index received'  (duration: 108.119187ms)","trace[1990715373] 'applied index is now lower than readState.Index'  (duration: 1.983206ms)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:51:05.368978Z","caller":"traceutil/trace.go:171","msg":"trace[1766734576] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"110.333125ms","start":"2026-02-09T18:51:05.258639Z","end":"2026-02-09T18:51:05.368972Z","steps":["trace[1766734576] 'process raft request'  (duration: 109.848032ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:05.369359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.649757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-02-09T18:51:05.369377Z","caller":"traceutil/trace.go:171","msg":"trace[579014307] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:591; }","duration":"110.692217ms","start":"2026-02-09T18:51:05.258679Z","end":"2026-02-09T18:51:05.369371Z","steps":["trace[579014307] 'agreement among raft nodes before linearized reading'  (duration: 110.620167ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:09.123846Z","caller":"traceutil/trace.go:171","msg":"trace[818868666] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"169.630179ms","start":"2026-02-09T18:51:08.954202Z","end":"2026-02-09T18:51:09.123832Z","steps":["trace[818868666] 'read index received'  (duration: 168.062877ms)","trace[818868666] 'applied index is now lower than readState.Index'  (duration: 1.566502ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:51:09.124011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.33717ms","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-09T18:51:09.124033Z","caller":"traceutil/trace.go:171","msg":"trace[940511869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:602; }","duration":"145.39183ms","start":"2026-02-09T18:51:08.978636Z","end":"2026-02-09T18:51:09.124027Z","steps":["trace[940511869] 'agreement among raft nodes before linearized reading'  (duration: 145.34486ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:09.124237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.540705ms","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-09T18:51:09.124252Z","caller":"traceutil/trace.go:171","msg":"trace[1609249406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"143.594856ms","start":"2026-02-09T18:51:08.980653Z","end":"2026-02-09T18:51:09.124248Z","steps":["trace[1609249406] 'agreement among raft nodes before linearized reading'  (duration: 143.565815ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:09.124429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.764899ms","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-09T18:51:09.124458Z","caller":"traceutil/trace.go:171","msg":"trace[1124728032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:602; }","duration":"170.281013ms","start":"2026-02-09T18:51:08.954172Z","end":"2026-02-09T18:51:09.124453Z","steps":["trace[1124728032] 'agreement among raft nodes before linearized reading'  (duration: 169.757119ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:11.247717Z","caller":"traceutil/trace.go:171","msg":"trace[383527624] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"112.835498ms","start":"2026-02-09T18:51:11.134858Z","end":"2026-02-09T18:51:11.247694Z","steps":["trace[383527624] 'process raft request'  (duration: 112.698097ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:11.445879Z","caller":"traceutil/trace.go:171","msg":"trace[520953391] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"130.950367ms","start":"2026-02-09T18:51:11.314911Z","end":"2026-02-09T18:51:11.445862Z","steps":["trace[520953391] 'read index received'  (duration: 130.800376ms)","trace[520953391] 'applied index is now lower than readState.Index'  (duration: 149.311µs)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:51:11.445945Z","caller":"traceutil/trace.go:171","msg":"trace[1390596078] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"310.988653ms","start":"2026-02-09T18:51:11.134934Z","end":"2026-02-09T18:51:11.445923Z","steps":["trace[1390596078] 'process raft request'  (duration: 310.783111ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:11.445996Z","caller":"traceutil/trace.go:171","msg":"trace[1836179140] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"309.693373ms","start":"2026-02-09T18:51:11.136295Z","end":"2026-02-09T18:51:11.445988Z","steps":["trace[1836179140] 'process raft request'  (duration: 309.543932ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:11.446074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:51:11.134929Z","time spent":"311.072653ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:603 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-09T18:51:11.446099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:51:11.136289Z","time spent":"309.742013ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:604 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-09T18:51:11.446337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.423101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-szxgq\" ","response":"range_response_count:1 size:16652"}
{"level":"info","ts":"2026-02-09T18:51:11.446362Z","caller":"traceutil/trace.go:171","msg":"trace[1976918696] range","detail":"{range_begin:/registry/pods/kube-system/cilium-szxgq; range_end:; response_count:1; response_revision:613; }","duration":"131.470342ms","start":"2026-02-09T18:51:11.314884Z","end":"2026-02-09T18:51:11.446355Z","steps":["trace[1976918696] 'agreement among raft nodes before linearized reading'  (duration: 131.383951ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:11.754546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.303018ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576313785502396725 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:606 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-09T18:51:11.754649Z","caller":"traceutil/trace.go:171","msg":"trace[2138271837] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"300.213139ms","start":"2026-02-09T18:51:11.45442Z","end":"2026-02-09T18:51:11.754633Z","steps":["trace[2138271837] 'process raft request'  (duration: 16.737389ms)","trace[2138271837] 'compare'  (duration: 282.759385ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:51:11.754726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:51:11.454405Z","time spent":"300.289799ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:606 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-09T18:51:12.066379Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502396724,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:51:12.472931Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.001933111s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-09T18:51:13.042115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.939785ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576313785502396726 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-szxgq\" mod_revision:504 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-szxgq\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-szxgq\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-09T18:51:13.042202Z","caller":"traceutil/trace.go:171","msg":"trace[2127079097] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"1.47661774s","start":"2026-02-09T18:51:11.565568Z","end":"2026-02-09T18:51:13.042186Z","steps":["trace[2127079097] 'read index received'  (duration: 907.511704ms)","trace[2127079097] 'applied index is now lower than readState.Index'  (duration: 569.104896ms)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:51:13.042397Z","caller":"traceutil/trace.go:171","msg":"trace[1540561535] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.576478179s","start":"2026-02-09T18:51:11.465908Z","end":"2026-02-09T18:51:13.042386Z","steps":["trace[1540561535] 'process raft request'  (duration: 1.007184091s)","trace[1540561535] 'compare'  (duration: 568.483382ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:51:13.042455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:51:11.465891Z","time spent":"1.576534919s","remote":"127.0.0.1:43062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-szxgq\" mod_revision:504 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-szxgq\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-szxgq\" > >"}
{"level":"warn","ts":"2026-02-09T18:51:13.042612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.477041013s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:51:13.042639Z","caller":"traceutil/trace.go:171","msg":"trace[647326407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"1.477088104s","start":"2026-02-09T18:51:11.565542Z","end":"2026-02-09T18:51:13.04263Z","steps":["trace[647326407] 'agreement among raft nodes before linearized reading'  (duration: 1.477042613s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:13.042664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:51:11.565527Z","time spent":"1.477131734s","remote":"127.0.0.1:42850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-09T18:51:13.042806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.474647255s","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-09T18:51:13.042832Z","caller":"traceutil/trace.go:171","msg":"trace[1614997193] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:615; }","duration":"1.474687785s","start":"2026-02-09T18:51:11.568137Z","end":"2026-02-09T18:51:13.042825Z","steps":["trace[1614997193] 'agreement among raft nodes before linearized reading'  (duration: 1.474636505s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:51:13.042857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:51:11.568127Z","time spent":"1.474724955s","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-09T18:51:17.64067Z","caller":"traceutil/trace.go:171","msg":"trace[1544409430] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"158.294427ms","start":"2026-02-09T18:51:17.482326Z","end":"2026-02-09T18:51:17.64062Z","steps":["trace[1544409430] 'process raft request'  (duration: 157.707532ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:51:17.642587Z","caller":"traceutil/trace.go:171","msg":"trace[1173311207] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"159.486736ms","start":"2026-02-09T18:51:17.483086Z","end":"2026-02-09T18:51:17.642573Z","steps":["trace[1173311207] 'process raft request'  (duration: 159.389695ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:37.668967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.336702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:52:37.669052Z","caller":"traceutil/trace.go:171","msg":"trace[691187877] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1000; }","duration":"317.487724ms","start":"2026-02-09T18:52:37.351545Z","end":"2026-02-09T18:52:37.669033Z","steps":["trace[691187877] 'count revisions from in-memory index tree'  (duration: 317.22907ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:37.669099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:52:37.351524Z","time spent":"317.563135ms","remote":"127.0.0.1:57430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"warn","ts":"2026-02-09T18:52:37.669517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.91089ms","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-09T18:52:37.669552Z","caller":"traceutil/trace.go:171","msg":"trace[388488553] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1000; }","duration":"249.9679ms","start":"2026-02-09T18:52:37.419572Z","end":"2026-02-09T18:52:37.66954Z","steps":["trace[388488553] 'count revisions from in-memory index tree'  (duration: 249.847979ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:52:37.676217Z","caller":"traceutil/trace.go:171","msg":"trace[1676591103] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"177.275077ms","start":"2026-02-09T18:52:37.498931Z","end":"2026-02-09T18:52:37.676206Z","steps":["trace[1676591103] 'process raft request'  (duration: 138.40281ms)","trace[1676591103] 'compare'  (duration: 32.932753ms)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:52:37.676436Z","caller":"traceutil/trace.go:171","msg":"trace[787392195] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"146.14986ms","start":"2026-02-09T18:52:37.524308Z","end":"2026-02-09T18:52:37.670458Z","steps":["trace[787392195] 'read index received'  (duration: 112.972283ms)","trace[787392195] 'applied index is now lower than readState.Index'  (duration: 33.176537ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:52:37.676711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.387178ms","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-09T18:52:37.676808Z","caller":"traceutil/trace.go:171","msg":"trace[1929389305] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1001; }","duration":"152.519191ms","start":"2026-02-09T18:52:37.524281Z","end":"2026-02-09T18:52:37.6768Z","steps":["trace[1929389305] 'agreement among raft nodes before linearized reading'  (duration: 152.206666ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:52:38.133152Z","caller":"traceutil/trace.go:171","msg":"trace[1888267960] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"436.820665ms","start":"2026-02-09T18:52:37.696308Z","end":"2026-02-09T18:52:38.133129Z","steps":["trace[1888267960] 'process raft request'  (duration: 436.677633ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:38.133407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:52:37.696298Z","time spent":"436.918486ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:995 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-09T18:52:38.134017Z","caller":"traceutil/trace.go:171","msg":"trace[107969151] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1037; }","duration":"279.913386ms","start":"2026-02-09T18:52:37.854079Z","end":"2026-02-09T18:52:38.133992Z","steps":["trace[107969151] 'read index received'  (duration: 279.903086ms)","trace[107969151] 'applied index is now lower than readState.Index'  (duration: 8.81µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:52:38.134286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.18626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-09T18:52:38.13435Z","caller":"traceutil/trace.go:171","msg":"trace[698831372] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1003; }","duration":"280.299181ms","start":"2026-02-09T18:52:37.854042Z","end":"2026-02-09T18:52:38.134341Z","steps":["trace[698831372] 'agreement among raft nodes before linearized reading'  (duration: 280.178049ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:38.378631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.557573ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576313785502397653 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:969 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-09T18:52:38.37872Z","caller":"traceutil/trace.go:171","msg":"trace[1660528934] linearizableReadLoop","detail":"{readStateIndex:1038; appliedIndex:1037; }","duration":"244.51356ms","start":"2026-02-09T18:52:38.134191Z","end":"2026-02-09T18:52:38.378705Z","steps":["trace[1660528934] 'read index received'  (duration: 35.737624ms)","trace[1660528934] 'applied index is now lower than readState.Index'  (duration: 208.774786ms)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:52:38.37922Z","caller":"traceutil/trace.go:171","msg":"trace[1049277810] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"337.611514ms","start":"2026-02-09T18:52:38.041591Z","end":"2026-02-09T18:52:38.379202Z","steps":["trace[1049277810] 'process raft request'  (duration: 128.394731ms)","trace[1049277810] 'compare'  (duration: 208.3292ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:52:38.379507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:52:38.041566Z","time spent":"337.904209ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:969 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-09T18:52:38.379833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.291626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-09T18:52:38.37987Z","caller":"traceutil/trace.go:171","msg":"trace[921857715] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1004; }","duration":"291.369878ms","start":"2026-02-09T18:52:38.088491Z","end":"2026-02-09T18:52:38.379861Z","steps":["trace[921857715] 'agreement among raft nodes before linearized reading'  (duration: 291.301497ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:38.380179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.234819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:52:38.380213Z","caller":"traceutil/trace.go:171","msg":"trace[1250706259] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1004; }","duration":"317.300009ms","start":"2026-02-09T18:52:38.062905Z","end":"2026-02-09T18:52:38.380205Z","steps":["trace[1250706259] 'agreement among raft nodes before linearized reading'  (duration: 317.245238ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:38.38024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:52:38.062882Z","time spent":"317.350631ms","remote":"127.0.0.1:43026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/test-pv\" "}
{"level":"warn","ts":"2026-02-09T18:52:38.380619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.414438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-09T18:52:38.380653Z","caller":"traceutil/trace.go:171","msg":"trace[1298600862] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1004; }","duration":"200.489779ms","start":"2026-02-09T18:52:38.180155Z","end":"2026-02-09T18:52:38.380645Z","steps":["trace[1298600862] 'agreement among raft nodes before linearized reading'  (duration: 200.433018ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:38.381074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.378306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-02-09T18:52:38.381111Z","caller":"traceutil/trace.go:171","msg":"trace[1332265947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1004; }","duration":"178.428857ms","start":"2026-02-09T18:52:38.202673Z","end":"2026-02-09T18:52:38.381102Z","steps":["trace[1332265947] 'agreement among raft nodes before linearized reading'  (duration: 178.315085ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:38.381441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.694466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-09T18:52:38.381499Z","caller":"traceutil/trace.go:171","msg":"trace[292422923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1004; }","duration":"179.775218ms","start":"2026-02-09T18:52:38.201708Z","end":"2026-02-09T18:52:38.381483Z","steps":["trace[292422923] 'agreement among raft nodes before linearized reading'  (duration: 179.635385ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:38.38225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.817707ms","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-09T18:52:38.382321Z","caller":"traceutil/trace.go:171","msg":"trace[1141738577] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1004; }","duration":"186.925308ms","start":"2026-02-09T18:52:38.195377Z","end":"2026-02-09T18:52:38.382303Z","steps":["trace[1141738577] 'agreement among raft nodes before linearized reading'  (duration: 186.513131ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:38.891437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.680838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:52:38.891525Z","caller":"traceutil/trace.go:171","msg":"trace[930230309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1007; }","duration":"321.82503ms","start":"2026-02-09T18:52:38.569683Z","end":"2026-02-09T18:52:38.891508Z","steps":["trace[930230309] 'range keys from in-memory index tree'  (duration: 321.561105ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:52:38.891569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:52:38.569665Z","time spent":"321.894952ms","remote":"127.0.0.1:42850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-09T18:53:04.928046Z","caller":"traceutil/trace.go:171","msg":"trace[1580518048] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"380.106089ms","start":"2026-02-09T18:53:04.54791Z","end":"2026-02-09T18:53:04.928016Z","steps":["trace[1580518048] 'process raft request'  (duration: 379.976838ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:04.928256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:04.547902Z","time spent":"380.227131ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1075 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-09T18:53:04.928581Z","caller":"traceutil/trace.go:171","msg":"trace[2059905893] linearizableReadLoop","detail":"{readStateIndex:1121; appliedIndex:1120; }","duration":"350.022685ms","start":"2026-02-09T18:53:04.578529Z","end":"2026-02-09T18:53:04.928552Z","steps":["trace[2059905893] 'read index received'  (duration: 349.283386ms)","trace[2059905893] 'applied index is now lower than readState.Index'  (duration: 735.819µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:53:04.929001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.453501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/kubeadm-certs\" ","response":"range_response_count:1 size:11455"}
{"level":"info","ts":"2026-02-09T18:53:04.929742Z","caller":"traceutil/trace.go:171","msg":"trace[940612997] range","detail":"{range_begin:/registry/secrets/kube-system/kubeadm-certs; range_end:; response_count:1; response_revision:1081; }","duration":"351.16893ms","start":"2026-02-09T18:53:04.578519Z","end":"2026-02-09T18:53:04.929688Z","steps":["trace[940612997] 'agreement among raft nodes before linearized reading'  (duration: 350.39664ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:04.929913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:04.578485Z","time spent":"351.367522ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":11479,"request content":"key:\"/registry/secrets/kube-system/kubeadm-certs\" "}
{"level":"warn","ts":"2026-02-09T18:53:04.929337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.041668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" ","response":"range_response_count:1 size:317274"}
{"level":"info","ts":"2026-02-09T18:53:04.930016Z","caller":"traceutil/trace.go:171","msg":"trace[320875769] range","detail":"{range_begin:/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1; range_end:; response_count:1; response_revision:1081; }","duration":"339.736516ms","start":"2026-02-09T18:53:04.590269Z","end":"2026-02-09T18:53:04.930005Z","steps":["trace[320875769] 'agreement among raft nodes before linearized reading'  (duration: 338.747844ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:04.930116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:04.590264Z","time spent":"339.781217ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":317298,"request content":"key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" "}
{"level":"warn","ts":"2026-02-09T18:53:04.929484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.908017ms","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-09T18:53:04.930603Z","caller":"traceutil/trace.go:171","msg":"trace[1587481823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1081; }","duration":"305.049332ms","start":"2026-02-09T18:53:04.625542Z","end":"2026-02-09T18:53:04.930591Z","steps":["trace[1587481823] 'agreement among raft nodes before linearized reading'  (duration: 303.852135ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:04.930697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:04.625527Z","time spent":"305.157503ms","remote":"127.0.0.1:43164","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-09T18:53:04.929585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.526834ms","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-09T18:53:04.931007Z","caller":"traceutil/trace.go:171","msg":"trace[774611618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1081; }","duration":"331.965353ms","start":"2026-02-09T18:53:04.599031Z","end":"2026-02-09T18:53:04.930996Z","steps":["trace[774611618] 'agreement among raft nodes before linearized reading'  (duration: 330.472023ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:04.931086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:04.59902Z","time spent":"332.052674ms","remote":"127.0.0.1:43164","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-09T18:53:06.067833Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:06.568871Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:07.068998Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:07.567373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000295901s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-09T18:53:07.567588Z","caller":"traceutil/trace.go:171","msg":"trace[63281097] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000482263s","start":"2026-02-09T18:53:05.567017Z","end":"2026-02-09T18:53:07.567499Z","steps":["trace[63281097] 'agreement among raft nodes before linearized reading'  (duration: 2.000317281s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:07.568278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:05.567003Z","time spent":"2.001230783s","remote":"127.0.0.1:42850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/09 18:53:07 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-09T18:53:07.569677Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:08.070343Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:08.570864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:09.071832Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:09.568926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000315032s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-09T18:53:09.569003Z","caller":"traceutil/trace.go:171","msg":"trace[859934068] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000541785s","start":"2026-02-09T18:53:07.568444Z","end":"2026-02-09T18:53:09.568986Z","steps":["trace[859934068] 'agreement among raft nodes before linearized reading'  (duration: 2.000445534s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:09.569051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:07.568307Z","time spent":"2.000734398s","remote":"127.0.0.1:42866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/09 18:53:09 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-09T18:53:09.57205Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:10.072869Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:10.573759Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:10.874287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.001337068s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-09T18:53:10.874364Z","caller":"traceutil/trace.go:171","msg":"trace[410334289] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.00146308s","start":"2026-02-09T18:53:05.872882Z","end":"2026-02-09T18:53:10.874346Z","steps":["trace[410334289] 'agreement among raft nodes before linearized reading'  (duration: 5.001364089s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:10.876104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:05.872865Z","time spent":"5.003159442s","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/09 18:53:10 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-09T18:53:11.074388Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:11.269152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.99990681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-09T18:53:11.269634Z","caller":"traceutil/trace.go:171","msg":"trace[199910036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000441786s","start":"2026-02-09T18:53:06.26917Z","end":"2026-02-09T18:53:11.269612Z","steps":["trace[199910036] 'agreement among raft nodes before linearized reading'  (duration: 4.99993348s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:11.269953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:06.269152Z","time spent":"5.000782691s","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/02/09 18:53:11 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-09T18:53:11.575043Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:11.577273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000217481s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-09T18:53:11.577368Z","caller":"traceutil/trace.go:171","msg":"trace[850687841] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000354134s","start":"2026-02-09T18:53:09.576998Z","end":"2026-02-09T18:53:11.577352Z","steps":["trace[850687841] 'agreement among raft nodes before linearized reading'  (duration: 2.000239512s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:11.577616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:09.576987Z","time spent":"2.000584087s","remote":"127.0.0.1:42850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-09T18:53:11.936798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999121118s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-09T18:53:11.936889Z","caller":"traceutil/trace.go:171","msg":"trace[174377672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.99926716s","start":"2026-02-09T18:53:06.937602Z","end":"2026-02-09T18:53:11.936869Z","steps":["trace[174377672] 'agreement among raft nodes before linearized reading'  (duration: 4.999151289s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:11.937937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:06.937582Z","time spent":"4.999412062s","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/02/09 18:53:11 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-09T18:53:12.075668Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398577,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:12.430872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:05.4302Z","time spent":"7.000665345s","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-09T18:53:12.567836Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"}
{"level":"warn","ts":"2026-02-09T18:53:13.069865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576313785502398583,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-09T18:53:13.309162Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"6.543732342s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-09T18:53:13.396651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.368348604s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"}
{"level":"info","ts":"2026-02-09T18:53:13.396778Z","caller":"traceutil/trace.go:171","msg":"trace[584034731] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1083; }","duration":"8.368499175s","start":"2026-02-09T18:53:05.028251Z","end":"2026-02-09T18:53:13.39675Z","steps":["trace[584034731] 'range keys from in-memory index tree'  (duration: 8.368236173s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.397261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:05.028241Z","time spent":"8.368597496s","remote":"127.0.0.1:43082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" "}
{"level":"warn","ts":"2026-02-09T18:53:13.397451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.250153734s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:53:13.397615Z","caller":"traceutil/trace.go:171","msg":"trace[1469194633] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1083; }","duration":"8.250314256s","start":"2026-02-09T18:53:05.147252Z","end":"2026-02-09T18:53:13.397566Z","steps":["trace[1469194633] 'count revisions from in-memory index tree'  (duration: 8.250064413s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.397744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:05.147237Z","time spent":"8.250486628s","remote":"127.0.0.1:43228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "}
{"level":"warn","ts":"2026-02-09T18:53:13.398231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.333988043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" ","response":"range_response_count:1 size:317274"}
{"level":"info","ts":"2026-02-09T18:53:13.398276Z","caller":"traceutil/trace.go:171","msg":"trace[418868994] range","detail":"{range_begin:/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1; range_end:; response_count:1; response_revision:1083; }","duration":"8.334050194s","start":"2026-02-09T18:53:05.064215Z","end":"2026-02-09T18:53:13.398265Z","steps":["trace[418868994] 'range keys from in-memory index tree'  (duration: 8.333063351s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.398618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:05.064205Z","time spent":"8.334391468s","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":317298,"request content":"key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" "}
{"level":"warn","ts":"2026-02-09T18:53:13.411613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.112904ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576313785502398578 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1056 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<>>","response":"size:16"}
{"level":"warn","ts":"2026-02-09T18:53:13.579656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000921157s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-09T18:53:13.579748Z","caller":"traceutil/trace.go:171","msg":"trace[1473762987] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00106384s","start":"2026-02-09T18:53:11.578663Z","end":"2026-02-09T18:53:13.579727Z","steps":["trace[1473762987] 'agreement among raft nodes before linearized reading'  (duration: 2.000952148s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.579814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:11.578644Z","time spent":"2.001160261s","remote":"127.0.0.1:42866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-09T18:53:13.67183Z","caller":"traceutil/trace.go:171","msg":"trace[1715277841] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"5.168550234s","start":"2026-02-09T18:53:08.503257Z","end":"2026-02-09T18:53:13.671807Z","steps":["trace[1715277841] 'process raft request'  (duration: 5.168028378s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.672118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:08.50323Z","time spent":"5.168719656s","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1064 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-09T18:53:13.691629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.165450792s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:53:13.691736Z","caller":"traceutil/trace.go:171","msg":"trace[1151964642] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1086; }","duration":"2.165605163s","start":"2026-02-09T18:53:11.526114Z","end":"2026-02-09T18:53:13.691719Z","steps":["trace[1151964642] 'agreement among raft nodes before linearized reading'  (duration: 2.165420661s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.692121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:11.526095Z","time spent":"2.166012658s","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"info","ts":"2026-02-09T18:53:13.692389Z","caller":"traceutil/trace.go:171","msg":"trace[1597694059] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"4.120384306s","start":"2026-02-09T18:53:09.571995Z","end":"2026-02-09T18:53:13.692379Z","steps":["trace[1597694059] 'process raft request'  (duration: 4.118957668s)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:53:13.692497Z","caller":"traceutil/trace.go:171","msg":"trace[786155822] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1123; }","duration":"1.123319562s","start":"2026-02-09T18:53:12.567924Z","end":"2026-02-09T18:53:13.691244Z","steps":["trace[786155822] 'read index received'  (duration: 741.539669ms)","trace[786155822] 'applied index is now lower than readState.Index'  (duration: 381.779273ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:53:13.692467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:09.571976Z","time spent":"4.120460107s","remote":"127.0.0.1:42948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.1892a8ca1f266a44\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.1892a8ca1f266a44\" value_size:672 lease:8352941748647621632 >> failure:<>"}
{"level":"warn","ts":"2026-02-09T18:53:13.692774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.426007955s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-09T18:53:13.692978Z","caller":"traceutil/trace.go:171","msg":"trace[1690868299] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1086; }","duration":"1.257305833s","start":"2026-02-09T18:53:12.435666Z","end":"2026-02-09T18:53:13.692971Z","steps":["trace[1690868299] 'process raft request'  (duration: 1.255549131s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.693098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:12.435646Z","time spent":"1.257425274s","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":722,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1056 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-09T18:53:13.693302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.743881185s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-09T18:53:13.693348Z","caller":"traceutil/trace.go:171","msg":"trace[1605471946] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1086; }","duration":"5.743963576s","start":"2026-02-09T18:53:07.949377Z","end":"2026-02-09T18:53:13.69334Z","steps":["trace[1605471946] 'agreement among raft nodes before linearized reading'  (duration: 5.743787913s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.693529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:07.949357Z","time spent":"5.744162268s","remote":"127.0.0.1:43410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "}
{"level":"info","ts":"2026-02-09T18:53:13.692936Z","caller":"traceutil/trace.go:171","msg":"trace[1339911311] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1086; }","duration":"2.426204647s","start":"2026-02-09T18:53:11.266722Z","end":"2026-02-09T18:53:13.692927Z","steps":["trace[1339911311] 'agreement among raft nodes before linearized reading'  (duration: 2.425883793s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.694169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:11.266702Z","time spent":"2.427456224s","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":121,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-09T18:53:13.694333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.681414273s","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-09T18:53:13.694414Z","caller":"traceutil/trace.go:171","msg":"trace[1423464868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1086; }","duration":"6.681494594s","start":"2026-02-09T18:53:07.012911Z","end":"2026-02-09T18:53:13.694406Z","steps":["trace[1423464868] 'agreement among raft nodes before linearized reading'  (duration: 6.68116933s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.694609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:07.012876Z","time spent":"6.681723926s","remote":"127.0.0.1:43164","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-09T18:53:13.693152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.596644392s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-09T18:53:13.694905Z","caller":"traceutil/trace.go:171","msg":"trace[1117830124] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1086; }","duration":"5.598528746s","start":"2026-02-09T18:53:08.096367Z","end":"2026-02-09T18:53:13.694896Z","steps":["trace[1117830124] 'agreement among raft nodes before linearized reading'  (duration: 5.596660132s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.695007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:08.096349Z","time spent":"5.598647068s","remote":"127.0.0.1:43348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-02-09T18:53:13.695664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.694442744s","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-09T18:53:13.695709Z","caller":"traceutil/trace.go:171","msg":"trace[1541603524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1086; }","duration":"6.694524565s","start":"2026-02-09T18:53:07.001178Z","end":"2026-02-09T18:53:13.695702Z","steps":["trace[1541603524] 'agreement among raft nodes before linearized reading'  (duration: 6.693874087s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.695746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:07.001138Z","time spent":"6.694601016s","remote":"127.0.0.1:43164","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-09T18:53:13.696035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043907786s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:53:13.696094Z","caller":"traceutil/trace.go:171","msg":"trace[1979469170] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1086; }","duration":"1.044031907s","start":"2026-02-09T18:53:12.652053Z","end":"2026-02-09T18:53:13.696085Z","steps":["trace[1979469170] 'agreement among raft nodes before linearized reading'  (duration: 1.043929346s)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.69623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:12.652025Z","time spent":"1.044160428s","remote":"127.0.0.1:57492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-02-09T18:53:13.697424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.9112ms","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-09T18:53:13.697469Z","caller":"traceutil/trace.go:171","msg":"trace[1787513206] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1086; }","duration":"820.004641ms","start":"2026-02-09T18:53:12.877454Z","end":"2026-02-09T18:53:13.697459Z","steps":["trace[1787513206] 'agreement among raft nodes before linearized reading'  (duration: 819.88009ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.697493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:12.877434Z","time spent":"820.054772ms","remote":"127.0.0.1:43164","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-09T18:53:13.69756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.431583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-09T18:53:13.697574Z","caller":"traceutil/trace.go:171","msg":"trace[1494174969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1086; }","duration":"114.471424ms","start":"2026-02-09T18:53:13.583097Z","end":"2026-02-09T18:53:13.697568Z","steps":["trace[1494174969] 'agreement among raft nodes before linearized reading'  (duration: 114.450243ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.697661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.473916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"}
{"level":"info","ts":"2026-02-09T18:53:13.697679Z","caller":"traceutil/trace.go:171","msg":"trace[334032571] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1086; }","duration":"202.491936ms","start":"2026-02-09T18:53:13.495182Z","end":"2026-02-09T18:53:13.697674Z","steps":["trace[334032571] 'agreement among raft nodes before linearized reading'  (duration: 202.460116ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.697955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.670211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1\" ","response":"range_response_count:1 size:317274"}
{"level":"info","ts":"2026-02-09T18:53:13.697978Z","caller":"traceutil/trace.go:171","msg":"trace[2092268341] range","detail":"{range_begin:/registry/secrets/kube-system/sh.helm.release.v1.cilium.v1; range_end:; response_count:1; response_revision:1086; }","duration":"259.733542ms","start":"2026-02-09T18:53:13.438239Z","end":"2026-02-09T18:53:13.697972Z","steps":["trace[2092268341] 'agreement among raft nodes before linearized reading'  (duration: 259.510929ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.698192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.153817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-09T18:53:13.698213Z","caller":"traceutil/trace.go:171","msg":"trace[163187833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1086; }","duration":"427.206578ms","start":"2026-02-09T18:53:13.270999Z","end":"2026-02-09T18:53:13.698206Z","steps":["trace[163187833] 'agreement among raft nodes before linearized reading'  (duration: 427.162107ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:13.698234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:13.270979Z","time spent":"427.249978ms","remote":"127.0.0.1:43164","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-09T18:53:13.704176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.736696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.95\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-09T18:53:13.704297Z","caller":"traceutil/trace.go:171","msg":"trace[1840395539] range","detail":"{range_begin:/registry/masterleases/199.204.45.95; range_end:; response_count:1; response_revision:1086; }","duration":"117.912958ms","start":"2026-02-09T18:53:13.586375Z","end":"2026-02-09T18:53:13.704288Z","steps":["trace[1840395539] 'agreement among raft nodes before linearized reading'  (duration: 110.482783ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:53:14.016625Z","caller":"traceutil/trace.go:171","msg":"trace[1046582891] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1129; }","duration":"309.30159ms","start":"2026-02-09T18:53:13.707299Z","end":"2026-02-09T18:53:14.016601Z","steps":["trace[1046582891] 'read index received'  (duration: 30.171188ms)","trace[1046582891] 'applied index is now lower than readState.Index'  (duration: 279.129302ms)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:53:14.016778Z","caller":"traceutil/trace.go:171","msg":"trace[305025007] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"309.704186ms","start":"2026-02-09T18:53:13.707062Z","end":"2026-02-09T18:53:14.016766Z","steps":["trace[305025007] 'process raft request'  (duration: 277.534953ms)","trace[305025007] 'compare'  (duration: 31.515985ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:53:14.016859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:13.707043Z","time spent":"309.761826ms","remote":"127.0.0.1:42948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.1892a8ca434017fb\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.1892a8ca434017fb\" value_size:671 lease:8352941748647621632 >> failure:<>"}
{"level":"warn","ts":"2026-02-09T18:53:14.017057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:13.707573Z","time spent":"309.481512ms","remote":"127.0.0.1:42894","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-09T18:53:14.017296Z","caller":"traceutil/trace.go:171","msg":"trace[1079893895] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"309.627433ms","start":"2026-02-09T18:53:13.707658Z","end":"2026-02-09T18:53:14.017286Z","steps":["trace[1079893895] 'process raft request'  (duration: 308.739272ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:14.01736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:13.70765Z","time spent":"309.669295ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1079 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-09T18:53:14.017483Z","caller":"traceutil/trace.go:171","msg":"trace[8412475] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"308.989016ms","start":"2026-02-09T18:53:13.708483Z","end":"2026-02-09T18:53:14.017472Z","steps":["trace[8412475] 'process raft request'  (duration: 308.032934ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:14.017528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:13.708379Z","time spent":"309.124358ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1083 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-09T18:53:14.017649Z","caller":"traceutil/trace.go:171","msg":"trace[1277454138] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"289.256482ms","start":"2026-02-09T18:53:13.728384Z","end":"2026-02-09T18:53:14.017641Z","steps":["trace[1277454138] 'process raft request'  (duration: 288.176198ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:14.018088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.779329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:1 size:687"}
{"level":"info","ts":"2026-02-09T18:53:14.018131Z","caller":"traceutil/trace.go:171","msg":"trace[1795391666] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:1; response_revision:1091; }","duration":"310.83439ms","start":"2026-02-09T18:53:13.707279Z","end":"2026-02-09T18:53:14.018113Z","steps":["trace[1795391666] 'agreement among raft nodes before linearized reading'  (duration: 310.714347ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:14.018161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:13.707271Z","time spent":"310.88286ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":711,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "}
{"level":"warn","ts":"2026-02-09T18:53:14.018897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.983442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329940"}
{"level":"info","ts":"2026-02-09T18:53:14.018954Z","caller":"traceutil/trace.go:171","msg":"trace[265562170] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1091; }","duration":"311.055763ms","start":"2026-02-09T18:53:13.707881Z","end":"2026-02-09T18:53:14.018937Z","steps":["trace[265562170] 'agreement among raft nodes before linearized reading'  (duration: 310.404955ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:14.019032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:13.707874Z","time spent":"311.136574ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":4,"response size":329964,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 "}
{"level":"warn","ts":"2026-02-09T18:53:14.019954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.53667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-02-09T18:53:14.019986Z","caller":"traceutil/trace.go:171","msg":"trace[447581373] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:1091; }","duration":"221.595441ms","start":"2026-02-09T18:53:13.798381Z","end":"2026-02-09T18:53:14.019977Z","steps":["trace[447581373] 'agreement among raft nodes before linearized reading'  (duration: 221.54871ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:14.262847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.729484ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576313785502398603 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.1892a8ca1f266a44\" mod_revision:1086 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.1892a8ca1f266a44\" value_size:672 lease:8352941748647621632 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.1892a8ca1f266a44\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-09T18:53:14.262955Z","caller":"traceutil/trace.go:171","msg":"trace[1467429834] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"146.815781ms","start":"2026-02-09T18:53:14.116124Z","end":"2026-02-09T18:53:14.262939Z","steps":["trace[1467429834] 'read index received'  (duration: 19.867065ms)","trace[1467429834] 'applied index is now lower than readState.Index'  (duration: 126.947596ms)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:53:14.263063Z","caller":"traceutil/trace.go:171","msg":"trace[1748316932] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"150.829703ms","start":"2026-02-09T18:53:14.112221Z","end":"2026-02-09T18:53:14.26305Z","steps":["trace[1748316932] 'process raft request'  (duration: 23.799065ms)","trace[1748316932] 'compare'  (duration: 126.626423ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:53:14.263331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.198636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-02-09T18:53:14.263373Z","caller":"traceutil/trace.go:171","msg":"trace[1553808414] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1095; }","duration":"147.248437ms","start":"2026-02-09T18:53:14.116112Z","end":"2026-02-09T18:53:14.26336Z","steps":["trace[1553808414] 'agreement among raft nodes before linearized reading'  (duration: 147.152335ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:14.263543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.300647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-02-09T18:53:14.263575Z","caller":"traceutil/trace.go:171","msg":"trace[1355702028] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:1095; }","duration":"147.341057ms","start":"2026-02-09T18:53:14.116226Z","end":"2026-02-09T18:53:14.263567Z","steps":["trace[1355702028] 'agreement among raft nodes before linearized reading'  (duration: 147.287226ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:53:15.913906Z","caller":"traceutil/trace.go:171","msg":"trace[1698288922] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"171.621639ms","start":"2026-02-09T18:53:15.742274Z","end":"2026-02-09T18:53:15.913896Z","steps":["trace[1698288922] 'process raft request'  (duration: 171.250415ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:53:15.913698Z","caller":"traceutil/trace.go:171","msg":"trace[614509256] linearizableReadLoop","detail":"{readStateIndex:1139; appliedIndex:1138; }","duration":"150.227616ms","start":"2026-02-09T18:53:15.763452Z","end":"2026-02-09T18:53:15.913679Z","steps":["trace[614509256] 'read index received'  (duration: 150.010983ms)","trace[614509256] 'applied index is now lower than readState.Index'  (duration: 215.992µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:53:15.914156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.667711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:1 size:232"}
{"level":"info","ts":"2026-02-09T18:53:15.914186Z","caller":"traceutil/trace.go:171","msg":"trace[201732384] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1096; }","duration":"150.729212ms","start":"2026-02-09T18:53:15.763448Z","end":"2026-02-09T18:53:15.914177Z","steps":["trace[201732384] 'agreement among raft nodes before linearized reading'  (duration: 150.645681ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:15.914553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.364662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:1 size:220"}
{"level":"info","ts":"2026-02-09T18:53:15.914621Z","caller":"traceutil/trace.go:171","msg":"trace[88764990] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:1; response_revision:1096; }","duration":"126.464174ms","start":"2026-02-09T18:53:15.788136Z","end":"2026-02-09T18:53:15.9146Z","steps":["trace[88764990] 'agreement among raft nodes before linearized reading'  (duration: 126.335061ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:16.588225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.623087ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17576313785502398690 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1094 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-09T18:53:16.588298Z","caller":"traceutil/trace.go:171","msg":"trace[847020851] linearizableReadLoop","detail":"{readStateIndex:1143; appliedIndex:1142; }","duration":"426.815254ms","start":"2026-02-09T18:53:16.161471Z","end":"2026-02-09T18:53:16.588286Z","steps":["trace[847020851] 'read index received'  (duration: 57.019785ms)","trace[847020851] 'applied index is now lower than readState.Index'  (duration: 369.794469ms)"],"step_count":2}
{"level":"info","ts":"2026-02-09T18:53:16.588841Z","caller":"traceutil/trace.go:171","msg":"trace[684461552] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"438.560912ms","start":"2026-02-09T18:53:16.15027Z","end":"2026-02-09T18:53:16.588831Z","steps":["trace[684461552] 'process raft request'  (duration: 68.277737ms)","trace[684461552] 'compare'  (duration: 369.285813ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:53:16.588889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:16.150255Z","time spent":"438.611743ms","remote":"127.0.0.1:43164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1094 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-09T18:53:16.589091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.631394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:1 size:199"}
{"level":"info","ts":"2026-02-09T18:53:16.589126Z","caller":"traceutil/trace.go:171","msg":"trace[2099832020] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:1; response_revision:1100; }","duration":"427.679074ms","start":"2026-02-09T18:53:16.161431Z","end":"2026-02-09T18:53:16.58911Z","steps":["trace[2099832020] 'agreement among raft nodes before linearized reading'  (duration: 427.629683ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:16.589146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:16.161419Z","time spent":"427.722374ms","remote":"127.0.0.1:43082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":223,"request content":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" "}
{"level":"warn","ts":"2026-02-09T18:53:16.589749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.344151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-dns\" ","response":"range_response_count:1 size:1211"}
{"level":"info","ts":"2026-02-09T18:53:16.590143Z","caller":"traceutil/trace.go:171","msg":"trace[850609987] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-dns; range_end:; response_count:1; response_revision:1100; }","duration":"368.792956ms","start":"2026-02-09T18:53:16.221331Z","end":"2026-02-09T18:53:16.590124Z","steps":["trace[850609987] 'agreement among raft nodes before linearized reading'  (duration: 368.32754ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:16.590378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T18:53:16.221309Z","time spent":"369.05245ms","remote":"127.0.0.1:43078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":1235,"request content":"key:\"/registry/services/specs/kube-system/kube-dns\" "}
{"level":"warn","ts":"2026-02-09T18:53:18.180969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.046952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-02-09T18:53:18.181059Z","caller":"traceutil/trace.go:171","msg":"trace[1550755816] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:1; response_revision:1101; }","duration":"131.156123ms","start":"2026-02-09T18:53:18.049872Z","end":"2026-02-09T18:53:18.181028Z","steps":["trace[1550755816] 'range keys from in-memory index tree'  (duration: 130.99053ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:53:18.318049Z","caller":"traceutil/trace.go:171","msg":"trace[1058753109] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"126.928509ms","start":"2026-02-09T18:53:18.191108Z","end":"2026-02-09T18:53:18.318037Z","steps":["trace[1058753109] 'process raft request'  (duration: 126.484283ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:53:18.318629Z","caller":"traceutil/trace.go:171","msg":"trace[1552397707] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"126.522764ms","start":"2026-02-09T18:53:18.191268Z","end":"2026-02-09T18:53:18.317791Z","steps":["trace[1552397707] 'read index received'  (duration: 126.410392ms)","trace[1552397707] 'applied index is now lower than readState.Index'  (duration: 111.312µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:53:18.318907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.569547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-02-09T18:53:18.319196Z","caller":"traceutil/trace.go:171","msg":"trace[1505931464] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:1; response_revision:1102; }","duration":"127.958633ms","start":"2026-02-09T18:53:18.191223Z","end":"2026-02-09T18:53:18.319181Z","steps":["trace[1505931464] 'agreement among raft nodes before linearized reading'  (duration: 127.553108ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:53:18.322696Z","caller":"traceutil/trace.go:171","msg":"trace[1927959750] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"130.764778ms","start":"2026-02-09T18:53:18.191914Z","end":"2026-02-09T18:53:18.322678Z","steps":["trace[1927959750] 'process raft request'  (duration: 130.372693ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:53:18.322808Z","caller":"traceutil/trace.go:171","msg":"trace[138158084] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"130.790638ms","start":"2026-02-09T18:53:18.192011Z","end":"2026-02-09T18:53:18.322802Z","steps":["trace[138158084] 'process raft request'  (duration: 130.368783ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:18.895848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.252282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-02-09T18:53:18.896287Z","caller":"traceutil/trace.go:171","msg":"trace[768897883] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:1; response_revision:1105; }","duration":"138.726398ms","start":"2026-02-09T18:53:18.757541Z","end":"2026-02-09T18:53:18.896268Z","steps":["trace[768897883] 'range keys from in-memory index tree'  (duration: 138.163461ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-09T18:53:18.895998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.788279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-controller\" ","response":"range_response_count:1 size:201"}
{"level":"info","ts":"2026-02-09T18:53:18.896609Z","caller":"traceutil/trace.go:171","msg":"trace[82588299] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-controller; range_end:; response_count:1; response_revision:1105; }","duration":"120.435957ms","start":"2026-02-09T18:53:18.776155Z","end":"2026-02-09T18:53:18.896591Z","steps":["trace[82588299] 'range keys from in-memory index tree'  (duration: 119.672918ms)"],"step_count":1}
{"level":"info","ts":"2026-02-09T18:53:19.099842Z","caller":"traceutil/trace.go:171","msg":"trace[2013506018] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1148; }","duration":"103.143535ms","start":"2026-02-09T18:53:18.996673Z","end":"2026-02-09T18:53:19.099817Z","steps":["trace[2013506018] 'read index received'  (duration: 23.609256ms)","trace[2013506018] 'applied index is now lower than readState.Index'  (duration: 79.532929ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-09T18:53:19.099996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.304547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-02-09T18:53:19.100058Z","caller":"traceutil/trace.go:171","msg":"trace[317444859] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:1; response_revision:1105; }","duration":"103.380767ms","start":"2026-02-09T18:53:18.996643Z","end":"2026-02-09T18:53:19.100023Z","steps":["trace[317444859] 'agreement among raft nodes before linearized reading'  (duration: 103.286206ms)"],"step_count":1}