{"level":"warn","ts":"2026-02-08T17:31:38.402941Z","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-08T17:31:38.403025Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.218: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://162.253.55.218:2380","--initial-cluster=instance=https://162.253.55.218:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.218:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.218: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-08T17:31:38.403091Z","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-08T17:31:38.403099Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.218:2380"]}
{"level":"info","ts":"2026-02-08T17:31:38.403115Z","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-08T17:31:38.403953Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"]}
{"level":"info","ts":"2026-02-08T17:31:38.404073Z","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://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.218: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-08T17:31:38.408228Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.911832ms"}
{"level":"info","ts":"2026-02-08T17:31:38.421051Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bb7d59f4041c8abe","cluster-id":"5330ca29224af3c4"}
{"level":"info","ts":"2026-02-08T17:31:38.421094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=()"}
{"level":"info","ts":"2026-02-08T17:31:38.421108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 0"}
{"level":"info","ts":"2026-02-08T17:31:38.421115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bb7d59f4041c8abe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-08T17:31:38.421125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 1"}
{"level":"info","ts":"2026-02-08T17:31:38.42115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"}
{"level":"warn","ts":"2026-02-08T17:31:38.425304Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-08T17:31:38.426514Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-08T17:31:38.427274Z","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-08T17:31:38.432802Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bb7d59f4041c8abe","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-08T17:31:38.433518Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bb7d59f4041c8abe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-08T17:31:38.433726Z","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-08T17:31:38.433758Z","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-08T17:31:38.433766Z","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-08T17:31:38.434002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"}
{"level":"info","ts":"2026-02-08T17:31:38.434088Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","added-peer-id":"bb7d59f4041c8abe","added-peer-peer-urls":["https://162.253.55.218:2380"]}
{"level":"info","ts":"2026-02-08T17:31:38.445259Z","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-08T17:31:38.445434Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bb7d59f4041c8abe","initial-advertise-peer-urls":["https://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-08T17:31:38.445459Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-08T17:31:38.445516Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.218:2380"}
{"level":"info","ts":"2026-02-08T17:31:38.445527Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.218:2380"}
{"level":"info","ts":"2026-02-08T17:31:39.421721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe is starting a new election at term 1"}
{"level":"info","ts":"2026-02-08T17:31:39.421766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-08T17:31:39.421789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgPreVoteResp from bb7d59f4041c8abe at term 1"}
{"level":"info","ts":"2026-02-08T17:31:39.421801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became candidate at term 2"}
{"level":"info","ts":"2026-02-08T17:31:39.421806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgVoteResp from bb7d59f4041c8abe at term 2"}
{"level":"info","ts":"2026-02-08T17:31:39.421813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became leader at term 2"}
{"level":"info","ts":"2026-02-08T17:31:39.42182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bb7d59f4041c8abe elected leader bb7d59f4041c8abe at term 2"}
{"level":"info","ts":"2026-02-08T17:31:39.422615Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-08T17:31:39.424751Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bb7d59f4041c8abe","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.218:2379]}","request-path":"/0/members/bb7d59f4041c8abe/attributes","cluster-id":"5330ca29224af3c4","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-08T17:31:39.424847Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-08T17:31:39.426447Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-08T17:31:39.42653Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-08T17:31:39.426548Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-08T17:31:39.428743Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.218:2379"}
{"level":"info","ts":"2026-02-08T17:31:39.429127Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-08T17:31:39.430529Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-08T17:31:39.430569Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-08T17:31:39.431913Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-08T17:31:54.533326Z","caller":"traceutil/trace.go:171","msg":"trace[1388119133] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"190.723208ms","start":"2026-02-08T17:31:54.342577Z","end":"2026-02-08T17:31:54.5333Z","steps":["trace[1388119133] 'read index received'  (duration: 190.481422ms)","trace[1388119133] 'applied index is now lower than readState.Index'  (duration: 240.906µs)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:31:54.534015Z","caller":"traceutil/trace.go:171","msg":"trace[543995126] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"242.531221ms","start":"2026-02-08T17:31:54.291469Z","end":"2026-02-08T17:31:54.534001Z","steps":["trace[543995126] 'process raft request'  (duration: 241.668371ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:31:54.534622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.028577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-08T17:31:54.534942Z","caller":"traceutil/trace.go:171","msg":"trace[366149613] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:415; }","duration":"192.363535ms","start":"2026-02-08T17:31:54.342533Z","end":"2026-02-08T17:31:54.534897Z","steps":["trace[366149613] 'agreement among raft nodes before linearized reading'  (duration: 192.028757ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:31:59.296641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.103327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:31:59.296687Z","caller":"traceutil/trace.go:171","msg":"trace[409547665] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:458; }","duration":"409.183459ms","start":"2026-02-08T17:31:58.887494Z","end":"2026-02-08T17:31:59.296677Z","steps":["trace[409547665] 'range keys from in-memory index tree'  (duration: 409.052675ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:31:59.296705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:31:58.887478Z","time spent":"409.222399ms","remote":"127.0.0.1:51072","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-08T17:31:59.296849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.257408ms","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-08T17:31:59.296862Z","caller":"traceutil/trace.go:171","msg":"trace[1323061428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:458; }","duration":"243.296168ms","start":"2026-02-08T17:31:59.053562Z","end":"2026-02-08T17:31:59.296858Z","steps":["trace[1323061428] 'range keys from in-memory index tree'  (duration: 243.210617ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:31:59.296921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.793485ms","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-08T17:31:59.296932Z","caller":"traceutil/trace.go:171","msg":"trace[1046281487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:458; }","duration":"242.813307ms","start":"2026-02-08T17:31:59.054116Z","end":"2026-02-08T17:31:59.296929Z","steps":["trace[1046281487] 'range keys from in-memory index tree'  (duration: 242.771745ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:09.551252Z","caller":"traceutil/trace.go:171","msg":"trace[1374574452] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"159.421561ms","start":"2026-02-08T17:32:09.391814Z","end":"2026-02-08T17:32:09.551236Z","steps":["trace[1374574452] 'read index received'  (duration: 159.216216ms)","trace[1374574452] 'applied index is now lower than readState.Index'  (duration: 204.715µs)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:32:09.551346Z","caller":"traceutil/trace.go:171","msg":"trace[1146021585] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"182.320812ms","start":"2026-02-08T17:32:09.369018Z","end":"2026-02-08T17:32:09.551339Z","steps":["trace[1146021585] 'process raft request'  (duration: 182.062286ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:09.551541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.707297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-08T17:32:09.551649Z","caller":"traceutil/trace.go:171","msg":"trace[118630388] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"159.859981ms","start":"2026-02-08T17:32:09.39178Z","end":"2026-02-08T17:32:09.55164Z","steps":["trace[118630388] 'agreement among raft nodes before linearized reading'  (duration: 159.677557ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:09.551688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.940442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-08T17:32:09.551742Z","caller":"traceutil/trace.go:171","msg":"trace[38006934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"116.020843ms","start":"2026-02-08T17:32:09.435707Z","end":"2026-02-08T17:32:09.551727Z","steps":["trace[38006934] 'agreement among raft nodes before linearized reading'  (duration: 115.938811ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:09.55184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.094502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-08T17:32:09.551856Z","caller":"traceutil/trace.go:171","msg":"trace[536548057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"115.129862ms","start":"2026-02-08T17:32:09.43672Z","end":"2026-02-08T17:32:09.55185Z","steps":["trace[536548057] 'agreement among raft nodes before linearized reading'  (duration: 115.099491ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:10.991171Z","caller":"traceutil/trace.go:171","msg":"trace[1941253863] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"250.953016ms","start":"2026-02-08T17:32:10.740203Z","end":"2026-02-08T17:32:10.991156Z","steps":["trace[1941253863] 'process raft request'  (duration: 250.029704ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:12.003981Z","caller":"traceutil/trace.go:171","msg":"trace[1745948209] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"419.344144ms","start":"2026-02-08T17:32:11.584613Z","end":"2026-02-08T17:32:12.003957Z","steps":["trace[1745948209] 'process raft request'  (duration: 419.301843ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:12.004487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:11.58461Z","time spent":"419.436486ms","remote":"127.0.0.1:51366","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:517 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-08T17:32:12.005445Z","caller":"traceutil/trace.go:171","msg":"trace[481849797] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"420.847609ms","start":"2026-02-08T17:32:11.584588Z","end":"2026-02-08T17:32:12.005435Z","steps":["trace[481849797] 'process raft request'  (duration: 419.132329ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:12.005489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:11.584584Z","time spent":"420.88198ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:516 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-08T17:32:17.192462Z","caller":"traceutil/trace.go:171","msg":"trace[1186835875] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"183.525249ms","start":"2026-02-08T17:32:17.008923Z","end":"2026-02-08T17:32:17.192448Z","steps":["trace[1186835875] 'process raft request'  (duration: 183.355036ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:17.19268Z","caller":"traceutil/trace.go:171","msg":"trace[780465804] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:552; }","duration":"146.130122ms","start":"2026-02-08T17:32:17.04653Z","end":"2026-02-08T17:32:17.19266Z","steps":["trace[780465804] 'read index received'  (duration: 145.712213ms)","trace[780465804] 'applied index is now lower than readState.Index'  (duration: 417.489µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:32:17.192742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.195844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hqdss\" ","response":"range_response_count:1 size:16656"}
{"level":"info","ts":"2026-02-08T17:32:17.192759Z","caller":"traceutil/trace.go:171","msg":"trace[1537757090] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hqdss; range_end:; response_count:1; response_revision:537; }","duration":"146.267655ms","start":"2026-02-08T17:32:17.046486Z","end":"2026-02-08T17:32:17.192754Z","steps":["trace[1537757090] 'agreement among raft nodes before linearized reading'  (duration: 146.212934ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:17.757142Z","caller":"traceutil/trace.go:171","msg":"trace[417794940] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"552.823073ms","start":"2026-02-08T17:32:17.204303Z","end":"2026-02-08T17:32:17.757126Z","steps":["trace[417794940] 'process raft request'  (duration: 552.71177ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:17.757283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:17.204289Z","time spent":"552.933376ms","remote":"127.0.0.1:51298","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-hqdss\" mod_revision:503 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-hqdss\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-hqdss\" > >"}
{"level":"info","ts":"2026-02-08T17:32:17.769831Z","caller":"traceutil/trace.go:171","msg":"trace[1612681651] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:554; }","duration":"132.898745ms","start":"2026-02-08T17:32:17.636916Z","end":"2026-02-08T17:32:17.769815Z","steps":["trace[1612681651] 'read index received'  (duration: 120.702582ms)","trace[1612681651] 'applied index is now lower than readState.Index'  (duration: 12.195053ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:32:17.769914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.983067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-08T17:32:17.76994Z","caller":"traceutil/trace.go:171","msg":"trace[2026248541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:538; }","duration":"133.042078ms","start":"2026-02-08T17:32:17.636885Z","end":"2026-02-08T17:32:17.769927Z","steps":["trace[2026248541] 'agreement among raft nodes before linearized reading'  (duration: 132.983867ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:22.388563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.009203ms","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-08T17:32:22.388669Z","caller":"traceutil/trace.go:171","msg":"trace[844992366] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:606; }","duration":"116.195117ms","start":"2026-02-08T17:32:22.272452Z","end":"2026-02-08T17:32:22.388647Z","steps":["trace[844992366] 'range keys from in-memory index tree'  (duration: 115.799138ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:30.029362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.50195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-08T17:32:30.029554Z","caller":"traceutil/trace.go:171","msg":"trace[1700719905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:670; }","duration":"108.707665ms","start":"2026-02-08T17:32:29.920822Z","end":"2026-02-08T17:32:30.02953Z","steps":["trace[1700719905] 'range keys from in-memory index tree'  (duration: 108.306055ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:30.032523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.062131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:32:30.032572Z","caller":"traceutil/trace.go:171","msg":"trace[2082773577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:670; }","duration":"146.147773ms","start":"2026-02-08T17:32:29.886414Z","end":"2026-02-08T17:32:30.032562Z","steps":["trace[2082773577] 'range keys from in-memory index tree'  (duration: 145.996149ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:36.608509Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600014238366449,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-08T17:32:37.109619Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600014238366449,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-08T17:32:37.137802Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.031506155s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-08T17:32:37.138185Z","caller":"traceutil/trace.go:171","msg":"trace[173475325] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:745; }","duration":"1.030524133s","start":"2026-02-08T17:32:36.107637Z","end":"2026-02-08T17:32:37.138161Z","steps":["trace[173475325] 'read index received'  (duration: 1.030333758s)","trace[173475325] 'applied index is now lower than readState.Index'  (duration: 189.164µs)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:32:37.138309Z","caller":"traceutil/trace.go:171","msg":"trace[1586178254] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"1.032088879s","start":"2026-02-08T17:32:36.106209Z","end":"2026-02-08T17:32:37.138298Z","steps":["trace[1586178254] 'process raft request'  (duration: 1.031773561s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:37.138463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:36.106193Z","time spent":"1.03214291s","remote":"127.0.0.1:51366","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:718 > 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-08T17:32:37.138584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000264401s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-08T17:32:37.138654Z","caller":"traceutil/trace.go:171","msg":"trace[1882438662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:725; }","duration":"1.000365662s","start":"2026-02-08T17:32:36.13827Z","end":"2026-02-08T17:32:37.138635Z","steps":["trace[1882438662] 'agreement among raft nodes before linearized reading'  (duration: 1.000148747s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:37.138713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:36.138257Z","time spent":"1.000427313s","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-08T17:32:37.138822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.213357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:32:37.138863Z","caller":"traceutil/trace.go:171","msg":"trace[108159406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:725; }","duration":"237.276539ms","start":"2026-02-08T17:32:36.90157Z","end":"2026-02-08T17:32:37.138847Z","steps":["trace[108159406] 'agreement among raft nodes before linearized reading'  (duration: 237.219998ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:37.139837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.267866ms","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-08T17:32:37.139877Z","caller":"traceutil/trace.go:171","msg":"trace[458985643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:725; }","duration":"983.337108ms","start":"2026-02-08T17:32:36.156528Z","end":"2026-02-08T17:32:37.139866Z","steps":["trace[458985643] 'agreement among raft nodes before linearized reading'  (duration: 983.176734ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:37.139935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:36.156493Z","time spent":"983.434639ms","remote":"127.0.0.1:51366","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-08T17:32:37.14002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032371736s","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-08T17:32:37.140061Z","caller":"traceutil/trace.go:171","msg":"trace[1098375109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:725; }","duration":"1.032432028s","start":"2026-02-08T17:32:36.107618Z","end":"2026-02-08T17:32:37.14005Z","steps":["trace[1098375109] 'agreement among raft nodes before linearized reading'  (duration: 1.032292975s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:37.140091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:36.107613Z","time spent":"1.032470769s","remote":"127.0.0.1:51366","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-08T17:32:37.925975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.737893ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9997600014238366454 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:720 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-08T17:32:37.926204Z","caller":"traceutil/trace.go:171","msg":"trace[1311671810] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"781.448089ms","start":"2026-02-08T17:32:37.144742Z","end":"2026-02-08T17:32:37.92619Z","steps":["trace[1311671810] 'process raft request'  (duration: 538.356887ms)","trace[1311671810] 'compare'  (duration: 242.61033ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:32:37.926241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:37.144726Z","time spent":"781.49874ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:720 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-08T17:32:37.926436Z","caller":"traceutil/trace.go:171","msg":"trace[1542963823] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"778.815088ms","start":"2026-02-08T17:32:37.147615Z","end":"2026-02-08T17:32:37.92643Z","steps":["trace[1542963823] 'process raft request'  (duration: 778.429299ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:37.926463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:37.147606Z","time spent":"778.841718ms","remote":"127.0.0.1:51366","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:721 > 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-08T17:32:37.926568Z","caller":"traceutil/trace.go:171","msg":"trace[443873905] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"778.875089ms","start":"2026-02-08T17:32:37.147686Z","end":"2026-02-08T17:32:37.926561Z","steps":["trace[443873905] 'process raft request'  (duration: 778.380237ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:37.926601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:37.147681Z","time spent":"778.90612ms","remote":"127.0.0.1:51366","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:719 > 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-08T17:32:38.057224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.124662ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9997600014238366457 > lease_revoke:<id:0abe9c3e4f1e3a05>","response":"size:28"}
{"level":"info","ts":"2026-02-08T17:32:38.057315Z","caller":"traceutil/trace.go:171","msg":"trace[14706320] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:746; }","duration":"749.489227ms","start":"2026-02-08T17:32:37.30781Z","end":"2026-02-08T17:32:38.0573Z","steps":["trace[14706320] 'read index received'  (duration: 375.245581ms)","trace[14706320] 'applied index is now lower than readState.Index'  (duration: 374.241916ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:32:38.057476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.66016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-08T17:32:38.057511Z","caller":"traceutil/trace.go:171","msg":"trace[1753166167] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:728; }","duration":"749.726292ms","start":"2026-02-08T17:32:37.307775Z","end":"2026-02-08T17:32:38.057501Z","steps":["trace[1753166167] 'agreement among raft nodes before linearized reading'  (duration: 749.587729ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:38.057551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:37.307761Z","time spent":"749.781963ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-08T17:32:39.444377Z","caller":"traceutil/trace.go:171","msg":"trace[626161608] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"295.072499ms","start":"2026-02-08T17:32:39.149285Z","end":"2026-02-08T17:32:39.444357Z","steps":["trace[626161608] 'process raft request'  (duration: 294.921815ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:52.063887Z","caller":"traceutil/trace.go:171","msg":"trace[1131060992] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:793; }","duration":"177.711867ms","start":"2026-02-08T17:32:51.886161Z","end":"2026-02-08T17:32:52.063873Z","steps":["trace[1131060992] 'read index received'  (duration: 177.603134ms)","trace[1131060992] 'applied index is now lower than readState.Index'  (duration: 107.983µs)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:32:52.063975Z","caller":"traceutil/trace.go:171","msg":"trace[1725147744] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"187.984388ms","start":"2026-02-08T17:32:51.875982Z","end":"2026-02-08T17:32:52.063967Z","steps":["trace[1725147744] 'process raft request'  (duration: 187.790763ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:52.064082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.908411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:32:52.064102Z","caller":"traceutil/trace.go:171","msg":"trace[1982939477] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:770; }","duration":"177.957253ms","start":"2026-02-08T17:32:51.886139Z","end":"2026-02-08T17:32:52.064096Z","steps":["trace[1982939477] 'agreement among raft nodes before linearized reading'  (duration: 177.914422ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:56.646157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.925302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:32:56.646218Z","caller":"traceutil/trace.go:171","msg":"trace[277533407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:782; }","duration":"761.028144ms","start":"2026-02-08T17:32:55.885177Z","end":"2026-02-08T17:32:56.646205Z","steps":["trace[277533407] 'range keys from in-memory index tree'  (duration: 760.841079ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:56.646244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:55.885162Z","time spent":"761.076405ms","remote":"127.0.0.1:51072","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-08T17:32:56.646589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.376989ms","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-08T17:32:56.646614Z","caller":"traceutil/trace.go:171","msg":"trace[1647190371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:782; }","duration":"557.42406ms","start":"2026-02-08T17:32:56.089179Z","end":"2026-02-08T17:32:56.646603Z","steps":["trace[1647190371] 'range keys from in-memory index tree'  (duration: 557.271766ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:56.646632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:56.089166Z","time spent":"557.460181ms","remote":"127.0.0.1:51366","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-08T17:32:56.646749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.182685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-08T17:32:56.646766Z","caller":"traceutil/trace.go:171","msg":"trace[2024073442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:782; }","duration":"557.207315ms","start":"2026-02-08T17:32:56.089554Z","end":"2026-02-08T17:32:56.646761Z","steps":["trace[2024073442] 'range keys from in-memory index tree'  (duration: 557.131354ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:56.646782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:56.08955Z","time spent":"557.228565ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-08T17:32:56.646883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.507722ms","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-08T17:32:56.6469Z","caller":"traceutil/trace.go:171","msg":"trace[368858049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:782; }","duration":"554.547523ms","start":"2026-02-08T17:32:56.092348Z","end":"2026-02-08T17:32:56.646895Z","steps":["trace[368858049] 'range keys from in-memory index tree'  (duration: 554.459471ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:56.646964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:56.092342Z","time spent":"554.617495ms","remote":"127.0.0.1:51366","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-08T17:32:56.647118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.687747ms","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-08T17:32:56.647137Z","caller":"traceutil/trace.go:171","msg":"trace[774596574] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:782; }","duration":"460.756988ms","start":"2026-02-08T17:32:56.186373Z","end":"2026-02-08T17:32:56.64713Z","steps":["trace[774596574] 'range keys from in-memory index tree'  (duration: 460.597894ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:56.647153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:56.186357Z","time spent":"460.792079ms","remote":"127.0.0.1:51366","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-08T17:32:56.647454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.919874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-08T17:32:56.647473Z","caller":"traceutil/trace.go:171","msg":"trace[314854050] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:782; }","duration":"148.974855ms","start":"2026-02-08T17:32:56.498492Z","end":"2026-02-08T17:32:56.647467Z","steps":["trace[314854050] 'count revisions from in-memory index tree'  (duration: 148.864633ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:56.922614Z","caller":"traceutil/trace.go:171","msg":"trace[2067752520] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"268.231716ms","start":"2026-02-08T17:32:56.654354Z","end":"2026-02-08T17:32:56.922586Z","steps":["trace[2067752520] 'process raft request'  (duration: 267.914479ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:56.922663Z","caller":"traceutil/trace.go:171","msg":"trace[1586721708] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"267.244193ms","start":"2026-02-08T17:32:56.655402Z","end":"2026-02-08T17:32:56.922647Z","steps":["trace[1586721708] 'process raft request'  (duration: 266.954167ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:56.922774Z","caller":"traceutil/trace.go:171","msg":"trace[440612241] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"264.300404ms","start":"2026-02-08T17:32:56.658468Z","end":"2026-02-08T17:32:56.922768Z","steps":["trace[440612241] 'process raft request'  (duration: 263.929775ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:59.26356Z","caller":"traceutil/trace.go:171","msg":"trace[302204985] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"333.88685ms","start":"2026-02-08T17:32:58.929656Z","end":"2026-02-08T17:32:59.263543Z","steps":["trace[302204985] 'process raft request'  (duration: 333.761637ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:59.263662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:58.92964Z","time spent":"333.969362ms","remote":"127.0.0.1:51366","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:784 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-08T17:32:59.263978Z","caller":"traceutil/trace.go:171","msg":"trace[1044159663] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:815; }","duration":"334.093216ms","start":"2026-02-08T17:32:58.929879Z","end":"2026-02-08T17:32:59.263972Z","steps":["trace[1044159663] 'read index received'  (duration: 334.091326ms)","trace[1044159663] 'applied index is now lower than readState.Index'  (duration: 1.5µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:32:59.264048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.164848ms","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-08T17:32:59.264062Z","caller":"traceutil/trace.go:171","msg":"trace[28035120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:789; }","duration":"334.187258ms","start":"2026-02-08T17:32:58.92987Z","end":"2026-02-08T17:32:59.264058Z","steps":["trace[28035120] 'agreement among raft nodes before linearized reading'  (duration: 334.124946ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:59.264078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:58.929866Z","time spent":"334.206488ms","remote":"127.0.0.1:51366","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":"info","ts":"2026-02-08T17:32:59.709233Z","caller":"traceutil/trace.go:171","msg":"trace[1122828741] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"777.96589ms","start":"2026-02-08T17:32:58.931243Z","end":"2026-02-08T17:32:59.709209Z","steps":["trace[1122828741] 'process raft request'  (duration: 721.999041ms)","trace[1122828741] 'compare'  (duration: 55.773294ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:32:59.709361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:58.931237Z","time spent":"778.057182ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:786 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-08T17:32:59.710162Z","caller":"traceutil/trace.go:171","msg":"trace[2085655397] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:815; }","duration":"192.028753ms","start":"2026-02-08T17:32:59.518121Z","end":"2026-02-08T17:32:59.710149Z","steps":["trace[2085655397] 'read index received'  (duration: 135.132392ms)","trace[2085655397] 'applied index is now lower than readState.Index'  (duration: 56.895621ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:32:59.710294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.172936ms","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-08T17:32:59.710323Z","caller":"traceutil/trace.go:171","msg":"trace[1905158396] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:791; }","duration":"192.234638ms","start":"2026-02-08T17:32:59.518079Z","end":"2026-02-08T17:32:59.710313Z","steps":["trace[1905158396] 'agreement among raft nodes before linearized reading'  (duration: 192.113095ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:32:59.710537Z","caller":"traceutil/trace.go:171","msg":"trace[1490020916] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"442.520303ms","start":"2026-02-08T17:32:59.268005Z","end":"2026-02-08T17:32:59.710526Z","steps":["trace[1490020916] 'process raft request'  (duration: 442.080233ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:32:59.710594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:59.267994Z","time spent":"442.565854ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:785 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-08T17:33:00.308036Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600014238366646,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-08T17:33:00.538016Z","caller":"traceutil/trace.go:171","msg":"trace[651037437] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"730.125833ms","start":"2026-02-08T17:32:59.807869Z","end":"2026-02-08T17:33:00.537995Z","steps":["trace[651037437] 'read index received'  (duration: 658.022117ms)","trace[651037437] 'applied index is now lower than readState.Index'  (duration: 72.102566ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:33:00.538257Z","caller":"traceutil/trace.go:171","msg":"trace[816511354] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"822.823411ms","start":"2026-02-08T17:32:59.71542Z","end":"2026-02-08T17:33:00.538244Z","steps":["trace[816511354] 'process raft request'  (duration: 750.52862ms)","trace[816511354] 'compare'  (duration: 71.964823ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:00.538356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:59.715393Z","time spent":"822.891032ms","remote":"127.0.0.1:51366","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:787 > 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-08T17:33:00.538565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.691046ms","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-08T17:33:00.538596Z","caller":"traceutil/trace.go:171","msg":"trace[864332841] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:792; }","duration":"730.723616ms","start":"2026-02-08T17:32:59.807863Z","end":"2026-02-08T17:33:00.538586Z","steps":["trace[864332841] 'agreement among raft nodes before linearized reading'  (duration: 730.671505ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:00.538624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:59.807803Z","time spent":"730.813419ms","remote":"127.0.0.1:51242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "}
{"level":"warn","ts":"2026-02-08T17:33:00.538949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.359204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:33:00.538974Z","caller":"traceutil/trace.go:171","msg":"trace[1749357815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:792; }","duration":"649.403534ms","start":"2026-02-08T17:32:59.889563Z","end":"2026-02-08T17:33:00.538966Z","steps":["trace[1749357815] 'agreement among raft nodes before linearized reading'  (duration: 649.364163ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:00.538997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:32:59.88955Z","time spent":"649.442415ms","remote":"127.0.0.1:51072","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-08T17:33:11.574274Z","caller":"traceutil/trace.go:171","msg":"trace[1463499393] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"270.55541ms","start":"2026-02-08T17:33:11.303701Z","end":"2026-02-08T17:33:11.574256Z","steps":["trace[1463499393] 'process raft request'  (duration: 270.438347ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:33:12.714796Z","caller":"traceutil/trace.go:171","msg":"trace[377400152] linearizableReadLoop","detail":"{readStateIndex:908; appliedIndex:907; }","duration":"125.382153ms","start":"2026-02-08T17:33:12.589399Z","end":"2026-02-08T17:33:12.714781Z","steps":["trace[377400152] 'read index received'  (duration: 125.2564ms)","trace[377400152] 'applied index is now lower than readState.Index'  (duration: 125.143µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:12.714955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.542217ms","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-08T17:33:12.714973Z","caller":"traceutil/trace.go:171","msg":"trace[1691746495] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:877; }","duration":"125.611178ms","start":"2026-02-08T17:33:12.589357Z","end":"2026-02-08T17:33:12.714968Z","steps":["trace[1691746495] 'agreement among raft nodes before linearized reading'  (duration: 125.478135ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:33:12.715087Z","caller":"traceutil/trace.go:171","msg":"trace[308898277] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"275.831322ms","start":"2026-02-08T17:33:12.43925Z","end":"2026-02-08T17:33:12.715081Z","steps":["trace[308898277] 'process raft request'  (duration: 275.442113ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:13.688717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.147101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-08T17:33:13.688771Z","caller":"traceutil/trace.go:171","msg":"trace[1633602886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:878; }","duration":"111.235062ms","start":"2026-02-08T17:33:13.577522Z","end":"2026-02-08T17:33:13.688757Z","steps":["trace[1633602886] 'range keys from in-memory index tree'  (duration: 111.036598ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:13.689063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.462853ms","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-08T17:33:13.689081Z","caller":"traceutil/trace.go:171","msg":"trace[1483160853] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:878; }","duration":"478.509184ms","start":"2026-02-08T17:33:13.210565Z","end":"2026-02-08T17:33:13.689074Z","steps":["trace[1483160853] 'count revisions from in-memory index tree'  (duration: 478.419212ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:13.689097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:13.210552Z","time spent":"478.540595ms","remote":"127.0.0.1:51616","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-08T17:33:13.689155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.812664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-08T17:33:13.689216Z","caller":"traceutil/trace.go:171","msg":"trace[761200901] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:878; }","duration":"803.914837ms","start":"2026-02-08T17:33:12.885284Z","end":"2026-02-08T17:33:13.689198Z","steps":["trace[761200901] 'range keys from in-memory index tree'  (duration: 803.683811ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:13.689244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:12.885269Z","time spent":"803.969108ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-08T17:33:13.689375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.017607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:33:13.689392Z","caller":"traceutil/trace.go:171","msg":"trace[139799438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:878; }","duration":"803.044357ms","start":"2026-02-08T17:33:12.886342Z","end":"2026-02-08T17:33:13.689386Z","steps":["trace[139799438] 'range keys from in-memory index tree'  (duration: 802.992475ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:13.689408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:12.886337Z","time spent":"803.067997ms","remote":"127.0.0.1:51072","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-08T17:33:14.735777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.913961ms","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-08T17:33:14.73589Z","caller":"traceutil/trace.go:171","msg":"trace[452867787] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:879; }","duration":"873.035934ms","start":"2026-02-08T17:33:13.862839Z","end":"2026-02-08T17:33:14.735874Z","steps":["trace[452867787] 'range keys from in-memory index tree'  (duration: 872.89923ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:14.736313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.903884ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9997600014238366849 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-08T17:33:14.736364Z","caller":"traceutil/trace.go:171","msg":"trace[684496569] linearizableReadLoop","detail":"{readStateIndex:911; appliedIndex:910; }","duration":"965.645331ms","start":"2026-02-08T17:33:13.770709Z","end":"2026-02-08T17:33:14.736354Z","steps":["trace[684496569] 'read index received'  (duration: 97.612724ms)","trace[684496569] 'applied index is now lower than readState.Index'  (duration: 868.031727ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:33:14.736438Z","caller":"traceutil/trace.go:171","msg":"trace[1497530932] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"1.04257327s","start":"2026-02-08T17:33:13.693853Z","end":"2026-02-08T17:33:14.736427Z","steps":["trace[1497530932] 'process raft request'  (duration: 174.501272ms)","trace[1497530932] 'compare'  (duration: 867.73977ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:14.736514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:13.693849Z","time spent":"1.042636911s","remote":"127.0.0.1:51366","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-08T17:33:14.736655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.776974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-08T17:33:14.736722Z","caller":"traceutil/trace.go:171","msg":"trace[1248537742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:880; }","duration":"912.879096ms","start":"2026-02-08T17:33:13.823825Z","end":"2026-02-08T17:33:14.736705Z","steps":["trace[1248537742] 'agreement among raft nodes before linearized reading'  (duration: 912.712282ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:14.73676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:13.823787Z","time spent":"912.965108ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-08T17:33:14.736852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.143582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-08T17:33:14.73691Z","caller":"traceutil/trace.go:171","msg":"trace[808716058] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:880; }","duration":"966.227084ms","start":"2026-02-08T17:33:13.770673Z","end":"2026-02-08T17:33:14.7369Z","steps":["trace[808716058] 'agreement among raft nodes before linearized reading'  (duration: 966.087881ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:14.736941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:13.770657Z","time spent":"966.276776ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-02-08T17:33:14.903318Z","caller":"traceutil/trace.go:171","msg":"trace[931350424] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"148.941164ms","start":"2026-02-08T17:33:14.75435Z","end":"2026-02-08T17:33:14.903291Z","steps":["trace[931350424] 'process raft request'  (duration: 132.749235ms)","trace[931350424] 'compare'  (duration: 16.113077ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:33:14.9874Z","caller":"traceutil/trace.go:171","msg":"trace[785016622] linearizableReadLoop","detail":"{readStateIndex:914; appliedIndex:911; }","duration":"101.475954ms","start":"2026-02-08T17:33:14.885906Z","end":"2026-02-08T17:33:14.987382Z","steps":["trace[785016622] 'read index received'  (duration: 1.257249ms)","trace[785016622] 'applied index is now lower than readState.Index'  (duration: 100.217995ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:14.987497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.582196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:33:14.987517Z","caller":"traceutil/trace.go:171","msg":"trace[1271425613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:883; }","duration":"101.631827ms","start":"2026-02-08T17:33:14.885879Z","end":"2026-02-08T17:33:14.987511Z","steps":["trace[1271425613] 'agreement among raft nodes before linearized reading'  (duration: 101.566226ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:33:14.987742Z","caller":"traceutil/trace.go:171","msg":"trace[1936948895] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"233.235096ms","start":"2026-02-08T17:33:14.7545Z","end":"2026-02-08T17:33:14.987735Z","steps":["trace[1936948895] 'process raft request'  (duration: 232.784186ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:33:14.987825Z","caller":"traceutil/trace.go:171","msg":"trace[862166081] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"233.287647ms","start":"2026-02-08T17:33:14.754532Z","end":"2026-02-08T17:33:14.987819Z","steps":["trace[862166081] 'process raft request'  (duration: 232.828367ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:23.385001Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600014238366910,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-08T17:33:23.715608Z","caller":"traceutil/trace.go:171","msg":"trace[984400995] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"955.104003ms","start":"2026-02-08T17:33:22.760486Z","end":"2026-02-08T17:33:23.71559Z","steps":["trace[984400995] 'process raft request'  (duration: 954.99647ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:23.715705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:22.760478Z","time spent":"955.177934ms","remote":"127.0.0.1:51366","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:896 > 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-08T17:33:24.068529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.697476ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-08T17:33:24.068615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.263914ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9997600014238366912 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:877 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-08T17:33:24.068709Z","caller":"traceutil/trace.go:171","msg":"trace[1465970755] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"1.18406943s","start":"2026-02-08T17:33:22.884624Z","end":"2026-02-08T17:33:24.068693Z","steps":["trace[1465970755] 'read index received'  (duration: 831.343469ms)","trace[1465970755] 'applied index is now lower than readState.Index'  (duration: 352.725031ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:33:24.068653Z","caller":"traceutil/trace.go:171","msg":"trace[810316193] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:902; }","duration":"206.827179ms","start":"2026-02-08T17:33:23.861807Z","end":"2026-02-08T17:33:24.068634Z","steps":["trace[810316193] 'range keys from in-memory index tree'  (duration: 206.682936ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.068852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184221124s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:33:24.068885Z","caller":"traceutil/trace.go:171","msg":"trace[1972140531] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:903; }","duration":"1.184278984s","start":"2026-02-08T17:33:22.884596Z","end":"2026-02-08T17:33:24.068875Z","steps":["trace[1972140531] 'agreement among raft nodes before linearized reading'  (duration: 1.184225693s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.068918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:22.884582Z","time spent":"1.184328216s","remote":"127.0.0.1:51072","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-08T17:33:24.069013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123644515s","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-08T17:33:24.069045Z","caller":"traceutil/trace.go:171","msg":"trace[822246937] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:903; }","duration":"1.123701147s","start":"2026-02-08T17:33:22.945334Z","end":"2026-02-08T17:33:24.069035Z","steps":["trace[822246937] 'agreement among raft nodes before linearized reading'  (duration: 1.123582174s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.069081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:22.945318Z","time spent":"1.123755408s","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-02-08T17:33:24.069087Z","caller":"traceutil/trace.go:171","msg":"trace[902352222] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"1.03790346s","start":"2026-02-08T17:33:23.031167Z","end":"2026-02-08T17:33:24.069071Z","steps":["trace[902352222] 'process raft request'  (duration: 911.112124ms)","trace[902352222] 'compare'  (duration: 126.053689ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:24.069164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:23.031159Z","time spent":"1.037954681s","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:877 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-08T17:33:24.069272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.383699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-08T17:33:24.069302Z","caller":"traceutil/trace.go:171","msg":"trace[381911626] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:903; }","duration":"130.447671ms","start":"2026-02-08T17:33:23.938844Z","end":"2026-02-08T17:33:24.069292Z","steps":["trace[381911626] 'agreement among raft nodes before linearized reading'  (duration: 130.39715ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.069468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.986261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-08T17:33:24.069492Z","caller":"traceutil/trace.go:171","msg":"trace[868040660] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:903; }","duration":"251.032391ms","start":"2026-02-08T17:33:23.818452Z","end":"2026-02-08T17:33:24.069485Z","steps":["trace[868040660] 'agreement among raft nodes before linearized reading'  (duration: 250.95791ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.069594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.041055694s","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-08T17:33:24.069627Z","caller":"traceutil/trace.go:171","msg":"trace[1643384407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:903; }","duration":"1.041110824s","start":"2026-02-08T17:33:23.028507Z","end":"2026-02-08T17:33:24.069618Z","steps":["trace[1643384407] 'agreement among raft nodes before linearized reading'  (duration: 1.040995892s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.069658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:23.028496Z","time spent":"1.041153255s","remote":"127.0.0.1:51366","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-08T17:33:24.069861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028641193s","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-08T17:33:24.069891Z","caller":"traceutil/trace.go:171","msg":"trace[1152032338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:903; }","duration":"1.028687235s","start":"2026-02-08T17:33:23.041194Z","end":"2026-02-08T17:33:24.069882Z","steps":["trace[1152032338] 'agreement among raft nodes before linearized reading'  (duration: 1.028607243s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.069917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:23.041189Z","time spent":"1.028721405s","remote":"127.0.0.1:51366","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-08T17:33:24.632445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.422921ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9997600014238366916 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:900 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-08T17:33:24.63254Z","caller":"traceutil/trace.go:171","msg":"trace[1452874377] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"546.492404ms","start":"2026-02-08T17:33:24.086029Z","end":"2026-02-08T17:33:24.632522Z","steps":["trace[1452874377] 'process raft request'  (duration: 185.907289ms)","trace[1452874377] 'compare'  (duration: 360.230327ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:24.632587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:24.086014Z","time spent":"546.550756ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:900 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-08T17:33:24.931975Z","caller":"traceutil/trace.go:171","msg":"trace[2103838947] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"845.52954ms","start":"2026-02-08T17:33:24.086427Z","end":"2026-02-08T17:33:24.931957Z","steps":["trace[2103838947] 'process raft request'  (duration: 845.391407ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.932076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:24.086102Z","time spent":"845.92136ms","remote":"127.0.0.1:51366","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:897 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-08T17:33:24.932132Z","caller":"traceutil/trace.go:171","msg":"trace[57745997] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"836.12831ms","start":"2026-02-08T17:33:24.095989Z","end":"2026-02-08T17:33:24.932118Z","steps":["trace[57745997] 'process raft request'  (duration: 835.940295ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.932219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:24.095976Z","time spent":"836.195831ms","remote":"127.0.0.1:51366","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:899 > 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-08T17:33:24.932361Z","caller":"traceutil/trace.go:171","msg":"trace[730662463] linearizableReadLoop","detail":"{readStateIndex:938; appliedIndex:936; }","duration":"836.912317ms","start":"2026-02-08T17:33:24.095442Z","end":"2026-02-08T17:33:24.932355Z","steps":["trace[730662463] 'read index received'  (duration: 176.503249ms)","trace[730662463] 'applied index is now lower than readState.Index'  (duration: 660.408438ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:24.932419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.974959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:33:24.932439Z","caller":"traceutil/trace.go:171","msg":"trace[338007323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:907; }","duration":"837.01082ms","start":"2026-02-08T17:33:24.095422Z","end":"2026-02-08T17:33:24.932433Z","steps":["trace[338007323] 'agreement among raft nodes before linearized reading'  (duration: 836.978999ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.932454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:24.095401Z","time spent":"837.049551ms","remote":"127.0.0.1:51072","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-08T17:33:24.932466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.176442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-08T17:33:24.932484Z","caller":"traceutil/trace.go:171","msg":"trace[597763417] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:907; }","duration":"736.222652ms","start":"2026-02-08T17:33:24.196256Z","end":"2026-02-08T17:33:24.932479Z","steps":["trace[597763417] 'agreement among raft nodes before linearized reading'  (duration: 736.190741ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.9325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:24.19624Z","time spent":"736.256884ms","remote":"127.0.0.1:51292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "}
{"level":"info","ts":"2026-02-08T17:33:24.932525Z","caller":"traceutil/trace.go:171","msg":"trace[1901191404] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"835.432354ms","start":"2026-02-08T17:33:24.097087Z","end":"2026-02-08T17:33:24.932519Z","steps":["trace[1901191404] 'process raft request'  (duration: 834.984694ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:24.932555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:24.09708Z","time spent":"835.458125ms","remote":"127.0.0.1:51366","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:898 > 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-08T17:33:27.441693Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600014238366931,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-08T17:33:27.810315Z","caller":"traceutil/trace.go:171","msg":"trace[460472980] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"869.383429ms","start":"2026-02-08T17:33:26.940914Z","end":"2026-02-08T17:33:27.810298Z","steps":["trace[460472980] 'process raft request'  (duration: 869.293427ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:27.810454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:26.940903Z","time spent":"869.45992ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:907 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-08T17:33:28.198114Z","caller":"traceutil/trace.go:171","msg":"trace[1186610925] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"1.257054327s","start":"2026-02-08T17:33:26.941033Z","end":"2026-02-08T17:33:28.198087Z","steps":["trace[1186610925] 'process raft request'  (duration: 1.256812832s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:28.198214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:26.941029Z","time spent":"1.25713413s","remote":"127.0.0.1:51366","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:905 > 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-08T17:33:28.371513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.52274ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9997600014238366934 > lease_revoke:<id:0abe9c3e4f1e3c72>","response":"size:28"}
{"level":"info","ts":"2026-02-08T17:33:28.37195Z","caller":"traceutil/trace.go:171","msg":"trace[1271725022] linearizableReadLoop","detail":"{readStateIndex:945; appliedIndex:944; }","duration":"1.430932065s","start":"2026-02-08T17:33:26.941002Z","end":"2026-02-08T17:33:28.371934Z","steps":["trace[1271725022] 'read index received'  (duration: 869.753727ms)","trace[1271725022] 'applied index is now lower than readState.Index'  (duration: 561.177258ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:28.372119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.431107029s","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-08T17:33:28.372145Z","caller":"traceutil/trace.go:171","msg":"trace[812114340] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:912; }","duration":"1.43114473s","start":"2026-02-08T17:33:26.940989Z","end":"2026-02-08T17:33:28.372134Z","steps":["trace[812114340] 'agreement among raft nodes before linearized reading'  (duration: 1.431043417s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:28.372166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:26.940985Z","time spent":"1.431176251s","remote":"127.0.0.1:51366","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-08T17:33:28.372334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.268119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-08T17:33:28.372353Z","caller":"traceutil/trace.go:171","msg":"trace[135208500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:912; }","duration":"608.328601ms","start":"2026-02-08T17:33:27.764018Z","end":"2026-02-08T17:33:28.372347Z","steps":["trace[135208500] 'agreement among raft nodes before linearized reading'  (duration: 608.268879ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:28.37237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:27.763995Z","time spent":"608.371132ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-08T17:33:28.372499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.15161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:33:28.372516Z","caller":"traceutil/trace.go:171","msg":"trace[1604062477] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:912; }","duration":"488.19082ms","start":"2026-02-08T17:33:27.88432Z","end":"2026-02-08T17:33:28.372511Z","steps":["trace[1604062477] 'agreement among raft nodes before linearized reading'  (duration: 488.15674ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:28.372532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:27.884294Z","time spent":"488.234252ms","remote":"127.0.0.1:51072","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-08T17:33:36.30718Z","caller":"traceutil/trace.go:171","msg":"trace[539680861] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"127.785ms","start":"2026-02-08T17:33:36.179378Z","end":"2026-02-08T17:33:36.307163Z","steps":["trace[539680861] 'process raft request'  (duration: 127.35368ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:36.988386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.768763ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9997600014238367042 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-08T17:33:36.988487Z","caller":"traceutil/trace.go:171","msg":"trace[890762486] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:998; }","duration":"373.121328ms","start":"2026-02-08T17:33:36.615338Z","end":"2026-02-08T17:33:36.988459Z","steps":["trace[890762486] 'read index received'  (duration: 41.401µs)","trace[890762486] 'applied index is now lower than readState.Index'  (duration: 373.078637ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:33:36.988726Z","caller":"traceutil/trace.go:171","msg":"trace[1619371951] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"499.144897ms","start":"2026-02-08T17:33:36.489567Z","end":"2026-02-08T17:33:36.988712Z","steps":["trace[1619371951] 'process raft request'  (duration: 24.972005ms)","trace[1619371951] 'compare'  (duration: 473.65333ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:36.988787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:36.489558Z","time spent":"499.196638ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-08T17:33:36.988972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.62819ms","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-08T17:33:36.989002Z","caller":"traceutil/trace.go:171","msg":"trace[2053819350] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:964; }","duration":"373.694151ms","start":"2026-02-08T17:33:36.615297Z","end":"2026-02-08T17:33:36.988991Z","steps":["trace[2053819350] 'agreement among raft nodes before linearized reading'  (duration: 373.62342ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:36.989032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:36.61528Z","time spent":"373.743963ms","remote":"127.0.0.1:51462","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-08T17:33:36.989228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.62742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-08T17:33:36.989254Z","caller":"traceutil/trace.go:171","msg":"trace[54391319] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:964; }","duration":"255.703351ms","start":"2026-02-08T17:33:36.733543Z","end":"2026-02-08T17:33:36.989246Z","steps":["trace[54391319] 'agreement among raft nodes before linearized reading'  (duration: 255.609859ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:42.461817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.767638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.218\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-08T17:33:42.461889Z","caller":"traceutil/trace.go:171","msg":"trace[1431456010] range","detail":"{range_begin:/registry/masterleases/162.253.55.218; range_end:; response_count:1; response_revision:991; }","duration":"162.890281ms","start":"2026-02-08T17:33:42.298981Z","end":"2026-02-08T17:33:42.461871Z","steps":["trace[1431456010] 'range keys from in-memory index tree'  (duration: 162.591264ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:42.462153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.047329ms","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-08T17:33:42.462181Z","caller":"traceutil/trace.go:171","msg":"trace[996726126] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:991; }","duration":"126.108951ms","start":"2026-02-08T17:33:42.336064Z","end":"2026-02-08T17:33:42.462173Z","steps":["trace[996726126] 'range keys from in-memory index tree'  (duration: 125.898965ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:33:42.971166Z","caller":"traceutil/trace.go:171","msg":"trace[1932014125] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"392.906703ms","start":"2026-02-08T17:33:42.578241Z","end":"2026-02-08T17:33:42.971147Z","steps":["trace[1932014125] 'process raft request'  (duration: 392.857712ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:42.971283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:42.57822Z","time spent":"393.001964ms","remote":"127.0.0.1:51130","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/162.253.55.218\" mod_revision:931 > success:<request_put:<key:\"/registry/masterleases/162.253.55.218\" value_size:67 lease:774227977383591294 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.218\" > >"}
{"level":"info","ts":"2026-02-08T17:33:42.971507Z","caller":"traceutil/trace.go:171","msg":"trace[410470357] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"500.715954ms","start":"2026-02-08T17:33:42.470783Z","end":"2026-02-08T17:33:42.971499Z","steps":["trace[410470357] 'process raft request'  (duration: 420.541588ms)","trace[410470357] 'compare'  (duration: 79.647623ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:42.971547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:42.470766Z","time spent":"500.756995ms","remote":"127.0.0.1:51366","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:987 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-08T17:33:42.971628Z","caller":"traceutil/trace.go:171","msg":"trace[412816701] linearizableReadLoop","detail":"{readStateIndex:1029; appliedIndex:1028; }","duration":"471.767378ms","start":"2026-02-08T17:33:42.499853Z","end":"2026-02-08T17:33:42.971621Z","steps":["trace[412816701] 'read index received'  (duration: 42.770152ms)","trace[412816701] 'applied index is now lower than readState.Index'  (duration: 428.996226ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:42.971777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.920681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-08T17:33:42.971798Z","caller":"traceutil/trace.go:171","msg":"trace[349535835] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:993; }","duration":"471.964332ms","start":"2026-02-08T17:33:42.499828Z","end":"2026-02-08T17:33:42.971792Z","steps":["trace[349535835] 'agreement among raft nodes before linearized reading'  (duration: 471.88594ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:42.971827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:42.499816Z","time spent":"471.995032ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-08T17:33:42.97195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.603119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"}
{"level":"info","ts":"2026-02-08T17:33:42.971969Z","caller":"traceutil/trace.go:171","msg":"trace[1980129232] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:993; }","duration":"234.65841ms","start":"2026-02-08T17:33:42.737303Z","end":"2026-02-08T17:33:42.971961Z","steps":["trace[1980129232] 'agreement among raft nodes before linearized reading'  (duration: 234.609918ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:43.936198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.910905ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9997600014238367110 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:972 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:425 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-08T17:33:43.93634Z","caller":"traceutil/trace.go:171","msg":"trace[442663986] linearizableReadLoop","detail":"{readStateIndex:1032; appliedIndex:1030; }","duration":"952.730978ms","start":"2026-02-08T17:33:42.983594Z","end":"2026-02-08T17:33:43.936325Z","steps":["trace[442663986] 'read index received'  (duration: 157.636908ms)","trace[442663986] 'applied index is now lower than readState.Index'  (duration: 795.09321ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:33:43.936552Z","caller":"traceutil/trace.go:171","msg":"trace[957650379] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"953.898805ms","start":"2026-02-08T17:33:42.98264Z","end":"2026-02-08T17:33:43.936538Z","steps":["trace[957650379] 'process raft request'  (duration: 158.58322ms)","trace[957650379] 'compare'  (duration: 794.434525ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:43.936609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:42.98263Z","time spent":"953.949216ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:972 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:425 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-02-08T17:33:43.936749Z","caller":"traceutil/trace.go:171","msg":"trace[957451695] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"953.908224ms","start":"2026-02-08T17:33:42.982831Z","end":"2026-02-08T17:33:43.936739Z","steps":["trace[957451695] 'process raft request'  (duration: 953.451054ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:43.936794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:42.982824Z","time spent":"953.946736ms","remote":"127.0.0.1:51366","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:988 > 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-08T17:33:43.936916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.316981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-02-08T17:33:43.936944Z","caller":"traceutil/trace.go:171","msg":"trace[419901892] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:995; }","duration":"953.353572ms","start":"2026-02-08T17:33:42.983581Z","end":"2026-02-08T17:33:43.936934Z","steps":["trace[419901892] 'agreement among raft nodes before linearized reading'  (duration: 953.303431ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:43.936969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:42.983574Z","time spent":"953.389523ms","remote":"127.0.0.1:51368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "}
{"level":"warn","ts":"2026-02-08T17:33:43.937101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.654552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:33:43.937125Z","caller":"traceutil/trace.go:171","msg":"trace[1208313533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"936.690552ms","start":"2026-02-08T17:33:43.000427Z","end":"2026-02-08T17:33:43.937117Z","steps":["trace[1208313533] 'agreement among raft nodes before linearized reading'  (duration: 936.655641ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:43.93717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:43.000401Z","time spent":"936.763473ms","remote":"127.0.0.1:51086","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-08T17:33:43.937628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.611692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-02-08T17:33:43.940094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.648997ms","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-08T17:33:43.940131Z","caller":"traceutil/trace.go:171","msg":"trace[1744080390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:995; }","duration":"926.699108ms","start":"2026-02-08T17:33:43.013421Z","end":"2026-02-08T17:33:43.940121Z","steps":["trace[1744080390] 'agreement among raft nodes before linearized reading'  (duration: 926.593346ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:43.94016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:43.013415Z","time spent":"926.738179ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-08T17:33:43.937668Z","caller":"traceutil/trace.go:171","msg":"trace[1375355211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:995; }","duration":"892.663133ms","start":"2026-02-08T17:33:43.044986Z","end":"2026-02-08T17:33:43.937649Z","steps":["trace[1375355211] 'agreement among raft nodes before linearized reading'  (duration: 892.589052ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:43.946977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T17:33:43.044975Z","time spent":"901.971721ms","remote":"127.0.0.1:51366","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":"info","ts":"2026-02-08T17:33:44.138617Z","caller":"traceutil/trace.go:171","msg":"trace[1777193924] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"189.109404ms","start":"2026-02-08T17:33:43.949482Z","end":"2026-02-08T17:33:44.138591Z","steps":["trace[1777193924] 'process raft request'  (duration: 103.269496ms)","trace[1777193924] 'compare'  (duration: 85.564691ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:33:44.138917Z","caller":"traceutil/trace.go:171","msg":"trace[1482362781] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1032; }","duration":"184.186159ms","start":"2026-02-08T17:33:43.954711Z","end":"2026-02-08T17:33:44.138897Z","steps":["trace[1482362781] 'read index received'  (duration: 98.046204ms)","trace[1482362781] 'applied index is now lower than readState.Index'  (duration: 86.138955ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T17:33:44.139018Z","caller":"traceutil/trace.go:171","msg":"trace[1033444272] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"184.243779ms","start":"2026-02-08T17:33:43.954765Z","end":"2026-02-08T17:33:44.139009Z","steps":["trace[1033444272] 'process raft request'  (duration: 184.100346ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:33:44.13895Z","caller":"traceutil/trace.go:171","msg":"trace[1650908564] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"185.97137ms","start":"2026-02-08T17:33:43.952963Z","end":"2026-02-08T17:33:44.138934Z","steps":["trace[1650908564] 'process raft request'  (duration: 185.834717ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:44.13921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.481716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:33:44.139242Z","caller":"traceutil/trace.go:171","msg":"trace[1963162481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"184.539367ms","start":"2026-02-08T17:33:43.954693Z","end":"2026-02-08T17:33:44.139232Z","steps":["trace[1963162481] 'agreement among raft nodes before linearized reading'  (duration: 184.474715ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T17:33:44.139304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.884697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T17:33:44.13934Z","caller":"traceutil/trace.go:171","msg":"trace[975990999] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:998; }","duration":"111.96589ms","start":"2026-02-08T17:33:44.027364Z","end":"2026-02-08T17:33:44.13933Z","steps":["trace[975990999] 'agreement among raft nodes before linearized reading'  (duration: 111.891688ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:33:46.705638Z","caller":"traceutil/trace.go:171","msg":"trace[534692578] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"111.774585ms","start":"2026-02-08T17:33:46.59384Z","end":"2026-02-08T17:33:46.705615Z","steps":["trace[534692578] 'process raft request'  (duration: 111.629071ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T17:33:46.879195Z","caller":"traceutil/trace.go:171","msg":"trace[204431921] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"238.194953ms","start":"2026-02-08T17:33:46.640974Z","end":"2026-02-08T17:33:46.879169Z","steps":["trace[204431921] 'process raft request'  (duration: 165.293207ms)","trace[204431921] 'compare'  (duration: 72.818664ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T17:33:47.14479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.61218ms","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-08T17:33:47.144865Z","caller":"traceutil/trace.go:171","msg":"trace[347745906] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1027; }","duration":"162.114072ms","start":"2026-02-08T17:33:46.982734Z","end":"2026-02-08T17:33:47.144848Z","steps":["trace[347745906] 'range keys from in-memory index tree'  (duration: 161.470007ms)"],"step_count":1}