{"level":"warn","ts":"2026-02-04T10:59:30.33714Z","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-04T10:59:30.337227Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-04T10:59:30.337291Z","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-04T10:59:30.3373Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]}
{"level":"info","ts":"2026-02-04T10:59:30.337319Z","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-04T10:59:30.342174Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]}
{"level":"info","ts":"2026-02-04T10:59:30.342259Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-04T10:59:30.381027Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"38.597578ms"}
{"level":"info","ts":"2026-02-04T10:59:30.433314Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"}
{"level":"info","ts":"2026-02-04T10:59:30.433386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-04T10:59:30.433411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"}
{"level":"info","ts":"2026-02-04T10:59:30.433423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-04T10:59:30.43343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"}
{"level":"info","ts":"2026-02-04T10:59:30.433463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"}
{"level":"warn","ts":"2026-02-04T10:59:30.48478Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-04T10:59:30.490622Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-04T10:59:30.501396Z","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-04T10:59:30.529572Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-04T10:59:30.534943Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-04T10:59:30.536617Z","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-04T10:59:30.536672Z","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-04T10:59:30.53669Z","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-04T10:59:30.53957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"}
{"level":"info","ts":"2026-02-04T10:59:30.539977Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]}
{"level":"info","ts":"2026-02-04T10:59:30.549758Z","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-04T10:59:30.549926Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"}
{"level":"info","ts":"2026-02-04T10:59:30.549952Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"}
{"level":"info","ts":"2026-02-04T10:59:30.550317Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-04T10:59:30.550414Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-04T10:59:30.948507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-04T10:59:30.948548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-04T10:59:30.948562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"}
{"level":"info","ts":"2026-02-04T10:59:30.948574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"}
{"level":"info","ts":"2026-02-04T10:59:30.94858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"}
{"level":"info","ts":"2026-02-04T10:59:30.948588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"}
{"level":"info","ts":"2026-02-04T10:59:30.948595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"}
{"level":"info","ts":"2026-02-04T10:59:30.95661Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-04T10:59:30.956737Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-04T10:59:30.957175Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T10:59:30.957261Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-04T10:59:30.958934Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-04T10:59:30.959458Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-04T10:59:30.960965Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-04T10:59:30.968534Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"}
{"level":"info","ts":"2026-02-04T10:59:30.974547Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T10:59:30.976557Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T10:59:30.97664Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-04T10:59:59.942886Z","caller":"traceutil/trace.go:171","msg":"trace[233179342] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"154.232549ms","start":"2026-02-04T10:59:59.788636Z","end":"2026-02-04T10:59:59.942868Z","steps":["trace[233179342] 'process raft request'  (duration: 154.086376ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:06.56801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.101775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ws5bm\" ","response":"range_response_count:1 size:16656"}
{"level":"info","ts":"2026-02-04T11:00:06.568109Z","caller":"traceutil/trace.go:171","msg":"trace[1435702813] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ws5bm; range_end:; response_count:1; response_revision:530; }","duration":"441.246088ms","start":"2026-02-04T11:00:06.126845Z","end":"2026-02-04T11:00:06.568091Z","steps":["trace[1435702813] 'range keys from in-memory index tree'  (duration: 440.945382ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:06.568152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:06.126829Z","time spent":"441.31297ms","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-ws5bm\" "}
{"level":"info","ts":"2026-02-04T11:00:06.577889Z","caller":"traceutil/trace.go:171","msg":"trace[1490241504] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"135.238528ms","start":"2026-02-04T11:00:06.44264Z","end":"2026-02-04T11:00:06.577879Z","steps":["trace[1490241504] 'process raft request'  (duration: 135.147996ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:06.968835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.290124ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520789915 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-ws5bm\" mod_revision:504 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-ws5bm\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-ws5bm\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:00:06.968918Z","caller":"traceutil/trace.go:171","msg":"trace[2046938971] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:550; }","duration":"242.084765ms","start":"2026-02-04T11:00:06.72682Z","end":"2026-02-04T11:00:06.968904Z","steps":["trace[2046938971] 'read index received'  (duration: 45.901µs)","trace[2046938971] 'applied index is now lower than readState.Index'  (duration: 242.037874ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:00:06.96971Z","caller":"traceutil/trace.go:171","msg":"trace[1089075968] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"385.808334ms","start":"2026-02-04T11:00:06.583886Z","end":"2026-02-04T11:00:06.969694Z","steps":["trace[1089075968] 'process raft request'  (duration: 92.102431ms)","trace[1089075968] 'compare'  (duration: 292.180582ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:06.969849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:06.583872Z","time spent":"385.873705ms","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-ws5bm\" mod_revision:504 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-ws5bm\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-ws5bm\" > >"}
{"level":"warn","ts":"2026-02-04T11:00:06.969873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.040354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:00:06.969929Z","caller":"traceutil/trace.go:171","msg":"trace[251716877] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"243.144266ms","start":"2026-02-04T11:00:06.726771Z","end":"2026-02-04T11:00:06.969915Z","steps":["trace[251716877] 'agreement among raft nodes before linearized reading'  (duration: 243.022544ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:07.239474Z","caller":"traceutil/trace.go:171","msg":"trace[1070053507] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"474.505506ms","start":"2026-02-04T11:00:06.76495Z","end":"2026-02-04T11:00:07.239456Z","steps":["trace[1070053507] 'process raft request'  (duration: 473.865983ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:07.239606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:06.764921Z","time spent":"474.618417ms","remote":"127.0.0.1:50062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4388,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:513 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4354 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-04T11:00:07.239874Z","caller":"traceutil/trace.go:171","msg":"trace[881874341] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"270.272711ms","start":"2026-02-04T11:00:06.968989Z","end":"2026-02-04T11:00:07.239262Z","steps":["trace[881874341] 'read index received'  (duration: 269.828252ms)","trace[881874341] 'applied index is now lower than readState.Index'  (duration: 443.429µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:07.240057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.137382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-04T11:00:07.240107Z","caller":"traceutil/trace.go:171","msg":"trace[901051408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:533; }","duration":"309.205854ms","start":"2026-02-04T11:00:06.930871Z","end":"2026-02-04T11:00:07.240077Z","steps":["trace[901051408] 'agreement among raft nodes before linearized reading'  (duration: 309.085061ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:07.24014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:06.930852Z","time spent":"309.279686ms","remote":"127.0.0.1:50180","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-04T11:00:07.241848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.260211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:00:07.241932Z","caller":"traceutil/trace.go:171","msg":"trace[1598490090] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:533; }","duration":"271.374044ms","start":"2026-02-04T11:00:06.970528Z","end":"2026-02-04T11:00:07.241902Z","steps":["trace[1598490090] 'agreement among raft nodes before linearized reading'  (duration: 271.231871ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:09.54933Z","caller":"traceutil/trace.go:171","msg":"trace[1394009923] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"120.44968ms","start":"2026-02-04T11:00:09.428858Z","end":"2026-02-04T11:00:09.549308Z","steps":["trace[1394009923] 'process raft request'  (duration: 120.209915ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:09.698927Z","caller":"traceutil/trace.go:171","msg":"trace[369265975] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"139.902861ms","start":"2026-02-04T11:00:09.559001Z","end":"2026-02-04T11:00:09.698904Z","steps":["trace[369265975] 'process raft request'  (duration: 139.862321ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:09.699553Z","caller":"traceutil/trace.go:171","msg":"trace[722425935] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"140.681637ms","start":"2026-02-04T11:00:09.558856Z","end":"2026-02-04T11:00:09.699537Z","steps":["trace[722425935] 'process raft request'  (duration: 91.172473ms)","trace[722425935] 'compare'  (duration: 48.740359ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:00:09.728773Z","caller":"traceutil/trace.go:171","msg":"trace[753930922] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"151.173918ms","start":"2026-02-04T11:00:09.57758Z","end":"2026-02-04T11:00:09.728754Z","steps":["trace[753930922] 'process raft request'  (duration: 151.058305ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:23.700614Z","caller":"traceutil/trace.go:171","msg":"trace[1651733039] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:733; }","duration":"312.56192ms","start":"2026-02-04T11:00:23.38803Z","end":"2026-02-04T11:00:23.700592Z","steps":["trace[1651733039] 'read index received'  (duration: 312.412317ms)","trace[1651733039] 'applied index is now lower than readState.Index'  (duration: 148.563µs)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:00:23.700739Z","caller":"traceutil/trace.go:171","msg":"trace[548742225] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"587.104848ms","start":"2026-02-04T11:00:23.113624Z","end":"2026-02-04T11:00:23.700729Z","steps":["trace[548742225] 'process raft request'  (duration: 586.841713ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:23.700837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:23.113613Z","time spent":"587.154339ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:704 > 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":"warn","ts":"2026-02-04T11:00:23.700959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.730701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-04T11:00:23.701004Z","caller":"traceutil/trace.go:171","msg":"trace[270469274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:710; }","duration":"260.852453ms","start":"2026-02-04T11:00:23.440139Z","end":"2026-02-04T11:00:23.700992Z","steps":["trace[270469274] 'agreement among raft nodes before linearized reading'  (duration: 260.72517ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:23.70113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.100752ms","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-04T11:00:23.701143Z","caller":"traceutil/trace.go:171","msg":"trace[1494001950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:710; }","duration":"313.147213ms","start":"2026-02-04T11:00:23.387991Z","end":"2026-02-04T11:00:23.701138Z","steps":["trace[1494001950] 'agreement among raft nodes before linearized reading'  (duration: 313.110022ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:23.701155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:23.387971Z","time spent":"313.180113ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-04T11:00:23.701265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.581036ms","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-04T11:00:23.701287Z","caller":"traceutil/trace.go:171","msg":"trace[104437923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:710; }","duration":"250.614767ms","start":"2026-02-04T11:00:23.450665Z","end":"2026-02-04T11:00:23.70128Z","steps":["trace[104437923] 'agreement among raft nodes before linearized reading'  (duration: 250.554396ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:23.7014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.379503ms","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-04T11:00:23.701416Z","caller":"traceutil/trace.go:171","msg":"trace[1114813598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:710; }","duration":"258.431574ms","start":"2026-02-04T11:00:23.442979Z","end":"2026-02-04T11:00:23.701411Z","steps":["trace[1114813598] 'agreement among raft nodes before linearized reading'  (duration: 258.389433ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:24.392936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.922341ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790257 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:707 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:00:24.393662Z","caller":"traceutil/trace.go:171","msg":"trace[574400077] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:734; }","duration":"669.858112ms","start":"2026-02-04T11:00:23.723785Z","end":"2026-02-04T11:00:24.393643Z","steps":["trace[574400077] 'read index received'  (duration: 133.146825ms)","trace[574400077] 'applied index is now lower than readState.Index'  (duration: 536.710397ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:24.393849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.019085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:00:24.393949Z","caller":"traceutil/trace.go:171","msg":"trace[791182674] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:714; }","duration":"670.171178ms","start":"2026-02-04T11:00:23.723764Z","end":"2026-02-04T11:00:24.393936Z","steps":["trace[791182674] 'agreement among raft nodes before linearized reading'  (duration: 669.991404ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:24.394016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:23.723756Z","time spent":"670.246449ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-04T11:00:24.394514Z","caller":"traceutil/trace.go:171","msg":"trace[1628934154] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"686.749501ms","start":"2026-02-04T11:00:23.707749Z","end":"2026-02-04T11:00:24.394499Z","steps":["trace[1628934154] 'process raft request'  (duration: 149.173147ms)","trace[1628934154] 'compare'  (duration: 535.668535ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:24.394784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:23.707733Z","time spent":"687.007687ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:707 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-04T11:00:24.395245Z","caller":"traceutil/trace.go:171","msg":"trace[1334034276] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"687.429314ms","start":"2026-02-04T11:00:23.707791Z","end":"2026-02-04T11:00:24.395221Z","steps":["trace[1334034276] 'process raft request'  (duration: 685.72736ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:24.400961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:23.70777Z","time spent":"693.150049ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:708 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-04T11:00:24.401108Z","caller":"traceutil/trace.go:171","msg":"trace[1289594809] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"691.592588ms","start":"2026-02-04T11:00:23.709508Z","end":"2026-02-04T11:00:24.401101Z","steps":["trace[1289594809] 'process raft request'  (duration: 684.074498ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:24.401171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:23.709497Z","time spent":"691.655759ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:709 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-04T11:00:24.401261Z","caller":"traceutil/trace.go:171","msg":"trace[643310296] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"691.600989ms","start":"2026-02-04T11:00:23.709655Z","end":"2026-02-04T11:00:24.401256Z","steps":["trace[643310296] 'process raft request'  (duration: 683.958575ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:24.401313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:23.709646Z","time spent":"691.65105ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:706 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-04T11:00:24.404728Z","caller":"traceutil/trace.go:171","msg":"trace[1858953781] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"241.388971ms","start":"2026-02-04T11:00:24.163321Z","end":"2026-02-04T11:00:24.40471Z","steps":["trace[1858953781] 'process raft request'  (duration: 241.266519ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:24.488372Z","caller":"traceutil/trace.go:171","msg":"trace[344322143] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"132.096095ms","start":"2026-02-04T11:00:24.356255Z","end":"2026-02-04T11:00:24.488351Z","steps":["trace[344322143] 'process raft request'  (duration: 131.895461ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:26.591669Z","caller":"traceutil/trace.go:171","msg":"trace[604191252] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:743; }","duration":"174.343894ms","start":"2026-02-04T11:00:26.417287Z","end":"2026-02-04T11:00:26.59163Z","steps":["trace[604191252] 'read index received'  (duration: 74.805674ms)","trace[604191252] 'applied index is now lower than readState.Index'  (duration: 99.53729ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:26.591819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.514597ms","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-04T11:00:26.591836Z","caller":"traceutil/trace.go:171","msg":"trace[1434567880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:721; }","duration":"174.558678ms","start":"2026-02-04T11:00:26.417272Z","end":"2026-02-04T11:00:26.59183Z","steps":["trace[1434567880] 'agreement among raft nodes before linearized reading'  (duration: 174.446096ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:26.59191Z","caller":"traceutil/trace.go:171","msg":"trace[1461237657] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"172.190541ms","start":"2026-02-04T11:00:26.419714Z","end":"2026-02-04T11:00:26.591905Z","steps":["trace[1461237657] 'process raft request'  (duration: 171.858274ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:26.591951Z","caller":"traceutil/trace.go:171","msg":"trace[1502376621] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"174.726302ms","start":"2026-02-04T11:00:26.41722Z","end":"2026-02-04T11:00:26.591947Z","steps":["trace[1502376621] 'process raft request'  (duration: 174.216201ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:41.077291Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790392,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:00:42.148066Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790392,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:00:42.649171Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790392,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:00:42.724728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000325528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:00:42.724783Z","caller":"traceutil/trace.go:171","msg":"trace[1806009909] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00040655s","start":"2026-02-04T11:00:40.724365Z","end":"2026-02-04T11:00:42.724772Z","steps":["trace[1806009909] 'agreement among raft nodes before linearized reading'  (duration: 2.000344599s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:42.724812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:40.724353Z","time spent":"2.000452191s","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:00:42 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:00:42.793222Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.027230857s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-04T11:00:42.793532Z","caller":"traceutil/trace.go:171","msg":"trace[2093200215] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:791; }","duration":"2.216876991s","start":"2026-02-04T11:00:40.576623Z","end":"2026-02-04T11:00:42.7935Z","steps":["trace[2093200215] 'read index received'  (duration: 2.216724368s)","trace[2093200215] 'applied index is now lower than readState.Index'  (duration: 152.033µs)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:00:42.793678Z","caller":"traceutil/trace.go:171","msg":"trace[1428131910] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"3.027735527s","start":"2026-02-04T11:00:39.765934Z","end":"2026-02-04T11:00:42.79367Z","steps":["trace[1428131910] 'process raft request'  (duration: 3.02741967s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:42.79377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:39.765925Z","time spent":"3.027774067s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:757 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-04T11:00:42.793809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.20888601s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:00:42.793864Z","caller":"traceutil/trace.go:171","msg":"trace[1590687402] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:763; }","duration":"2.208965222s","start":"2026-02-04T11:00:40.584887Z","end":"2026-02-04T11:00:42.793852Z","steps":["trace[1590687402] 'agreement among raft nodes before linearized reading'  (duration: 2.2088824s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:42.793896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:40.584877Z","time spent":"2.209010883s","remote":"127.0.0.1:50144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:00:42.794086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.048043978s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-02-04T11:00:42.794091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.091075432s","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-04T11:00:42.79412Z","caller":"traceutil/trace.go:171","msg":"trace[1606365898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:763; }","duration":"2.091102522s","start":"2026-02-04T11:00:40.703009Z","end":"2026-02-04T11:00:42.794111Z","steps":["trace[1606365898] 'agreement among raft nodes before linearized reading'  (duration: 2.091019921s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:42.794145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:40.702985Z","time spent":"2.091154664s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-04T11:00:42.794172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.217549984s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-04T11:00:42.794203Z","caller":"traceutil/trace.go:171","msg":"trace[1745586743] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:763; }","duration":"2.217603196s","start":"2026-02-04T11:00:40.576582Z","end":"2026-02-04T11:00:42.794185Z","steps":["trace[1745586743] 'agreement among raft nodes before linearized reading'  (duration: 2.217554665s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:42.794221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:40.576562Z","time spent":"2.217654166s","remote":"127.0.0.1:50180","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-04T11:00:42.794321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.099728856s","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-04T11:00:42.794349Z","caller":"traceutil/trace.go:171","msg":"trace[1046680045] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:763; }","duration":"2.099777897s","start":"2026-02-04T11:00:40.694561Z","end":"2026-02-04T11:00:42.794339Z","steps":["trace[1046680045] 'agreement among raft nodes before linearized reading'  (duration: 2.099708395s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:42.794373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:40.694548Z","time spent":"2.099819567s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-04T11:00:42.794453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.677155184s","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-04T11:00:42.794475Z","caller":"traceutil/trace.go:171","msg":"trace[491982837] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:763; }","duration":"1.677200594s","start":"2026-02-04T11:00:41.117268Z","end":"2026-02-04T11:00:42.794469Z","steps":["trace[491982837] 'agreement among raft nodes before linearized reading'  (duration: 1.677163984s)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:42.794124Z","caller":"traceutil/trace.go:171","msg":"trace[286255001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:763; }","duration":"2.048086168s","start":"2026-02-04T11:00:40.746016Z","end":"2026-02-04T11:00:42.794102Z","steps":["trace[286255001] 'agreement among raft nodes before linearized reading'  (duration: 2.047989066s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:42.79451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:41.117256Z","time spent":"1.677233345s","remote":"127.0.0.1:49970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:00:42.79451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:40.74601Z","time spent":"2.048492827s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-04T11:00:43.338383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.006966ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790396 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:759 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:00:43.338451Z","caller":"traceutil/trace.go:171","msg":"trace[1207967380] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"538.034503ms","start":"2026-02-04T11:00:42.800404Z","end":"2026-02-04T11:00:43.338439Z","steps":["trace[1207967380] 'process raft request'  (duration: 163.916025ms)","trace[1207967380] 'compare'  (duration: 373.70522ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:43.338489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:42.800391Z","time spent":"538.081255ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:759 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-04T11:00:43.714261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.640828ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790398 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:21c29c284eac157d>","response":"size:41"}
{"level":"info","ts":"2026-02-04T11:00:43.71473Z","caller":"traceutil/trace.go:171","msg":"trace[390359480] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:792; }","duration":"893.815262ms","start":"2026-02-04T11:00:42.820841Z","end":"2026-02-04T11:00:43.714656Z","steps":["trace[390359480] 'read index received'  (duration: 143.540044ms)","trace[390359480] 'applied index is now lower than readState.Index'  (duration: 750.274278ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:43.714911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.042427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:00:43.714946Z","caller":"traceutil/trace.go:171","msg":"trace[1672363170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"894.119339ms","start":"2026-02-04T11:00:42.820816Z","end":"2026-02-04T11:00:43.714935Z","steps":["trace[1672363170] 'agreement among raft nodes before linearized reading'  (duration: 893.996176ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:43.714984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:42.820804Z","time spent":"894.16939ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:00:43.716074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:42.803502Z","time spent":"912.568638ms","remote":"127.0.0.1:49968","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-04T11:00:43.716574Z","caller":"traceutil/trace.go:171","msg":"trace[552491500] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"903.243052ms","start":"2026-02-04T11:00:42.813315Z","end":"2026-02-04T11:00:43.716558Z","steps":["trace[552491500] 'process raft request'  (duration: 901.068489ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:43.716662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:42.813299Z","time spent":"903.304483ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:762 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-04T11:00:43.716837Z","caller":"traceutil/trace.go:171","msg":"trace[545135381] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"912.305774ms","start":"2026-02-04T11:00:42.804518Z","end":"2026-02-04T11:00:43.716823Z","steps":["trace[545135381] 'process raft request'  (duration: 909.799244ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:43.716908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:42.804509Z","time spent":"912.359545ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:760 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-04T11:00:43.717398Z","caller":"traceutil/trace.go:171","msg":"trace[1760731490] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"903.857165ms","start":"2026-02-04T11:00:42.813524Z","end":"2026-02-04T11:00:43.717382Z","steps":["trace[1760731490] 'process raft request'  (duration: 901.027258ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:43.717525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:42.813517Z","time spent":"903.966357ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:761 > 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-04T11:00:43.997539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.756887ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790403 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" value_size:672 lease:2432678445666014589 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:00:43.997623Z","caller":"traceutil/trace.go:171","msg":"trace[1757128237] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"269.72055ms","start":"2026-02-04T11:00:43.727889Z","end":"2026-02-04T11:00:43.997609Z","steps":["trace[1757128237] 'read index received'  (duration: 149.820941ms)","trace[1757128237] 'applied index is now lower than readState.Index'  (duration: 119.898689ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:00:43.997662Z","caller":"traceutil/trace.go:171","msg":"trace[71766618] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"279.014148ms","start":"2026-02-04T11:00:43.718608Z","end":"2026-02-04T11:00:43.997622Z","steps":["trace[71766618] 'process raft request'  (duration: 159.127738ms)","trace[71766618] 'compare'  (duration: 119.647735ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:43.997731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.840333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:00:43.997751Z","caller":"traceutil/trace.go:171","msg":"trace[1232830038] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"269.888523ms","start":"2026-02-04T11:00:43.727856Z","end":"2026-02-04T11:00:43.997744Z","steps":["trace[1232830038] 'agreement among raft nodes before linearized reading'  (duration: 269.828812ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:43.997991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.830472ms","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-04T11:00:43.998012Z","caller":"traceutil/trace.go:171","msg":"trace[1990159375] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:768; }","duration":"158.882073ms","start":"2026-02-04T11:00:43.839124Z","end":"2026-02-04T11:00:43.998006Z","steps":["trace[1990159375] 'agreement among raft nodes before linearized reading'  (duration: 158.845703ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:44.443707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.245911ms","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-04T11:00:44.443766Z","caller":"traceutil/trace.go:171","msg":"trace[1729501101] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:768; }","duration":"262.352143ms","start":"2026-02-04T11:00:44.181401Z","end":"2026-02-04T11:00:44.443753Z","steps":["trace[1729501101] 'count revisions from in-memory index tree'  (duration: 262.183039ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:45.059262Z","caller":"traceutil/trace.go:171","msg":"trace[1123603227] linearizableReadLoop","detail":"{readStateIndex:800; appliedIndex:799; }","duration":"334.193626ms","start":"2026-02-04T11:00:44.725051Z","end":"2026-02-04T11:00:45.059244Z","steps":["trace[1123603227] 'read index received'  (duration: 243.852121ms)","trace[1123603227] 'applied index is now lower than readState.Index'  (duration: 90.340765ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:00:45.059351Z","caller":"traceutil/trace.go:171","msg":"trace[974523732] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"334.36169ms","start":"2026-02-04T11:00:44.724972Z","end":"2026-02-04T11:00:45.059333Z","steps":["trace[974523732] 'process raft request'  (duration: 243.888112ms)","trace[974523732] 'compare'  (duration: 90.018659ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:45.059431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:44.724958Z","time spent":"334.410001ms","remote":"127.0.0.1:49932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.227\" mod_revision:745 > success:<request_put:<key:\"/registry/masterleases/199.204.45.227\" value_size:67 lease:2432678445666014600 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.227\" > >"}
{"level":"warn","ts":"2026-02-04T11:00:45.059665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.611415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:00:45.059692Z","caller":"traceutil/trace.go:171","msg":"trace[393607342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:769; }","duration":"334.654155ms","start":"2026-02-04T11:00:44.725032Z","end":"2026-02-04T11:00:45.059686Z","steps":["trace[393607342] 'agreement among raft nodes before linearized reading'  (duration: 334.592524ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:45.059713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:00:44.725024Z","time spent":"334.685387ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-04T11:00:45.073997Z","caller":"traceutil/trace.go:171","msg":"trace[534781620] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"120.617064ms","start":"2026-02-04T11:00:44.953362Z","end":"2026-02-04T11:00:45.073979Z","steps":["trace[534781620] 'process raft request'  (duration: 120.455791ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:45.074197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.126788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-04T11:00:45.074218Z","caller":"traceutil/trace.go:171","msg":"trace[235482398] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:770; }","duration":"273.19003ms","start":"2026-02-04T11:00:44.801022Z","end":"2026-02-04T11:00:45.074212Z","steps":["trace[235482398] 'agreement among raft nodes before linearized reading'  (duration: 273.095748ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:45.4998Z","caller":"traceutil/trace.go:171","msg":"trace[1379217646] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"154.186318ms","start":"2026-02-04T11:00:45.345597Z","end":"2026-02-04T11:00:45.499783Z","steps":["trace[1379217646] 'process raft request'  (duration: 154.097707ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:45.88102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.262021ms","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-04T11:00:45.881085Z","caller":"traceutil/trace.go:171","msg":"trace[852677035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:772; }","duration":"156.354492ms","start":"2026-02-04T11:00:45.724716Z","end":"2026-02-04T11:00:45.88107Z","steps":["trace[852677035] 'range keys from in-memory index tree'  (duration: 156.137238ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:45.881216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.077117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:00:45.881236Z","caller":"traceutil/trace.go:171","msg":"trace[825668314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:772; }","duration":"155.107387ms","start":"2026-02-04T11:00:45.726123Z","end":"2026-02-04T11:00:45.88123Z","steps":["trace[825668314] 'range keys from in-memory index tree'  (duration: 155.055286ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:45.881351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.978624ms","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-04T11:00:45.88137Z","caller":"traceutil/trace.go:171","msg":"trace[856090645] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:772; }","duration":"154.010586ms","start":"2026-02-04T11:00:45.727355Z","end":"2026-02-04T11:00:45.881365Z","steps":["trace[856090645] 'range keys from in-memory index tree'  (duration: 153.932034ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:45.88147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.873333ms","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-04T11:00:45.881489Z","caller":"traceutil/trace.go:171","msg":"trace[32087203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:772; }","duration":"150.902043ms","start":"2026-02-04T11:00:45.730583Z","end":"2026-02-04T11:00:45.881485Z","steps":["trace[32087203] 'range keys from in-memory index tree'  (duration: 150.827771ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:46.103476Z","caller":"traceutil/trace.go:171","msg":"trace[1271124813] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"219.026273ms","start":"2026-02-04T11:00:45.884436Z","end":"2026-02-04T11:00:46.103462Z","steps":["trace[1271124813] 'process raft request'  (duration: 218.94664ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:46.135658Z","caller":"traceutil/trace.go:171","msg":"trace[479865374] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"249.880902ms","start":"2026-02-04T11:00:45.885762Z","end":"2026-02-04T11:00:46.135643Z","steps":["trace[479865374] 'process raft request'  (duration: 249.859021ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:46.135894Z","caller":"traceutil/trace.go:171","msg":"trace[687374238] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"250.643787ms","start":"2026-02-04T11:00:45.885245Z","end":"2026-02-04T11:00:46.135889Z","steps":["trace[687374238] 'process raft request'  (duration: 250.30344ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:00:50.358745Z","caller":"traceutil/trace.go:171","msg":"trace[2092708524] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:815; }","duration":"210.9296ms","start":"2026-02-04T11:00:50.147797Z","end":"2026-02-04T11:00:50.358726Z","steps":["trace[2092708524] 'read index received'  (duration: 210.716764ms)","trace[2092708524] 'applied index is now lower than readState.Index'  (duration: 206.306µs)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:00:50.358967Z","caller":"traceutil/trace.go:171","msg":"trace[552559389] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"243.746828ms","start":"2026-02-04T11:00:50.115212Z","end":"2026-02-04T11:00:50.358959Z","steps":["trace[552559389] 'process raft request'  (duration: 243.37075ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:00:50.408368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.529386ms","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-04T11:00:50.408441Z","caller":"traceutil/trace.go:171","msg":"trace[1778020409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:784; }","duration":"260.691559ms","start":"2026-02-04T11:00:50.14773Z","end":"2026-02-04T11:00:50.408422Z","steps":["trace[1778020409] 'agreement among raft nodes before linearized reading'  (duration: 211.392039ms)","trace[1778020409] 'range keys from in-memory index tree'  (duration: 49.094046ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:00:50.40848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.991765ms","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-04T11:00:50.408548Z","caller":"traceutil/trace.go:171","msg":"trace[674332618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:784; }","duration":"260.087407ms","start":"2026-02-04T11:00:50.148441Z","end":"2026-02-04T11:00:50.408528Z","steps":["trace[674332618] 'agreement among raft nodes before linearized reading'  (duration: 210.704855ms)","trace[674332618] 'range keys from in-memory index tree'  (duration: 49.199398ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:03.481257Z","caller":"traceutil/trace.go:171","msg":"trace[566583176] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"158.016246ms","start":"2026-02-04T11:01:03.323222Z","end":"2026-02-04T11:01:03.481238Z","steps":["trace[566583176] 'process raft request'  (duration: 157.893064ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:03.874362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.130944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-04T11:01:03.874413Z","caller":"traceutil/trace.go:171","msg":"trace[1171541469] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:872; }","duration":"221.209096ms","start":"2026-02-04T11:01:03.653191Z","end":"2026-02-04T11:01:03.874401Z","steps":["trace[1171541469] 'range keys from in-memory index tree'  (duration: 220.995501ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:07.462178Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.328163131s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-04T11:01:07.462552Z","caller":"traceutil/trace.go:171","msg":"trace[1878324543] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"1.32862169s","start":"2026-02-04T11:01:06.133915Z","end":"2026-02-04T11:01:07.462536Z","steps":["trace[1878324543] 'process raft request'  (duration: 1.328507868s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:07.462619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:06.133897Z","time spent":"1.328673991s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:873 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-04T11:01:07.462824Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790672,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-04T11:01:07.462853Z","caller":"traceutil/trace.go:171","msg":"trace[1601466211] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:916; }","duration":"1.002529478s","start":"2026-02-04T11:01:06.460315Z","end":"2026-02-04T11:01:07.462845Z","steps":["trace[1601466211] 'read index received'  (duration: 1.002527138s)","trace[1601466211] 'applied index is now lower than readState.Index'  (duration: 2.03µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:07.46292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002606129s","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-04T11:01:07.462935Z","caller":"traceutil/trace.go:171","msg":"trace[1756947672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:880; }","duration":"1.00264547s","start":"2026-02-04T11:01:06.460284Z","end":"2026-02-04T11:01:07.46293Z","steps":["trace[1756947672] 'agreement among raft nodes before linearized reading'  (duration: 1.002584949s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:07.462949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:06.460273Z","time spent":"1.002672521s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-04T11:01:07.463212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.528432ms","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-04T11:01:07.463228Z","caller":"traceutil/trace.go:171","msg":"trace[95406962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:880; }","duration":"946.570163ms","start":"2026-02-04T11:01:06.516653Z","end":"2026-02-04T11:01:07.463223Z","steps":["trace[95406962] 'agreement among raft nodes before linearized reading'  (duration: 946.527342ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:07.46324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:06.51664Z","time spent":"946.597173ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-04T11:01:07.463352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.916039ms","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-04T11:01:07.463365Z","caller":"traceutil/trace.go:171","msg":"trace[1749676600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:880; }","duration":"944.97119ms","start":"2026-02-04T11:01:06.51839Z","end":"2026-02-04T11:01:07.463361Z","steps":["trace[1749676600] 'agreement among raft nodes before linearized reading'  (duration: 944.932399ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:07.463377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:06.518379Z","time spent":"944.994821ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-04T11:01:07.994393Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:08.342864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.633206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:08.342956Z","caller":"traceutil/trace.go:171","msg":"trace[948575678] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:880; }","duration":"872.79917ms","start":"2026-02-04T11:01:07.470138Z","end":"2026-02-04T11:01:08.342938Z","steps":["trace[948575678] 'count revisions from in-memory index tree'  (duration: 872.555905ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:08.343141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:07.470122Z","time spent":"872.865391ms","remote":"127.0.0.1:50190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:08.343617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.736329ms","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-04T11:01:08.343713Z","caller":"traceutil/trace.go:171","msg":"trace[108231242] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:880; }","duration":"865.849361ms","start":"2026-02-04T11:01:07.477852Z","end":"2026-02-04T11:01:08.343702Z","steps":["trace[108231242] 'range keys from in-memory index tree'  (duration: 865.727419ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:08.494842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:08.995914Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:09.496118Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:09.727745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000746396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:09.727804Z","caller":"traceutil/trace.go:171","msg":"trace[1063187394] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000866039s","start":"2026-02-04T11:01:07.726924Z","end":"2026-02-04T11:01:09.72779Z","steps":["trace[1063187394] 'agreement among raft nodes before linearized reading'  (duration: 2.000782187s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:09.727836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:07.726858Z","time spent":"2.000972332s","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:01:09 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:09.996955Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:10.497753Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:10.942474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000162406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:10.942549Z","caller":"traceutil/trace.go:171","msg":"trace[473337270] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000277768s","start":"2026-02-04T11:01:08.942256Z","end":"2026-02-04T11:01:10.942534Z","steps":["trace[473337270] 'agreement among raft nodes before linearized reading'  (duration: 2.000183096s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:10.942584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:08.94224Z","time spent":"2.00033745s","remote":"127.0.0.1:49902","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-04T11:01:10.998469Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:11.499612Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:11.728212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000016793s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:11.728264Z","caller":"traceutil/trace.go:171","msg":"trace[1310548185] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000099264s","start":"2026-02-04T11:01:09.728152Z","end":"2026-02-04T11:01:11.728251Z","steps":["trace[1310548185] 'agreement among raft nodes before linearized reading'  (duration: 2.000036003s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:11.728296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:09.72814Z","time spent":"2.000148945s","remote":"127.0.0.1:49906","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-04T11:01:11.999963Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:12.47352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:07.478028Z","time spent":"4.995486701s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/04 11:01:12 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:12.493272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999725508s","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-04T11:01:12.493305Z","caller":"traceutil/trace.go:171","msg":"trace[143538062] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.99980215s","start":"2026-02-04T11:01:07.493492Z","end":"2026-02-04T11:01:12.493295Z","steps":["trace[143538062] 'agreement among raft nodes before linearized reading'  (duration: 4.999750229s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:12.493335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:07.493466Z","time spent":"4.99985764s","remote":"127.0.0.1:50180","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\" "}
{"level":"warn","ts":"2026-02-04T11:01:12.500534Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:13.000615Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:13.501873Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:14.002407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790676,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:14.261245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000693065s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:14.261336Z","caller":"traceutil/trace.go:171","msg":"trace[772474267] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000805837s","start":"2026-02-04T11:01:12.260517Z","end":"2026-02-04T11:01:14.261322Z","steps":["trace[772474267] 'agreement among raft nodes before linearized reading'  (duration: 2.000702845s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:14.261378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:12.26051Z","time spent":"2.000860688s","remote":"127.0.0.1:49902","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-04T11:01:14.477665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:07.477152Z","time spent":"7.000508933s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:14.480864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999883216s","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-04T11:01:14.480906Z","caller":"traceutil/trace.go:171","msg":"trace[1470406870] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999978838s","start":"2026-02-04T11:01:09.480918Z","end":"2026-02-04T11:01:14.480897Z","steps":["trace[1470406870] 'agreement among raft nodes before linearized reading'  (duration: 4.999920447s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:14.480929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:09.480906Z","time spent":"5.000018669s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-04T11:01:14.482104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:07.481785Z","time spent":"7.00031729s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:14.494775Z","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-04T11:01:14.995173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:15.040556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:08.039988Z","time spent":"7.000563083s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:15.496173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:15.996926Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:16.262328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00035016s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:16.262381Z","caller":"traceutil/trace.go:171","msg":"trace[404819174] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000446021s","start":"2026-02-04T11:01:14.261922Z","end":"2026-02-04T11:01:16.262368Z","steps":["trace[404819174] 'agreement among raft nodes before linearized reading'  (duration: 2.000375219s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:16.262414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:14.26191Z","time spent":"2.000498313s","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:01:16 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:16.468783Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"21c29c284eac15d8","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-02-04T11:01:16.497646Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:16.50899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.034245681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:16.509218Z","caller":"traceutil/trace.go:171","msg":"trace[1329546065] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.034526766s","start":"2026-02-04T11:01:14.47467Z","end":"2026-02-04T11:01:16.509196Z","steps":["trace[1329546065] 'agreement among raft nodes before linearized reading'  (duration: 2.034263151s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:16.509346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:14.474657Z","time spent":"2.034673259s","remote":"127.0.0.1:50180","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/04 11:01:16 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
2026/02/04 11:01:16 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
2026/02/04 11:01:16 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:16.998121Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:17.494345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.999297305s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:17.494466Z","caller":"traceutil/trace.go:171","msg":"trace[1152142602] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.999466278s","start":"2026-02-04T11:01:14.494981Z","end":"2026-02-04T11:01:17.494447Z","steps":["trace[1152142602] 'agreement among raft nodes before linearized reading'  (duration: 2.999328695s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:17.494545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:14.494969Z","time spent":"2.99955916s","remote":"127.0.0.1:50180","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/04 11:01:17 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:17.498281Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:17.998609Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:18.269348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001548095s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:18.269417Z","caller":"traceutil/trace.go:171","msg":"trace[934409624] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001658187s","start":"2026-02-04T11:01:16.267744Z","end":"2026-02-04T11:01:18.269402Z","steps":["trace[934409624] 'agreement among raft nodes before linearized reading'  (duration: 2.001563205s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:18.269463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:16.267734Z","time spent":"2.001721188s","remote":"127.0.0.1:49902","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-04T11:01:18.499179Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:18.999449Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:19.481785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.998348227s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:19.481849Z","caller":"traceutil/trace.go:171","msg":"trace[1140371398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.998482689s","start":"2026-02-04T11:01:16.483354Z","end":"2026-02-04T11:01:19.481836Z","steps":["trace[1140371398] 'agreement among raft nodes before linearized reading'  (duration: 2.998403177s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:19.481878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:16.483333Z","time spent":"2.99853931s","remote":"127.0.0.1:50180","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/04 11:01:19 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:19.500164Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:20.001205Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:20.270398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000211047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:20.270489Z","caller":"traceutil/trace.go:171","msg":"trace[1715468685] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000318459s","start":"2026-02-04T11:01:18.270152Z","end":"2026-02-04T11:01:20.270471Z","steps":["trace[1715468685] 'agreement among raft nodes before linearized reading'  (duration: 2.000207267s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:20.270535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:18.270123Z","time spent":"2.00040253s","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:01:20 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:20.501632Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:21.002501Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790682,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:21.351825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000787548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:21.351891Z","caller":"traceutil/trace.go:171","msg":"trace[1284135562] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00089258s","start":"2026-02-04T11:01:19.350985Z","end":"2026-02-04T11:01:21.351877Z","steps":["trace[1284135562] 'agreement among raft nodes before linearized reading'  (duration: 2.000812829s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:21.351923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:19.350959Z","time spent":"2.000957412s","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:01:21 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:21.495763Z","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-04T11:01:21.495898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.040136782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:01:21.495942Z","caller":"traceutil/trace.go:171","msg":"trace[252193155] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; }","duration":"7.040237923s","start":"2026-02-04T11:01:14.455686Z","end":"2026-02-04T11:01:21.495924Z","steps":["trace[252193155] 'agreement among raft nodes before linearized reading'  (duration: 7.040176491s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:21.49599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:14.455665Z","time spent":"7.040311115s","remote":"127.0.0.1:49932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/199.204.45.227\" "}
{"level":"warn","ts":"2026-02-04T11:01:21.496052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.24501166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:01:21.496075Z","caller":"traceutil/trace.go:171","msg":"trace[1907059038] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8; range_end:; }","duration":"9.245060131s","start":"2026-02-04T11:01:12.251007Z","end":"2026-02-04T11:01:21.496068Z","steps":["trace[1907059038] 'agreement among raft nodes before linearized reading'  (duration: 9.24503665s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:21.4961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:12.250994Z","time spent":"9.245100531s","remote":"127.0.0.1:49968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":0,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" "}
{"level":"warn","ts":"2026-02-04T11:01:21.496136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.656036628s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:01:21.496158Z","caller":"traceutil/trace.go:171","msg":"trace[214157878] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; }","duration":"12.656081968s","start":"2026-02-04T11:01:08.840069Z","end":"2026-02-04T11:01:21.496151Z","steps":["trace[214157878] 'agreement among raft nodes before linearized reading'  (duration: 12.656056568s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:21.496182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:08.840056Z","time spent":"12.65611965s","remote":"127.0.0.1:49766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":0,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:21.996508Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790691,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:22.045035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:15.044475Z","time spent":"7.000548525s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:22.278159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000054883s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:22.278211Z","caller":"traceutil/trace.go:171","msg":"trace[1437427205] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000141795s","start":"2026-02-04T11:01:20.278054Z","end":"2026-02-04T11:01:22.278196Z","steps":["trace[1437427205] 'agreement among raft nodes before linearized reading'  (duration: 2.000080204s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:22.278241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:20.278038Z","time spent":"2.000194846s","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:01:22 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:22.444759Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"14.967526711s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-04T11:01:22.494458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:17.495632Z","time spent":"4.998820877s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:22.68193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:15.672836Z","time spent":"7.009087565s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:23.521144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:16.521024Z","time spent":"7.000100266s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:23.521228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:16.520966Z","time spent":"7.000259959s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:23.592814Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.147883439s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-04T11:01:23.788468Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"21c29c284eac15d8","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-02-04T11:01:24.211378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.323956ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790681 > lease_revoke:<id:21c29c284eac15d8>","response":"size:28"}
{"level":"warn","ts":"2026-02-04T11:01:24.282655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000473052s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:24.282732Z","caller":"traceutil/trace.go:171","msg":"trace[466915569] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000588104s","start":"2026-02-04T11:01:22.282125Z","end":"2026-02-04T11:01:24.282714Z","steps":["trace[466915569] 'agreement among raft nodes before linearized reading'  (duration: 2.000491022s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.28278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:22.282116Z","time spent":"2.000652605s","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:01:24 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:24.485107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:19.483311Z","time spent":"5.001788868s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/04 11:01:24 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:24.737042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.961429ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790685 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:876 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:363 >> failure:<>>","response":"size:5"}
{"level":"warn","ts":"2026-02-04T11:01:24.737141Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"14.9µs","request":"header:<ID:11656050482520790687 > lease_revoke:<id:21c29c284eac15d8>","response":"size:28","error":"lease not found"}
{"level":"warn","ts":"2026-02-04T11:01:24.991258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.016964ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790690 > lease_revoke:<id:21c29c284eac167e>","response":"size:28"}
{"level":"info","ts":"2026-02-04T11:01:24.991583Z","caller":"traceutil/trace.go:171","msg":"trace[1743214672] transaction","detail":"{read_only:false; number_of_response:1; response_revision:888; }","duration":"2.942342929s","start":"2026-02-04T11:01:22.049222Z","end":"2026-02-04T11:01:24.991565Z","steps":["trace[1743214672] 'process raft request'  (duration: 2.942123075s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.991671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:22.049203Z","time spent":"2.942419991s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":45,"response count":0,"response size":569,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:806 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-04T11:01:24.991903Z","caller":"traceutil/trace.go:171","msg":"trace[1067515459] linearizableReadLoop","detail":"{readStateIndex:929; appliedIndex:917; }","duration":"3.496064608s","start":"2026-02-04T11:01:21.495831Z","end":"2026-02-04T11:01:24.991896Z","steps":["trace[1067515459] 'read index received'  (duration: 949.493001ms)","trace[1067515459] 'applied index is now lower than readState.Index'  (duration: 2.546570607s)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:24.991976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.475703205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:24.991991Z","caller":"traceutil/trace.go:171","msg":"trace[1762438475] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:888; }","duration":"4.475723346s","start":"2026-02-04T11:01:20.516263Z","end":"2026-02-04T11:01:24.991986Z","steps":["trace[1762438475] 'agreement among raft nodes before linearized reading'  (duration: 4.475685244s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.992005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:20.51623Z","time spent":"4.475771397s","remote":"127.0.0.1:55408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:24.992096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.518491465s","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-04T11:01:24.992108Z","caller":"traceutil/trace.go:171","msg":"trace[991993343] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:888; }","duration":"4.518544636s","start":"2026-02-04T11:01:20.47356Z","end":"2026-02-04T11:01:24.992105Z","steps":["trace[991993343] 'agreement among raft nodes before linearized reading'  (duration: 4.518512615s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.99212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:20.47354Z","time spent":"4.518577186s","remote":"127.0.0.1:49908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:24.992198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.59982528s","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-04T11:01:24.99221Z","caller":"traceutil/trace.go:171","msg":"trace[1433641831] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:888; }","duration":"4.599885291s","start":"2026-02-04T11:01:20.392321Z","end":"2026-02-04T11:01:24.992206Z","steps":["trace[1433641831] 'agreement among raft nodes before linearized reading'  (duration: 4.59985669s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.992222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:20.3923Z","time spent":"4.599918391s","remote":"127.0.0.1:50010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":23,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:24.992309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.714122606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7045"}
{"level":"info","ts":"2026-02-04T11:01:24.992324Z","caller":"traceutil/trace.go:171","msg":"trace[1219312603] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:888; }","duration":"4.714147507s","start":"2026-02-04T11:01:20.278173Z","end":"2026-02-04T11:01:24.992321Z","steps":["trace[1219312603] 'agreement among raft nodes before linearized reading'  (duration: 4.714115657s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.992336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:20.278168Z","time spent":"4.714164967s","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7068,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "}
{"level":"warn","ts":"2026-02-04T11:01:24.992429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.240138357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:01:24.992442Z","caller":"traceutil/trace.go:171","msg":"trace[460976676] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:888; }","duration":"5.240173738s","start":"2026-02-04T11:01:19.752264Z","end":"2026-02-04T11:01:24.992438Z","steps":["trace[460976676] 'agreement among raft nodes before linearized reading'  (duration: 5.240135248s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.992455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:19.752236Z","time spent":"5.240214469s","remote":"127.0.0.1:49812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":53,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:24.992539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.377374001s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:24.992552Z","caller":"traceutil/trace.go:171","msg":"trace[1166701079] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:888; }","duration":"6.377426713s","start":"2026-02-04T11:01:18.615121Z","end":"2026-02-04T11:01:24.992548Z","steps":["trace[1166701079] 'agreement among raft nodes before linearized reading'  (duration: 6.377405082s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.992564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:18.615092Z","time spent":"6.377467684s","remote":"127.0.0.1:50008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:24.992684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.482066628s","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-04T11:01:24.992698Z","caller":"traceutil/trace.go:171","msg":"trace[1368907268] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:888; }","duration":"8.482098319s","start":"2026-02-04T11:01:16.510596Z","end":"2026-02-04T11:01:24.992694Z","steps":["trace[1368907268] 'agreement among raft nodes before linearized reading'  (duration: 8.482069948s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.99271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:16.510586Z","time spent":"8.482121129s","remote":"127.0.0.1:50184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:24.992817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.62050866s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:01:24.992829Z","caller":"traceutil/trace.go:171","msg":"trace[264983374] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:888; }","duration":"8.62053705s","start":"2026-02-04T11:01:16.372288Z","end":"2026-02-04T11:01:24.992825Z","steps":["trace[264983374] 'agreement among raft nodes before linearized reading'  (duration: 8.620495659s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.99284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:16.37228Z","time spent":"8.62055676s","remote":"127.0.0.1:49798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":68,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:24.99291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.948301844s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:24.992922Z","caller":"traceutil/trace.go:171","msg":"trace[648845346] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:888; }","duration":"9.948331724s","start":"2026-02-04T11:01:15.044587Z","end":"2026-02-04T11:01:24.992918Z","steps":["trace[648845346] 'agreement among raft nodes before linearized reading'  (duration: 9.948310444s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.992933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:15.044581Z","time spent":"9.948349604s","remote":"127.0.0.1:50194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "}
{"level":"info","ts":"2026-02-04T11:01:24.996045Z","caller":"traceutil/trace.go:171","msg":"trace[942008105] transaction","detail":"{read_only:false; number_of_response:1; response_revision:888; }","duration":"2.309913152s","start":"2026-02-04T11:01:22.686121Z","end":"2026-02-04T11:01:24.996034Z","steps":["trace[942008105] 'process raft request'  (duration: 2.305279899s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.996101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:22.686094Z","time spent":"2.309976793s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":721,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:879 > 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-04T11:01:24.996258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.205703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:24.996279Z","caller":"traceutil/trace.go:171","msg":"trace[1865618053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:889; }","duration":"713.260454ms","start":"2026-02-04T11:01:24.283013Z","end":"2026-02-04T11:01:24.996274Z","steps":["trace[1865618053] 'agreement among raft nodes before linearized reading'  (duration: 713.213863ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.996294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:24.282991Z","time spent":"713.299324ms","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:01:24.99637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.658155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:24.996386Z","caller":"traceutil/trace.go:171","msg":"trace[58815144] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:0; response_revision:889; }","duration":"540.716146ms","start":"2026-02-04T11:01:24.455666Z","end":"2026-02-04T11:01:24.996382Z","steps":["trace[58815144] 'agreement among raft nodes before linearized reading'  (duration: 540.692626ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.996398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:24.455644Z","time spent":"540.750886ms","remote":"127.0.0.1:49932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.227\" "}
{"level":"warn","ts":"2026-02-04T11:01:24.996559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.068456318s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:01:24.996577Z","caller":"traceutil/trace.go:171","msg":"trace[790549243] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:889; }","duration":"2.068511069s","start":"2026-02-04T11:01:22.928062Z","end":"2026-02-04T11:01:24.996573Z","steps":["trace[790549243] 'agreement among raft nodes before linearized reading'  (duration: 2.068479828s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.996603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:22.928047Z","time spent":"2.068552189s","remote":"127.0.0.1:55398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":2,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:24.996721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.673204971s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:24.996735Z","caller":"traceutil/trace.go:171","msg":"trace[1026272257] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:889; }","duration":"2.673229761s","start":"2026-02-04T11:01:22.323501Z","end":"2026-02-04T11:01:24.996731Z","steps":["trace[1026272257] 'agreement among raft nodes before linearized reading'  (duration: 2.673207521s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:24.996747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:22.323496Z","time spent":"2.673248081s","remote":"127.0.0.1:49990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:24.999757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.49769959s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-04T11:01:24.999877Z","caller":"traceutil/trace.go:171","msg":"trace[1392443229] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8; range_end:; response_count:1; response_revision:889; }","duration":"3.497826612s","start":"2026-02-04T11:01:21.502036Z","end":"2026-02-04T11:01:24.999863Z","steps":["trace[1392443229] 'agreement among raft nodes before linearized reading'  (duration: 3.494024076s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:25.005309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:21.501986Z","time spent":"3.499290942s","remote":"127.0.0.1:49968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" "}
{"level":"info","ts":"2026-02-04T11:01:25.17235Z","caller":"traceutil/trace.go:171","msg":"trace[43063109] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"160.24957ms","start":"2026-02-04T11:01:25.012083Z","end":"2026-02-04T11:01:25.172332Z","steps":["trace[43063109] 'process raft request'  (duration: 160.2135ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:25.172586Z","caller":"traceutil/trace.go:171","msg":"trace[1687134308] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"162.856872ms","start":"2026-02-04T11:01:25.009722Z","end":"2026-02-04T11:01:25.172579Z","steps":["trace[1687134308] 'process raft request'  (duration: 162.424464ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:25.172852Z","caller":"traceutil/trace.go:171","msg":"trace[2113990061] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"160.848261ms","start":"2026-02-04T11:01:25.011996Z","end":"2026-02-04T11:01:25.172844Z","steps":["trace[2113990061] 'process raft request'  (duration: 160.26797ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:25.173239Z","caller":"traceutil/trace.go:171","msg":"trace[774885005] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:936; }","duration":"145.317ms","start":"2026-02-04T11:01:25.027915Z","end":"2026-02-04T11:01:25.173232Z","steps":["trace[774885005] 'read index received'  (duration: 145.31441ms)","trace[774885005] 'applied index is now lower than readState.Index'  (duration: 2.14µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:25.173297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.258561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:25.173313Z","caller":"traceutil/trace.go:171","msg":"trace[1716617189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:892; }","duration":"162.294472ms","start":"2026-02-04T11:01:25.011013Z","end":"2026-02-04T11:01:25.173307Z","steps":["trace[1716617189] 'agreement among raft nodes before linearized reading'  (duration: 162.255421ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:25.184638Z","caller":"traceutil/trace.go:171","msg":"trace[776924587] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"151.568656ms","start":"2026-02-04T11:01:25.033058Z","end":"2026-02-04T11:01:25.184626Z","steps":["trace[776924587] 'process raft request'  (duration: 151.531945ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:25.1848Z","caller":"traceutil/trace.go:171","msg":"trace[2004326784] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"155.29962ms","start":"2026-02-04T11:01:25.029495Z","end":"2026-02-04T11:01:25.184795Z","steps":["trace[2004326784] 'process raft request'  (duration: 155.040125ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:25.357526Z","caller":"traceutil/trace.go:171","msg":"trace[2000207676] linearizableReadLoop","detail":"{readStateIndex:939; appliedIndex:938; }","duration":"172.442086ms","start":"2026-02-04T11:01:25.185067Z","end":"2026-02-04T11:01:25.357509Z","steps":["trace[2000207676] 'read index received'  (duration: 116.352568ms)","trace[2000207676] 'applied index is now lower than readState.Index'  (duration: 56.088838ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:25.357606Z","caller":"traceutil/trace.go:171","msg":"trace[402293334] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"179.026957ms","start":"2026-02-04T11:01:25.178574Z","end":"2026-02-04T11:01:25.357601Z","steps":["trace[402293334] 'process raft request'  (duration: 122.881999ms)","trace[402293334] 'compare'  (duration: 55.976435ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:25.357846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.336953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-02-04T11:01:25.357906Z","caller":"traceutil/trace.go:171","msg":"trace[2036415234] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:895; }","duration":"169.425854ms","start":"2026-02-04T11:01:25.188465Z","end":"2026-02-04T11:01:25.357891Z","steps":["trace[2036415234] 'agreement among raft nodes before linearized reading'  (duration: 169.261891ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:25.35792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.828363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7237"}
{"level":"info","ts":"2026-02-04T11:01:25.357942Z","caller":"traceutil/trace.go:171","msg":"trace[1885596836] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:895; }","duration":"180.882604ms","start":"2026-02-04T11:01:25.177053Z","end":"2026-02-04T11:01:25.357936Z","steps":["trace[1885596836] 'agreement among raft nodes before linearized reading'  (duration: 180.792552ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:25.623644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.119695ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790714 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" mod_revision:890 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" value_size:672 lease:2432678445666014589 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:01:25.623709Z","caller":"traceutil/trace.go:171","msg":"trace[153760877] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"261.055726ms","start":"2026-02-04T11:01:25.362642Z","end":"2026-02-04T11:01:25.623698Z","steps":["trace[153760877] 'process raft request'  (duration: 126.836539ms)","trace[153760877] 'compare'  (duration: 133.938622ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:25.637223Z","caller":"traceutil/trace.go:171","msg":"trace[1067207811] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"271.16184ms","start":"2026-02-04T11:01:25.366051Z","end":"2026-02-04T11:01:25.637213Z","steps":["trace[1067207811] 'process raft request'  (duration: 271.099879ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:25.637366Z","caller":"traceutil/trace.go:171","msg":"trace[1210885985] linearizableReadLoop","detail":"{readStateIndex:941; appliedIndex:941; }","duration":"113.516052ms","start":"2026-02-04T11:01:25.523838Z","end":"2026-02-04T11:01:25.637354Z","steps":["trace[1210885985] 'read index received'  (duration: 113.499801ms)","trace[1210885985] 'applied index is now lower than readState.Index'  (duration: 3.881µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:25.637455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.594533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:25.637476Z","caller":"traceutil/trace.go:171","msg":"trace[740945125] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:897; }","duration":"113.657825ms","start":"2026-02-04T11:01:25.523813Z","end":"2026-02-04T11:01:25.63747Z","steps":["trace[740945125] 'agreement among raft nodes before linearized reading'  (duration: 113.579964ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:25.79205Z","caller":"traceutil/trace.go:171","msg":"trace[845797749] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"143.685278ms","start":"2026-02-04T11:01:25.648347Z","end":"2026-02-04T11:01:25.792032Z","steps":["trace[845797749] 'process raft request'  (duration: 89.309375ms)","trace[845797749] 'compare'  (duration: 54.030876ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:25.792115Z","caller":"traceutil/trace.go:171","msg":"trace[1596306372] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"143.570015ms","start":"2026-02-04T11:01:25.648535Z","end":"2026-02-04T11:01:25.792105Z","steps":["trace[1596306372] 'process raft request'  (duration: 143.396482ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:26.013429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.01974ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790725 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-scheduler-instance.1891062509b0b076\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-scheduler-instance.1891062509b0b076\" value_size:735 lease:2432678445666014589 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:01:26.013504Z","caller":"traceutil/trace.go:171","msg":"trace[729902509] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"187.326974ms","start":"2026-02-04T11:01:25.826164Z","end":"2026-02-04T11:01:26.013491Z","steps":["trace[729902509] 'process raft request'  (duration: 84.201692ms)","trace[729902509] 'compare'  (duration: 102.872477ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:26.194319Z","caller":"traceutil/trace.go:171","msg":"trace[183570471] linearizableReadLoop","detail":"{readStateIndex:947; appliedIndex:946; }","duration":"178.988297ms","start":"2026-02-04T11:01:26.015313Z","end":"2026-02-04T11:01:26.194302Z","steps":["trace[183570471] 'read index received'  (duration: 122.534693ms)","trace[183570471] 'applied index is now lower than readState.Index'  (duration: 56.452994ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:26.1944Z","caller":"traceutil/trace.go:171","msg":"trace[321482082] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"364.841033ms","start":"2026-02-04T11:01:25.829551Z","end":"2026-02-04T11:01:26.194392Z","steps":["trace[321482082] 'process raft request'  (duration: 308.336718ms)","trace[321482082] 'compare'  (duration: 56.348932ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:26.194456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:25.82954Z","time spent":"364.873153ms","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4865,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:414 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:4813 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-vip-instance\" > >"}
{"level":"warn","ts":"2026-02-04T11:01:26.194582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.265383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-04T11:01:26.194604Z","caller":"traceutil/trace.go:171","msg":"trace[2080985472] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8; range_end:; response_count:1; response_revision:903; }","duration":"179.307073ms","start":"2026-02-04T11:01:26.015289Z","end":"2026-02-04T11:01:26.194596Z","steps":["trace[2080985472] 'agreement among raft nodes before linearized reading'  (duration: 179.241872ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:26.369238Z","caller":"traceutil/trace.go:171","msg":"trace[1755733950] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"159.291721ms","start":"2026-02-04T11:01:26.209929Z","end":"2026-02-04T11:01:26.369221Z","steps":["trace[1755733950] 'process raft request'  (duration: 127.250947ms)","trace[1755733950] 'compare'  (duration: 31.82893ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:26.628706Z","caller":"traceutil/trace.go:171","msg":"trace[953794011] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"253.823141ms","start":"2026-02-04T11:01:26.374864Z","end":"2026-02-04T11:01:26.628687Z","steps":["trace[953794011] 'process raft request'  (duration: 227.494862ms)","trace[953794011] 'compare'  (duration: 26.237707ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:26.62905Z","caller":"traceutil/trace.go:171","msg":"trace[112576936] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"169.031756ms","start":"2026-02-04T11:01:26.460004Z","end":"2026-02-04T11:01:26.629035Z","steps":["trace[112576936] 'process raft request'  (duration: 168.861053ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:27.065183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.637746ms","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-04T11:01:27.065256Z","caller":"traceutil/trace.go:171","msg":"trace[1284247879] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:909; }","duration":"129.719398ms","start":"2026-02-04T11:01:26.935526Z","end":"2026-02-04T11:01:27.065245Z","steps":["trace[1284247879] 'range keys from in-memory index tree'  (duration: 129.627996ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:27.065321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.161376ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790738 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-vip-instance.189106252fbae080\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-vip-instance.189106252fbae080\" value_size:665 lease:2432678445666014589 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:01:27.065428Z","caller":"traceutil/trace.go:171","msg":"trace[1444328530] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:953; }","duration":"342.739618ms","start":"2026-02-04T11:01:26.722673Z","end":"2026-02-04T11:01:27.065412Z","steps":["trace[1444328530] 'read index received'  (duration: 8.416749ms)","trace[1444328530] 'applied index is now lower than readState.Index'  (duration: 334.308019ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:27.065536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.85484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:27.065564Z","caller":"traceutil/trace.go:171","msg":"trace[1414874947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:910; }","duration":"342.914392ms","start":"2026-02-04T11:01:26.722645Z","end":"2026-02-04T11:01:27.065559Z","steps":["trace[1414874947] 'agreement among raft nodes before linearized reading'  (duration: 342.81544ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:27.065585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:26.722631Z","time spent":"342.950233ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-04T11:01:27.065754Z","caller":"traceutil/trace.go:171","msg":"trace[409976078] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"433.568214ms","start":"2026-02-04T11:01:26.632178Z","end":"2026-02-04T11:01:27.065746Z","steps":["trace[409976078] 'process raft request'  (duration: 98.928198ms)","trace[409976078] 'compare'  (duration: 333.915032ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:27.065796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:26.632166Z","time spent":"433.607684ms","remote":"127.0.0.1:49968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-vip-instance.189106252fbae080\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-vip-instance.189106252fbae080\" value_size:665 lease:2432678445666014589 >> failure:<>"}
{"level":"warn","ts":"2026-02-04T11:01:28.045976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.354628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:28.046046Z","caller":"traceutil/trace.go:171","msg":"trace[1260693190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:910; }","duration":"319.46467ms","start":"2026-02-04T11:01:27.726564Z","end":"2026-02-04T11:01:28.046028Z","steps":["trace[1260693190] 'range keys from in-memory index tree'  (duration: 319.307697ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:28.046084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:27.726551Z","time spent":"319.524071ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:01:28.046174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.313171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:01:28.046205Z","caller":"traceutil/trace.go:171","msg":"trace[1555176836] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:910; }","duration":"566.359411ms","start":"2026-02-04T11:01:27.479834Z","end":"2026-02-04T11:01:28.046193Z","steps":["trace[1555176836] 'count revisions from in-memory index tree'  (duration: 566.27284ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:28.046227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:27.479817Z","time spent":"566.405413ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:28.045992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.884113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-04T11:01:28.046493Z","caller":"traceutil/trace.go:171","msg":"trace[1666738150] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:910; }","duration":"772.423833ms","start":"2026-02-04T11:01:27.274057Z","end":"2026-02-04T11:01:28.046481Z","steps":["trace[1666738150] 'count revisions from in-memory index tree'  (duration: 771.834801ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:28.046533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:27.274045Z","time spent":"772.473814ms","remote":"127.0.0.1:49954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:29.728873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.526031ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790747 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-2nckh.189106135e63c848\" mod_revision:543 > success:<request_put:<key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-2nckh.189106135e63c848\" value_size:667 lease:2432678445666014589 >> failure:<request_range:<key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-2nckh.189106135e63c848\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:01:29.728966Z","caller":"traceutil/trace.go:171","msg":"trace[1674634807] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"919.896257ms","start":"2026-02-04T11:01:28.809032Z","end":"2026-02-04T11:01:29.728928Z","steps":["trace[1674634807] 'read index received'  (duration: 81.216743ms)","trace[1674634807] 'applied index is now lower than readState.Index'  (duration: 838.678874ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:29.729014Z","caller":"traceutil/trace.go:171","msg":"trace[1757399852] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"953.36272ms","start":"2026-02-04T11:01:28.775646Z","end":"2026-02-04T11:01:29.729008Z","steps":["trace[1757399852] 'process raft request'  (duration: 114.654045ms)","trace[1757399852] 'compare'  (duration: 838.207225ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:29.729046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:28.775632Z","time spent":"953.39661ms","remote":"127.0.0.1:49968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-2nckh.189106135e63c848\" mod_revision:543 > success:<request_put:<key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-2nckh.189106135e63c848\" value_size:667 lease:2432678445666014589 >> failure:<request_range:<key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-2nckh.189106135e63c848\" > >"}
{"level":"warn","ts":"2026-02-04T11:01:29.72918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.145283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:29.729199Z","caller":"traceutil/trace.go:171","msg":"trace[1177158313] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:912; }","duration":"920.191363ms","start":"2026-02-04T11:01:28.809003Z","end":"2026-02-04T11:01:29.729195Z","steps":["trace[1177158313] 'agreement among raft nodes before linearized reading'  (duration: 920.147322ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:29.729213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:28.80899Z","time spent":"920.218994ms","remote":"127.0.0.1:49974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:29.729303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.07992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-04T11:01:29.72932Z","caller":"traceutil/trace.go:171","msg":"trace[798321307] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:912; }","duration":"818.120692ms","start":"2026-02-04T11:01:28.911196Z","end":"2026-02-04T11:01:29.729317Z","steps":["trace[798321307] 'agreement among raft nodes before linearized reading'  (duration: 818.086831ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:29.729334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:28.91117Z","time spent":"818.160702ms","remote":"127.0.0.1:49992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-04T11:01:29.729523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.302328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4879"}
{"level":"info","ts":"2026-02-04T11:01:29.729542Z","caller":"traceutil/trace.go:171","msg":"trace[2049719858] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:912; }","duration":"107.342368ms","start":"2026-02-04T11:01:29.622195Z","end":"2026-02-04T11:01:29.729538Z","steps":["trace[2049719858] 'agreement among raft nodes before linearized reading'  (duration: 107.289557ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:29.729613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.781902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:29.729628Z","caller":"traceutil/trace.go:171","msg":"trace[1617158786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:912; }","duration":"375.823033ms","start":"2026-02-04T11:01:29.353802Z","end":"2026-02-04T11:01:29.729625Z","steps":["trace[1617158786] 'agreement among raft nodes before linearized reading'  (duration: 375.800422ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:29.729639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:29.353786Z","time spent":"375.851293ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:01:29.729721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.640662ms","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-04T11:01:29.729736Z","caller":"traceutil/trace.go:171","msg":"trace[871612520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:912; }","duration":"604.663512ms","start":"2026-02-04T11:01:29.125069Z","end":"2026-02-04T11:01:29.729733Z","steps":["trace[871612520] 'agreement among raft nodes before linearized reading'  (duration: 604.624101ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:29.729748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:29.125067Z","time spent":"604.678392ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-04T11:01:29.729826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.763984ms","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-04T11:01:29.729842Z","caller":"traceutil/trace.go:171","msg":"trace[627110677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:912; }","duration":"604.802345ms","start":"2026-02-04T11:01:29.125036Z","end":"2026-02-04T11:01:29.729839Z","steps":["trace[627110677] 'agreement among raft nodes before linearized reading'  (duration: 604.765174ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:29.729853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:29.125024Z","time spent":"604.826845ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-04T11:01:30.259537Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790749,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:30.717985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.68592ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790750 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-vip-instance.189106263000d12e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-vip-instance.189106263000d12e\" value_size:615 lease:2432678445666014589 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:01:30.718058Z","caller":"traceutil/trace.go:171","msg":"trace[449277681] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"984.801561ms","start":"2026-02-04T11:01:29.733244Z","end":"2026-02-04T11:01:30.718045Z","steps":["trace[449277681] 'process raft request'  (duration: 712.011589ms)","trace[449277681] 'compare'  (duration: 272.503216ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:30.718102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:29.733233Z","time spent":"984.855152ms","remote":"127.0.0.1:49968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":696,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-vip-instance.189106263000d12e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-vip-instance.189106263000d12e\" value_size:615 lease:2432678445666014589 >> failure:<>"}
{"level":"warn","ts":"2026-02-04T11:01:31.813056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.308728ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790751 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:903 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:4645 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-vip-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:01:31.813183Z","caller":"traceutil/trace.go:171","msg":"trace[1582303360] linearizableReadLoop","detail":"{readStateIndex:960; appliedIndex:956; }","duration":"2.053813994s","start":"2026-02-04T11:01:29.759359Z","end":"2026-02-04T11:01:31.813173Z","steps":["trace[1582303360] 'read index received'  (duration: 685.856164ms)","trace[1582303360] 'applied index is now lower than readState.Index'  (duration: 1.36795703s)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:31.813326Z","caller":"traceutil/trace.go:171","msg":"trace[1452824011] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"2.076870508s","start":"2026-02-04T11:01:29.736448Z","end":"2026-02-04T11:01:31.813319Z","steps":["trace[1452824011] 'process raft request'  (duration: 1.637248593s)","trace[1452824011] 'compare'  (duration: 439.090954ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:31.813358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:29.73644Z","time spent":"2.076901709s","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4697,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:903 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:4645 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-vip-instance\" > >"}
{"level":"info","ts":"2026-02-04T11:01:31.813494Z","caller":"traceutil/trace.go:171","msg":"trace[928802686] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"2.073091041s","start":"2026-02-04T11:01:29.740397Z","end":"2026-02-04T11:01:31.813489Z","steps":["trace[928802686] 'process raft request'  (duration: 2.072720153s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:31.813523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:29.740392Z","time spent":"2.073116712s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:881 > 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":"info","ts":"2026-02-04T11:01:31.813583Z","caller":"traceutil/trace.go:171","msg":"trace[1408346088] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"2.071420158s","start":"2026-02-04T11:01:29.742158Z","end":"2026-02-04T11:01:31.813578Z","steps":["trace[1408346088] 'process raft request'  (duration: 2.070991659s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:31.813605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:29.742152Z","time spent":"2.071440709s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:883 > 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-04T11:01:31.813709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.054343306s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:473"}
{"level":"info","ts":"2026-02-04T11:01:31.813722Z","caller":"traceutil/trace.go:171","msg":"trace[890390214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:916; }","duration":"2.054382606s","start":"2026-02-04T11:01:29.759335Z","end":"2026-02-04T11:01:31.813718Z","steps":["trace[890390214] 'agreement among raft nodes before linearized reading'  (duration: 2.054315715s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:31.813735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:29.759325Z","time spent":"2.054407216s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-04T11:01:31.813799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.954218263s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:31.813814Z","caller":"traceutil/trace.go:171","msg":"trace[1548764760] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:916; }","duration":"1.954253784s","start":"2026-02-04T11:01:29.859553Z","end":"2026-02-04T11:01:31.813807Z","steps":["trace[1548764760] 'agreement among raft nodes before linearized reading'  (duration: 1.954233393s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:31.813826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:29.859541Z","time spent":"1.954281214s","remote":"127.0.0.1:50112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:31.814041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.050614ms","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-04T11:01:31.814056Z","caller":"traceutil/trace.go:171","msg":"trace[510261113] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:916; }","duration":"866.101626ms","start":"2026-02-04T11:01:30.94795Z","end":"2026-02-04T11:01:31.814051Z","steps":["trace[510261113] 'agreement among raft nodes before linearized reading'  (duration: 866.037314ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:31.814072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:30.947929Z","time spent":"866.138506ms","remote":"127.0.0.1:50006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":118,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:31.81415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085462874s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:31.814162Z","caller":"traceutil/trace.go:171","msg":"trace[971642734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:916; }","duration":"1.085485915s","start":"2026-02-04T11:01:30.728673Z","end":"2026-02-04T11:01:31.814159Z","steps":["trace[971642734] 'agreement among raft nodes before linearized reading'  (duration: 1.085467524s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:31.814173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:30.728667Z","time spent":"1.085503795s","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:01:31.814258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.09221135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-2nckh.18910613615ed1c3\" ","response":"range_response_count:1 size:778"}
{"level":"info","ts":"2026-02-04T11:01:31.814271Z","caller":"traceutil/trace.go:171","msg":"trace[1929395247] range","detail":"{range_begin:/registry/events/kube-system/cilium-operator-7fcd8d6ffd-2nckh.18910613615ed1c3; range_end:; response_count:1; response_revision:916; }","duration":"1.09224188s","start":"2026-02-04T11:01:30.722025Z","end":"2026-02-04T11:01:31.814267Z","steps":["trace[1929395247] 'agreement among raft nodes before linearized reading'  (duration: 1.092201409s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:31.814282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:30.722015Z","time spent":"1.092264241s","remote":"127.0.0.1:49968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":801,"request content":"key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-2nckh.18910613615ed1c3\" "}
{"level":"warn","ts":"2026-02-04T11:01:31.814355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.723827563s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:31.814367Z","caller":"traceutil/trace.go:171","msg":"trace[1491826621] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:916; }","duration":"1.723862573s","start":"2026-02-04T11:01:30.090501Z","end":"2026-02-04T11:01:31.814364Z","steps":["trace[1491826621] 'agreement among raft nodes before linearized reading'  (duration: 1.723837372s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:31.81438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:30.090488Z","time spent":"1.723888833s","remote":"127.0.0.1:49938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-02-04T11:01:32.015183Z","caller":"traceutil/trace.go:171","msg":"trace[1303971429] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"103.128952ms","start":"2026-02-04T11:01:31.912028Z","end":"2026-02-04T11:01:32.015157Z","steps":["trace[1303971429] 'process raft request'  (duration: 102.802355ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.25103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.92458ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790762 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-2nckh\" mod_revision:905 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-2nckh\" value_size:6711 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-2nckh\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:01:32.251274Z","caller":"traceutil/trace.go:171","msg":"trace[1107930750] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"226.564533ms","start":"2026-02-04T11:01:32.0247Z","end":"2026-02-04T11:01:32.251264Z","steps":["trace[1107930750] 'process raft request'  (duration: 226.542352ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:32.251573Z","caller":"traceutil/trace.go:171","msg":"trace[206590042] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"327.123974ms","start":"2026-02-04T11:01:31.924439Z","end":"2026-02-04T11:01:32.251563Z","steps":["trace[206590042] 'process raft request'  (duration: 213.617542ms)","trace[206590042] 'compare'  (duration: 112.858629ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:32.251652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:31.92443Z","time spent":"327.202945ms","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6778,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-2nckh\" mod_revision:905 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-2nckh\" value_size:6711 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-2nckh\" > >"}
{"level":"info","ts":"2026-02-04T11:01:32.252728Z","caller":"traceutil/trace.go:171","msg":"trace[1567844751] linearizableReadLoop","detail":"{readStateIndex:966; appliedIndex:963; }","duration":"237.563183ms","start":"2026-02-04T11:01:32.015139Z","end":"2026-02-04T11:01:32.252702Z","steps":["trace[1567844751] 'read index received'  (duration: 122.926739ms)","trace[1567844751] 'applied index is now lower than readState.Index'  (duration: 114.632504ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:32.252876Z","caller":"traceutil/trace.go:171","msg":"trace[1728270888] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"318.317757ms","start":"2026-02-04T11:01:31.934547Z","end":"2026-02-04T11:01:32.252864Z","steps":["trace[1728270888] 'process raft request'  (duration: 316.646683ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.253014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:31.934539Z","time spent":"318.360747ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:915 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-04T11:01:32.25326Z","caller":"traceutil/trace.go:171","msg":"trace[947184351] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"318.665904ms","start":"2026-02-04T11:01:31.934584Z","end":"2026-02-04T11:01:32.25325Z","steps":["trace[947184351] 'process raft request'  (duration: 316.639263ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.253301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:31.934581Z","time spent":"318.697405ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:916 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-04T11:01:32.253421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.602527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"}
{"level":"info","ts":"2026-02-04T11:01:32.253448Z","caller":"traceutil/trace.go:171","msg":"trace[2062019262] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"255.927264ms","start":"2026-02-04T11:01:31.997515Z","end":"2026-02-04T11:01:32.253442Z","steps":["trace[2062019262] 'agreement among raft nodes before linearized reading'  (duration: 255.862453ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.253589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.255512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"}
{"level":"info","ts":"2026-02-04T11:01:32.253606Z","caller":"traceutil/trace.go:171","msg":"trace[989007063] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"267.283162ms","start":"2026-02-04T11:01:31.986319Z","end":"2026-02-04T11:01:32.253602Z","steps":["trace[989007063] 'agreement among raft nodes before linearized reading'  (duration: 267.218101ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.253689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.822904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"}
{"level":"info","ts":"2026-02-04T11:01:32.253705Z","caller":"traceutil/trace.go:171","msg":"trace[72854208] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"269.845704ms","start":"2026-02-04T11:01:31.983856Z","end":"2026-02-04T11:01:32.253702Z","steps":["trace[72854208] 'agreement among raft nodes before linearized reading'  (duration: 269.799363ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.253818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.979526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"}
{"level":"info","ts":"2026-02-04T11:01:32.253835Z","caller":"traceutil/trace.go:171","msg":"trace[1060430630] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"270.036028ms","start":"2026-02-04T11:01:31.983795Z","end":"2026-02-04T11:01:32.253831Z","steps":["trace[1060430630] 'agreement among raft nodes before linearized reading'  (duration: 269.976316ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.253915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.919605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"}
{"level":"info","ts":"2026-02-04T11:01:32.253932Z","caller":"traceutil/trace.go:171","msg":"trace[274051382] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"277.942135ms","start":"2026-02-04T11:01:31.975985Z","end":"2026-02-04T11:01:32.253927Z","steps":["trace[274051382] 'agreement among raft nodes before linearized reading'  (duration: 277.901925ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.254033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.055067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"}
{"level":"info","ts":"2026-02-04T11:01:32.254049Z","caller":"traceutil/trace.go:171","msg":"trace[1264211151] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"278.094549ms","start":"2026-02-04T11:01:31.975951Z","end":"2026-02-04T11:01:32.254046Z","steps":["trace[1264211151] 'agreement among raft nodes before linearized reading'  (duration: 278.044568ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.254142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.707344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-02-04T11:01:32.25416Z","caller":"traceutil/trace.go:171","msg":"trace[1018763737] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"308.748424ms","start":"2026-02-04T11:01:31.945407Z","end":"2026-02-04T11:01:32.254155Z","steps":["trace[1018763737] 'agreement among raft nodes before linearized reading'  (duration: 308.690833ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.254177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:31.945392Z","time spent":"308.780155ms","remote":"127.0.0.1:49948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4106,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "}
{"level":"warn","ts":"2026-02-04T11:01:32.254259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.857829ms","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-04T11:01:32.254274Z","caller":"traceutil/trace.go:171","msg":"trace[202739881] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"329.884709ms","start":"2026-02-04T11:01:31.924386Z","end":"2026-02-04T11:01:32.254271Z","steps":["trace[202739881] 'agreement among raft nodes before linearized reading'  (duration: 329.842358ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.254287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:31.92438Z","time spent":"329.903669ms","remote":"127.0.0.1:49948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4203,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "}
{"level":"warn","ts":"2026-02-04T11:01:32.254363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.681076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-02-04T11:01:32.254378Z","caller":"traceutil/trace.go:171","msg":"trace[231769431] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:923; }","duration":"336.703236ms","start":"2026-02-04T11:01:31.917671Z","end":"2026-02-04T11:01:32.254375Z","steps":["trace[231769431] 'agreement among raft nodes before linearized reading'  (duration: 336.663885ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.254389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:31.917669Z","time spent":"336.717866ms","remote":"127.0.0.1:50180","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-04T11:01:32.254595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.371937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"}
{"level":"info","ts":"2026-02-04T11:01:32.254613Z","caller":"traceutil/trace.go:171","msg":"trace[868066159] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"204.419138ms","start":"2026-02-04T11:01:32.05019Z","end":"2026-02-04T11:01:32.254609Z","steps":["trace[868066159] 'agreement among raft nodes before linearized reading'  (duration: 204.341056ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:32.254777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.591102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"}
{"level":"info","ts":"2026-02-04T11:01:32.254795Z","caller":"traceutil/trace.go:171","msg":"trace[1863059889] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:923; }","duration":"113.631513ms","start":"2026-02-04T11:01:32.14116Z","end":"2026-02-04T11:01:32.254791Z","steps":["trace[1863059889] 'agreement among raft nodes before linearized reading'  (duration: 113.541332ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:32.401071Z","caller":"traceutil/trace.go:171","msg":"trace[1176330782] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"118.246726ms","start":"2026-02-04T11:01:32.282805Z","end":"2026-02-04T11:01:32.401052Z","steps":["trace[1176330782] 'process raft request'  (duration: 113.262566ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:32.607604Z","caller":"traceutil/trace.go:171","msg":"trace[561037287] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"202.273184ms","start":"2026-02-04T11:01:32.405312Z","end":"2026-02-04T11:01:32.607585Z","steps":["trace[561037287] 'process raft request'  (duration: 170.467976ms)","trace[561037287] 'compare'  (duration: 31.725547ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:32.801249Z","caller":"traceutil/trace.go:171","msg":"trace[1109504419] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:970; }","duration":"156.503265ms","start":"2026-02-04T11:01:32.644727Z","end":"2026-02-04T11:01:32.801231Z","steps":["trace[1109504419] 'read index received'  (duration: 128.265987ms)","trace[1109504419] 'applied index is now lower than readState.Index'  (duration: 28.236638ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:32.801323Z","caller":"traceutil/trace.go:171","msg":"trace[378325065] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"188.163861ms","start":"2026-02-04T11:01:32.613153Z","end":"2026-02-04T11:01:32.801317Z","steps":["trace[378325065] 'process raft request'  (duration: 159.883553ms)","trace[378325065] 'compare'  (duration: 27.958132ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:32.801512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.77272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4362"}
{"level":"info","ts":"2026-02-04T11:01:32.801532Z","caller":"traceutil/trace.go:171","msg":"trace[1337185311] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:927; }","duration":"156.838071ms","start":"2026-02-04T11:01:32.64469Z","end":"2026-02-04T11:01:32.801528Z","steps":["trace[1337185311] 'agreement among raft nodes before linearized reading'  (duration: 156.736809ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:32.992973Z","caller":"traceutil/trace.go:171","msg":"trace[690749605] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"183.59794ms","start":"2026-02-04T11:01:32.809359Z","end":"2026-02-04T11:01:32.992957Z","steps":["trace[690749605] 'process raft request'  (duration: 117.161575ms)","trace[690749605] 'compare'  (duration: 66.336273ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:33.246329Z","caller":"traceutil/trace.go:171","msg":"trace[2102026794] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"220.277367ms","start":"2026-02-04T11:01:33.026035Z","end":"2026-02-04T11:01:33.246312Z","steps":["trace[2102026794] 'process raft request'  (duration: 142.067456ms)","trace[2102026794] 'compare'  (duration: 76.905986ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:33.453092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.374266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:33.453161Z","caller":"traceutil/trace.go:171","msg":"trace[1643842554] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:929; }","duration":"101.478619ms","start":"2026-02-04T11:01:33.351667Z","end":"2026-02-04T11:01:33.453146Z","steps":["trace[1643842554] 'range keys from in-memory index tree'  (duration: 101.288985ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:33.453297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.5197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:33.453827Z","caller":"traceutil/trace.go:171","msg":"trace[1597898301] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:929; }","duration":"102.087181ms","start":"2026-02-04T11:01:33.351727Z","end":"2026-02-04T11:01:33.453814Z","steps":["trace[1597898301] 'range keys from in-memory index tree'  (duration: 101.487089ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:34.50814Z","caller":"traceutil/trace.go:171","msg":"trace[1966777781] linearizableReadLoop","detail":"{readStateIndex:975; appliedIndex:974; }","duration":"110.240896ms","start":"2026-02-04T11:01:34.397883Z","end":"2026-02-04T11:01:34.508124Z","steps":["trace[1966777781] 'read index received'  (duration: 64.588608ms)","trace[1966777781] 'applied index is now lower than readState.Index'  (duration: 45.651608ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:34.508272Z","caller":"traceutil/trace.go:171","msg":"trace[1491266897] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"118.269667ms","start":"2026-02-04T11:01:34.389995Z","end":"2026-02-04T11:01:34.508265Z","steps":["trace[1491266897] 'process raft request'  (duration: 103.438698ms)","trace[1491266897] 'compare'  (duration: 14.519962ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:34.508399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.504932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:34.508422Z","caller":"traceutil/trace.go:171","msg":"trace[1331783970] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:931; }","duration":"110.557462ms","start":"2026-02-04T11:01:34.397858Z","end":"2026-02-04T11:01:34.508416Z","steps":["trace[1331783970] 'agreement among raft nodes before linearized reading'  (duration: 110.510751ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:34.738357Z","caller":"traceutil/trace.go:171","msg":"trace[289911147] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"201.52663ms","start":"2026-02-04T11:01:34.536817Z","end":"2026-02-04T11:01:34.738344Z","steps":["trace[289911147] 'process raft request'  (duration: 201.495749ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:01:34.738421Z","caller":"traceutil/trace.go:171","msg":"trace[1732415435] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"223.730406ms","start":"2026-02-04T11:01:34.51468Z","end":"2026-02-04T11:01:34.738411Z","steps":["trace[1732415435] 'process raft request'  (duration: 134.419111ms)","trace[1732415435] 'compare'  (duration: 89.113311ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:01:34.738502Z","caller":"traceutil/trace.go:171","msg":"trace[1386192539] linearizableReadLoop","detail":"{readStateIndex:977; appliedIndex:976; }","duration":"206.48628ms","start":"2026-02-04T11:01:34.532009Z","end":"2026-02-04T11:01:34.738496Z","steps":["trace[1386192539] 'read index received'  (duration: 4.399629ms)","trace[1386192539] 'applied index is now lower than readState.Index'  (duration: 202.086131ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:34.73908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.059731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"}
{"level":"info","ts":"2026-02-04T11:01:34.739104Z","caller":"traceutil/trace.go:171","msg":"trace[2084012639] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:933; }","duration":"207.128803ms","start":"2026-02-04T11:01:34.531969Z","end":"2026-02-04T11:01:34.739097Z","steps":["trace[2084012639] 'agreement among raft nodes before linearized reading'  (duration: 206.545221ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:43.037972Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:43.538591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:44.038802Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:44.539898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:45.04093Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:45.541186Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:45.726434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000136285s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:45.726516Z","caller":"traceutil/trace.go:171","msg":"trace[462867165] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000245567s","start":"2026-02-04T11:01:43.72625Z","end":"2026-02-04T11:01:45.726495Z","steps":["trace[462867165] 'agreement among raft nodes before linearized reading'  (duration: 2.000151585s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:45.72657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:43.726238Z","time spent":"2.000323389s","remote":"127.0.0.1:49902","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-04T11:01:46.042228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:46.543369Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:47.044035Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:47.544979Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:47.72819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000508962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:47.728238Z","caller":"traceutil/trace.go:171","msg":"trace[729570324] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000614916s","start":"2026-02-04T11:01:45.727611Z","end":"2026-02-04T11:01:47.728226Z","steps":["trace[729570324] 'agreement among raft nodes before linearized reading'  (duration: 2.000551154s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:47.728268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:45.727574Z","time spent":"2.000689027s","remote":"127.0.0.1:49906","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-04T11:01:47.844992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000588252s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:47.845048Z","caller":"traceutil/trace.go:171","msg":"trace[1800396745] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.000721985s","start":"2026-02-04T11:01:42.844312Z","end":"2026-02-04T11:01:47.845034Z","steps":["trace[1800396745] 'agreement among raft nodes before linearized reading'  (duration: 5.000619923s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:47.845082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:42.844296Z","time spent":"5.000780226s","remote":"127.0.0.1:50180","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/04 11:01:47 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:48.045486Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:48.067732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999261737s","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-04T11:01:48.067805Z","caller":"traceutil/trace.go:171","msg":"trace[1707185750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999373069s","start":"2026-02-04T11:01:43.068414Z","end":"2026-02-04T11:01:48.067787Z","steps":["trace[1707185750] 'agreement among raft nodes before linearized reading'  (duration: 4.999289778s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:48.06785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:43.068399Z","time spent":"4.99944187s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-04T11:01:48.546276Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:49.046688Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790853,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:49.500746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:42.500383Z","time spent":"7.000356791s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:49.538313Z","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-04T11:01:49.538443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.001032195s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:01:49.538493Z","caller":"traceutil/trace.go:171","msg":"trace[1394207508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"7.001149037s","start":"2026-02-04T11:01:42.537325Z","end":"2026-02-04T11:01:49.538474Z","steps":["trace[1394207508] 'agreement among raft nodes before linearized reading'  (duration: 7.001073276s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:49.53854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:42.537315Z","time spent":"7.001210898s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-04T11:01:49.569556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999149845s","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-04T11:01:49.569612Z","caller":"traceutil/trace.go:171","msg":"trace[560274665] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999242526s","start":"2026-02-04T11:01:44.570357Z","end":"2026-02-04T11:01:49.569599Z","steps":["trace[560274665] 'agreement among raft nodes before linearized reading'  (duration: 4.999179705s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:49.569682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:44.570337Z","time spent":"4.999336989s","remote":"127.0.0.1:50180","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\" "}
{"level":"warn","ts":"2026-02-04T11:01:49.732393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000308959s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:49.732501Z","caller":"traceutil/trace.go:171","msg":"trace[86379204] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000447802s","start":"2026-02-04T11:01:47.732031Z","end":"2026-02-04T11:01:49.732478Z","steps":["trace[86379204] 'agreement among raft nodes before linearized reading'  (duration: 2.000310849s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:49.732558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:47.732026Z","time spent":"2.000518404s","remote":"127.0.0.1:49902","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-04T11:01:50.039413Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:50.539955Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:51.040781Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:51.353095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000477943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:51.35317Z","caller":"traceutil/trace.go:171","msg":"trace[1896714159] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000595875s","start":"2026-02-04T11:01:49.352557Z","end":"2026-02-04T11:01:51.353153Z","steps":["trace[1896714159] 'agreement among raft nodes before linearized reading'  (duration: 2.000500383s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:51.353231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:49.352543Z","time spent":"2.000673367s","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:01:51 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:51.541846Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:51.734055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000235497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:51.734158Z","caller":"traceutil/trace.go:171","msg":"trace[297507009] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00037879s","start":"2026-02-04T11:01:49.733759Z","end":"2026-02-04T11:01:51.734137Z","steps":["trace[297507009] 'agreement among raft nodes before linearized reading'  (duration: 2.000263528s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:51.734239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:49.733744Z","time spent":"2.000484252s","remote":"127.0.0.1:49906","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-04T11:01:52.041984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:52.497986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.620848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:52.49807Z","caller":"traceutil/trace.go:171","msg":"trace[1114749399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"992.774401ms","start":"2026-02-04T11:01:51.505276Z","end":"2026-02-04T11:01:52.49805Z","steps":["trace[1114749399] 'agreement among raft nodes before linearized reading'  (duration: 992.643898ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:52.498122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:51.505256Z","time spent":"992.854642ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
2026/02/04 11:01:52 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:52.535942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.472105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:52.536054Z","caller":"traceutil/trace.go:171","msg":"trace[388291946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"993.615489ms","start":"2026-02-04T11:01:51.54242Z","end":"2026-02-04T11:01:52.536036Z","steps":["trace[388291946] 'agreement among raft nodes before linearized reading'  (duration: 993.492136ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:52.536158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:51.542409Z","time spent":"993.70313ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
2026/02/04 11:01:52 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:52.543128Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:52.632896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:45.632148Z","time spent":"7.000744169s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:52.844073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.9976086s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:52.844149Z","caller":"traceutil/trace.go:171","msg":"trace[242706898] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.997825684s","start":"2026-02-04T11:01:49.846307Z","end":"2026-02-04T11:01:52.844133Z","steps":["trace[242706898] 'agreement among raft nodes before linearized reading'  (duration: 2.997732462s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:52.844192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:49.846288Z","time spent":"2.997895286s","remote":"127.0.0.1:50180","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/04 11:01:52 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:52.863251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:45.863169Z","time spent":"7.000079275s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:53.044287Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:53.069336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997832224s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:53.069415Z","caller":"traceutil/trace.go:171","msg":"trace[1434192392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.998038969s","start":"2026-02-04T11:01:50.071357Z","end":"2026-02-04T11:01:53.069396Z","steps":["trace[1434192392] 'agreement among raft nodes before linearized reading'  (duration: 2.997862685s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:53.069463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:50.07134Z","time spent":"2.99811147s","remote":"127.0.0.1:50180","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/04 11:01:53 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:53.544688Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:53.745393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000759468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:53.745634Z","caller":"traceutil/trace.go:171","msg":"trace[1051382420] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000987012s","start":"2026-02-04T11:01:51.744593Z","end":"2026-02-04T11:01:53.74558Z","steps":["trace[1051382420] 'agreement among raft nodes before linearized reading'  (duration: 2.000777358s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:53.745743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:51.744582Z","time spent":"2.001148236s","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:01:53 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:54.045836Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:54.547259Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:55.048106Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:55.548553Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:55.745595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000232428s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-04T11:01:55.745672Z","caller":"traceutil/trace.go:171","msg":"trace[130305251] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00035784s","start":"2026-02-04T11:01:53.745296Z","end":"2026-02-04T11:01:55.745654Z","steps":["trace[130305251] 'agreement among raft nodes before linearized reading'  (duration: 2.000258918s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:55.745719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:53.745278Z","time spent":"2.000431842s","remote":"127.0.0.1:49906","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-04T11:01:56.049621Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790857,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:56.539044Z","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-04T11:01:56.539336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.239582959s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:01:56.539419Z","caller":"traceutil/trace.go:171","msg":"trace[787273700] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; }","duration":"10.239745231s","start":"2026-02-04T11:01:46.299656Z","end":"2026-02-04T11:01:56.539402Z","steps":["trace[787273700] 'agreement among raft nodes before linearized reading'  (duration: 10.239623379s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:56.539464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:46.29964Z","time spent":"10.239811283s","remote":"127.0.0.1:39084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":0,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:56.539473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.082919742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-02-04T11:01:56.539543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.808216893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:01:56.539578Z","caller":"traceutil/trace.go:171","msg":"trace[1470068649] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8; range_end:; }","duration":"8.808267944s","start":"2026-02-04T11:01:47.731302Z","end":"2026-02-04T11:01:56.53957Z","steps":["trace[1470068649] 'agreement among raft nodes before linearized reading'  (duration: 8.808234394s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:56.539609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:47.731291Z","time spent":"8.808311115s","remote":"127.0.0.1:49968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":0,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" "}
{"level":"warn","ts":"2026-02-04T11:01:56.539345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.375093538s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:01:56.539654Z","caller":"traceutil/trace.go:171","msg":"trace[1700131025] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; }","duration":"11.375476456s","start":"2026-02-04T11:01:45.164171Z","end":"2026-02-04T11:01:56.539647Z","steps":["trace[1700131025] 'agreement among raft nodes before linearized reading'  (duration: 11.375125609s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:56.539683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:45.164153Z","time spent":"11.375524938s","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":0,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"info","ts":"2026-02-04T11:01:56.539666Z","caller":"traceutil/trace.go:171","msg":"trace[1450989231] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; }","duration":"12.083125856s","start":"2026-02-04T11:01:44.456434Z","end":"2026-02-04T11:01:56.53956Z","steps":["trace[1450989231] 'agreement among raft nodes before linearized reading'  (duration: 12.082954973s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:56.539823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:44.456418Z","time spent":"12.083386972s","remote":"127.0.0.1:49932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":0,"request content":"key:\"/registry/masterleases/199.204.45.227\" "}
{"level":"warn","ts":"2026-02-04T11:01:56.539903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.91828796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:01:56.539953Z","caller":"traceutil/trace.go:171","msg":"trace[600613591] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; }","duration":"12.918340611s","start":"2026-02-04T11:01:43.621601Z","end":"2026-02-04T11:01:56.539941Z","steps":["trace[600613591] 'agreement among raft nodes before linearized reading'  (duration: 12.9182872s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:56.540003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:43.621548Z","time spent":"12.918444523s","remote":"127.0.0.1:49794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":0,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:56.539517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.604575495s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-02-04T11:01:56.540227Z","caller":"traceutil/trace.go:171","msg":"trace[1560962041] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; }","duration":"7.605311869s","start":"2026-02-04T11:01:48.934904Z","end":"2026-02-04T11:01:56.540216Z","steps":["trace[1560962041] 'agreement among raft nodes before linearized reading'  (duration: 7.604604805s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:56.540285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:48.934891Z","time spent":"7.605380471s","remote":"127.0.0.1:50144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":0,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:56.747963Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"21c29c284eac1708","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-02-04T11:01:57.04026Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790865,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:57.541452Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790865,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:57.754718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000923911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-04T11:01:57.754797Z","caller":"traceutil/trace.go:171","msg":"trace[988121232] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001069895s","start":"2026-02-04T11:01:55.753709Z","end":"2026-02-04T11:01:57.754779Z","steps":["trace[988121232] 'agreement among raft nodes before linearized reading'  (duration: 2.000971123s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:57.754842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:55.753688Z","time spent":"2.001144977s","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/04 11:01:57 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:57.845179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:52.848055Z","time spent":"4.997118485s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-04T11:01:58.041585Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790865,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:58.070477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:53.072656Z","time spent":"4.997813788s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/04 11:01:58 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:58.542233Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790865,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:58.553245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999326318s","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-04T11:01:58.553542Z","caller":"traceutil/trace.go:171","msg":"trace[1566894022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999679596s","start":"2026-02-04T11:01:53.553843Z","end":"2026-02-04T11:01:58.553523Z","steps":["trace[1566894022] 'agreement among raft nodes before linearized reading'  (duration: 4.999364709s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:58.553643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:53.553825Z","time spent":"4.999803889s","remote":"127.0.0.1:50180","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/04 11:01:58 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-04T11:01:59.04256Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656050482520790865,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-04T11:01:59.101797Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"16.601314866s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-04T11:01:59.415735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.917909ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790858 > lease_revoke:<id:21c29c284eac1708>","response":"size:28"}
{"level":"info","ts":"2026-02-04T11:01:59.415912Z","caller":"traceutil/trace.go:171","msg":"trace[137725196] transaction","detail":"{read_only:false; number_of_response:1; response_revision:954; }","duration":"6.917811273s","start":"2026-02-04T11:01:52.498088Z","end":"2026-02-04T11:01:59.415899Z","steps":["trace[137725196] 'process raft request'  (duration: 6.917716661s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.41599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:52.498067Z","time spent":"6.917875535s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":48,"response count":0,"response size":470,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:947 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:363 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-04T11:01:59.41669Z","caller":"traceutil/trace.go:171","msg":"trace[282719784] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"6.874705656s","start":"2026-02-04T11:01:52.541976Z","end":"2026-02-04T11:01:59.416682Z","steps":["trace[282719784] 'process raft request'  (duration: 6.87388861s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.416743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:52.541954Z","time spent":"6.874762657s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":411,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:948 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:361 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-04T11:01:59.551711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.947882ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790861 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:937 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:547"}
{"level":"info","ts":"2026-02-04T11:01:59.551865Z","caller":"traceutil/trace.go:171","msg":"trace[1499054140] transaction","detail":"{read_only:false; number_of_response:1; response_revision:955; }","duration":"6.913773982s","start":"2026-02-04T11:01:52.638069Z","end":"2026-02-04T11:01:59.551843Z","steps":["trace[1499054140] 'process raft request'  (duration: 6.778607125s)","trace[1499054140] 'compare'  (duration: 134.867941ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:59.551973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:52.638046Z","time spent":"6.913864944s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":45,"response count":0,"response size":570,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:937 > 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-04T11:01:59.552059Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"31.011µs","request":"header:<ID:11656050482520790866 > lease_revoke:<id:21c29c284eac1708>","response":"size:28","error":"lease not found"}
{"level":"info","ts":"2026-02-04T11:01:59.552117Z","caller":"traceutil/trace.go:171","msg":"trace[1201845984] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:996; }","duration":"3.012836627s","start":"2026-02-04T11:01:56.539264Z","end":"2026-02-04T11:01:59.552101Z","steps":["trace[1201845984] 'read index received'  (duration: 2.562825424s)","trace[1201845984] 'applied index is now lower than readState.Index'  (duration: 450.009983ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:59.552178Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"21c29c284eac1708","error":"lease not found"}
{"level":"warn","ts":"2026-02-04T11:01:59.552231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.969852419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:59.55226Z","caller":"traceutil/trace.go:171","msg":"trace[21958386] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:957; }","duration":"3.969922151s","start":"2026-02-04T11:01:55.582329Z","end":"2026-02-04T11:01:59.552251Z","steps":["trace[21958386] 'agreement among raft nodes before linearized reading'  (duration: 3.969855519s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.552344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:55.582312Z","time spent":"3.970021122s","remote":"127.0.0.1:55356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:59.552352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.00858119s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:59.552379Z","caller":"traceutil/trace.go:171","msg":"trace[271597200] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:0; response_revision:957; }","duration":"3.008639091s","start":"2026-02-04T11:01:56.543733Z","end":"2026-02-04T11:01:59.552372Z","steps":["trace[271597200] 'agreement among raft nodes before linearized reading'  (duration: 3.00859212s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.552402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:56.543717Z","time spent":"3.008680654s","remote":"127.0.0.1:49932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.227\" "}
{"level":"warn","ts":"2026-02-04T11:01:59.552509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.301672501s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:59.552527Z","caller":"traceutil/trace.go:171","msg":"trace[1344552933] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:957; }","duration":"6.301720073s","start":"2026-02-04T11:01:53.250801Z","end":"2026-02-04T11:01:59.552521Z","steps":["trace[1344552933] 'agreement among raft nodes before linearized reading'  (duration: 6.301688302s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.552543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:53.250784Z","time spent":"6.301754863s","remote":"127.0.0.1:50128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"info","ts":"2026-02-04T11:01:59.552267Z","caller":"traceutil/trace.go:171","msg":"trace[1279043583] transaction","detail":"{read_only:false; number_of_response:1; response_revision:956; }","duration":"6.685180138s","start":"2026-02-04T11:01:52.867079Z","end":"2026-02-04T11:01:59.552259Z","steps":["trace[1279043583] 'process raft request'  (duration: 6.684845811s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.552637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.622682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:59.552654Z","caller":"traceutil/trace.go:171","msg":"trace[415112139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:957; }","duration":"199.668453ms","start":"2026-02-04T11:01:59.352981Z","end":"2026-02-04T11:01:59.552649Z","steps":["trace[415112139] 'agreement among raft nodes before linearized reading'  (duration: 199.642913ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.552659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:52.867065Z","time spent":"6.685557596s","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":721,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:938 > 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-04T11:01:59.552745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.818242ms","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-04T11:01:59.552763Z","caller":"traceutil/trace.go:171","msg":"trace[1867154393] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:957; }","duration":"577.877574ms","start":"2026-02-04T11:01:58.97488Z","end":"2026-02-04T11:01:59.552758Z","steps":["trace[1867154393] 'agreement among raft nodes before linearized reading'  (duration: 577.840743ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.552778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:58.974862Z","time spent":"577.912455ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "}
{"level":"warn","ts":"2026-02-04T11:01:59.552824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.797724358s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:01:59.552853Z","caller":"traceutil/trace.go:171","msg":"trace[1629934095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:957; }","duration":"1.797783929s","start":"2026-02-04T11:01:57.755064Z","end":"2026-02-04T11:01:59.552848Z","steps":["trace[1629934095] 'agreement among raft nodes before linearized reading'  (duration: 1.797748979s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.552867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:57.75505Z","time spent":"1.79781391s","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-04T11:01:59.553013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.006718024s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18910624436b1821\" ","response":"range_response_count:1 size:773"}
{"level":"info","ts":"2026-02-04T11:01:59.553081Z","caller":"traceutil/trace.go:171","msg":"trace[1355479503] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18910624436b1821; range_end:; response_count:1; response_revision:957; }","duration":"3.006796086s","start":"2026-02-04T11:01:56.546278Z","end":"2026-02-04T11:01:59.553074Z","steps":["trace[1355479503] 'agreement among raft nodes before linearized reading'  (duration: 3.006670073s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.553102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:56.546272Z","time spent":"3.006822626s","remote":"127.0.0.1:49968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":796,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18910624436b1821\" "}
{"level":"warn","ts":"2026-02-04T11:01:59.553234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.009342336s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:7012"}
{"level":"info","ts":"2026-02-04T11:01:59.553251Z","caller":"traceutil/trace.go:171","msg":"trace[1309851438] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:957; }","duration":"3.009374437s","start":"2026-02-04T11:01:56.543871Z","end":"2026-02-04T11:01:59.553246Z","steps":["trace[1309851438] 'agreement among raft nodes before linearized reading'  (duration: 3.009312856s)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.553268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:56.543865Z","time spent":"3.009397807s","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":7035,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "}
{"level":"warn","ts":"2026-02-04T11:01:59.926542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.918154ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790872 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:21c29c284eac1757>","response":"size:41"}
{"level":"info","ts":"2026-02-04T11:01:59.92674Z","caller":"traceutil/trace.go:171","msg":"trace[942178834] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1008; }","duration":"326.278996ms","start":"2026-02-04T11:01:59.600444Z","end":"2026-02-04T11:01:59.926723Z","steps":["trace[942178834] 'read index received'  (duration: 164.176238ms)","trace[942178834] 'applied index is now lower than readState.Index'  (duration: 162.101978ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:01:59.926897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.674747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"}
{"level":"info","ts":"2026-02-04T11:01:59.926925Z","caller":"traceutil/trace.go:171","msg":"trace[1130975676] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:958; }","duration":"347.720938ms","start":"2026-02-04T11:01:59.579195Z","end":"2026-02-04T11:01:59.926916Z","steps":["trace[1130975676] 'agreement among raft nodes before linearized reading'  (duration: 347.573055ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.926953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:59.57919Z","time spent":"347.755909ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "}
{"level":"warn","ts":"2026-02-04T11:01:59.927145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:59.578539Z","time spent":"348.605146ms","remote":"127.0.0.1:49968","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-04T11:01:59.927379Z","caller":"traceutil/trace.go:171","msg":"trace[1123862461] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"348.285279ms","start":"2026-02-04T11:01:59.579085Z","end":"2026-02-04T11:01:59.927371Z","steps":["trace[1123862461] 'process raft request'  (duration: 347.534014ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.927436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:59.579046Z","time spent":"348.350341ms","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6787,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:929 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6720 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >"}
{"level":"warn","ts":"2026-02-04T11:01:59.927581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.893741ms","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-04T11:01:59.927606Z","caller":"traceutil/trace.go:171","msg":"trace[265893417] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:1; response_revision:958; }","duration":"347.937542ms","start":"2026-02-04T11:01:59.579662Z","end":"2026-02-04T11:01:59.9276Z","steps":["trace[265893417] 'agreement among raft nodes before linearized reading'  (duration: 347.875831ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:01:59.927626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:59.579653Z","time spent":"347.968513ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":710,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "}
{"level":"warn","ts":"2026-02-04T11:02:00.441826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.112311ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11656050482520790875 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.227\" mod_revision:0 > success:<request_put:<key:\"/registry/masterleases/199.204.45.227\" value_size:67 lease:2432678445666015061 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.227\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-04T11:02:00.44195Z","caller":"traceutil/trace.go:171","msg":"trace[531916622] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"840.242676ms","start":"2026-02-04T11:01:59.601684Z","end":"2026-02-04T11:02:00.441927Z","steps":["trace[531916622] 'process raft request'  (duration: 648.920921ms)","trace[531916622] 'compare'  (duration: 190.976628ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:02:00.442034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:59.601667Z","time spent":"840.323187ms","remote":"127.0.0.1:49932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.227\" mod_revision:0 > success:<request_put:<key:\"/registry/masterleases/199.204.45.227\" value_size:67 lease:2432678445666015061 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.227\" > >"}
{"level":"info","ts":"2026-02-04T11:02:00.448783Z","caller":"traceutil/trace.go:171","msg":"trace[840460670] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1010; }","duration":"513.52829ms","start":"2026-02-04T11:01:59.935238Z","end":"2026-02-04T11:02:00.448767Z","steps":["trace[840460670] 'read index received'  (duration: 315.374719ms)","trace[840460670] 'applied index is now lower than readState.Index'  (duration: 198.152531ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:02:00.448986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.733865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7045"}
{"level":"info","ts":"2026-02-04T11:02:00.449014Z","caller":"traceutil/trace.go:171","msg":"trace[1882234689] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:962; }","duration":"513.783826ms","start":"2026-02-04T11:01:59.935221Z","end":"2026-02-04T11:02:00.449005Z","steps":["trace[1882234689] 'agreement among raft nodes before linearized reading'  (duration: 513.603781ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:00.449044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:59.935212Z","time spent":"513.824576ms","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7068,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "}
{"level":"info","ts":"2026-02-04T11:02:00.449197Z","caller":"traceutil/trace.go:171","msg":"trace[314542536] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"517.601882ms","start":"2026-02-04T11:01:59.931586Z","end":"2026-02-04T11:02:00.449187Z","steps":["trace[314542536] 'process raft request'  (duration: 517.02663ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:00.449254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:59.931571Z","time spent":"517.644963ms","remote":"127.0.0.1:49968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18910624436b1821\" mod_revision:898 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18910624436b1821\" value_size:671 lease:2432678445666015063 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.18910624436b1821\" > >"}
{"level":"info","ts":"2026-02-04T11:02:00.449461Z","caller":"traceutil/trace.go:171","msg":"trace[904984841] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"517.806176ms","start":"2026-02-04T11:01:59.931643Z","end":"2026-02-04T11:02:00.449449Z","steps":["trace[904984841] 'process raft request'  (duration: 517.05599ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:00.449535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:59.931637Z","time spent":"517.842107ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:953 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-04T11:02:00.451556Z","caller":"traceutil/trace.go:171","msg":"trace[203797487] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"516.736074ms","start":"2026-02-04T11:01:59.934808Z","end":"2026-02-04T11:02:00.451544Z","steps":["trace[203797487] 'process raft request'  (duration: 513.923687ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:00.451618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:01:59.9348Z","time spent":"516.784415ms","remote":"127.0.0.1:50180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:952 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-04T11:02:00.791185Z","caller":"traceutil/trace.go:171","msg":"trace[1145978629] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"325.557139ms","start":"2026-02-04T11:02:00.465614Z","end":"2026-02-04T11:02:00.791171Z","steps":["trace[1145978629] 'process raft request'  (duration: 325.461707ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:00.791283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:00.465608Z","time spent":"325.62315ms","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7222,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:897 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7164 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"info","ts":"2026-02-04T11:02:00.791703Z","caller":"traceutil/trace.go:171","msg":"trace[1776421320] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1016; }","duration":"246.931477ms","start":"2026-02-04T11:02:00.544764Z","end":"2026-02-04T11:02:00.791695Z","steps":["trace[1776421320] 'read index received'  (duration: 246.928197ms)","trace[1776421320] 'applied index is now lower than readState.Index'  (duration: 2.69µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:02:00.791921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.159232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-04T11:02:00.791943Z","caller":"traceutil/trace.go:171","msg":"trace[1206450945] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8; range_end:; response_count:1; response_revision:964; }","duration":"247.226043ms","start":"2026-02-04T11:02:00.54471Z","end":"2026-02-04T11:02:00.791936Z","steps":["trace[1206450945] 'agreement among raft nodes before linearized reading'  (duration: 247.151491ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:02:00.920712Z","caller":"traceutil/trace.go:171","msg":"trace[2058656427] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1016; }","duration":"125.412385ms","start":"2026-02-04T11:02:00.795285Z","end":"2026-02-04T11:02:00.920697Z","steps":["trace[2058656427] 'read index received'  (duration: 125.088708ms)","trace[2058656427] 'applied index is now lower than readState.Index'  (duration: 323.147µs)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:02:00.920783Z","caller":"traceutil/trace.go:171","msg":"trace[1607159339] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"125.763071ms","start":"2026-02-04T11:02:00.795016Z","end":"2026-02-04T11:02:00.920779Z","steps":["trace[1607159339] 'process raft request'  (duration: 125.371054ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:00.920957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.642759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-04T11:02:00.920976Z","caller":"traceutil/trace.go:171","msg":"trace[131160966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:965; }","duration":"125.70029ms","start":"2026-02-04T11:02:00.795271Z","end":"2026-02-04T11:02:00.920971Z","steps":["trace[131160966] 'agreement among raft nodes before linearized reading'  (duration: 125.627149ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:00.921104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.466126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4374"}
{"level":"info","ts":"2026-02-04T11:02:00.921116Z","caller":"traceutil/trace.go:171","msg":"trace[1511993589] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:965; }","duration":"124.490416ms","start":"2026-02-04T11:02:00.796622Z","end":"2026-02-04T11:02:00.921112Z","steps":["trace[1511993589] 'agreement among raft nodes before linearized reading'  (duration: 124.430585ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:02:01.151812Z","caller":"traceutil/trace.go:171","msg":"trace[1762736786] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"224.183731ms","start":"2026-02-04T11:02:00.927603Z","end":"2026-02-04T11:02:01.151786Z","steps":["trace[1762736786] 'process raft request'  (duration: 189.507425ms)","trace[1762736786] 'compare'  (duration: 34.503532ms)"],"step_count":2}
{"level":"info","ts":"2026-02-04T11:02:01.347664Z","caller":"traceutil/trace.go:171","msg":"trace[1529793102] linearizableReadLoop","detail":"{readStateIndex:1019; appliedIndex:1018; }","duration":"191.886291ms","start":"2026-02-04T11:02:01.155762Z","end":"2026-02-04T11:02:01.347648Z","steps":["trace[1529793102] 'read index received'  (duration: 191.772049ms)","trace[1529793102] 'applied index is now lower than readState.Index'  (duration: 113.722µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-04T11:02:01.34784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.062924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-04T11:02:01.34787Z","caller":"traceutil/trace.go:171","msg":"trace[884382576] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1891061b498579f8; range_end:; response_count:1; response_revision:967; }","duration":"192.135296ms","start":"2026-02-04T11:02:01.155727Z","end":"2026-02-04T11:02:01.347862Z","steps":["trace[884382576] 'agreement among raft nodes before linearized reading'  (duration: 191.994733ms)"],"step_count":1}
{"level":"info","ts":"2026-02-04T11:02:01.347958Z","caller":"traceutil/trace.go:171","msg":"trace[1501345115] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"419.50858ms","start":"2026-02-04T11:02:00.928439Z","end":"2026-02-04T11:02:01.347947Z","steps":["trace[1501345115] 'process raft request'  (duration: 419.110852ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-04T11:02:01.348022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-04T11:02:00.928425Z","time spent":"419.55585ms","remote":"127.0.0.1:50068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4167,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:928 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4109 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}