{"level":"warn","ts":"2026-01-20T20:25:46.87009Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-20T20:25:46.870338Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.62: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.62:2380","--initial-cluster=instance=https://162.253.55.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.62: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-01-20T20:25:46.870452Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-01-20T20:25:46.870504Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.62:2380"]}
{"level":"info","ts":"2026-01-20T20:25:46.870542Z","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-01-20T20:25:46.871313Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"]}
{"level":"info","ts":"2026-01-20T20:25:46.871473Z","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.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.62: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-01-20T20:25:46.877562Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.779292ms"}
{"level":"info","ts":"2026-01-20T20:25:46.904695Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"791a7e25b533cd26","cluster-id":"be484d2748da72cd"}
{"level":"info","ts":"2026-01-20T20:25:46.904788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=()"}
{"level":"info","ts":"2026-01-20T20:25:46.90482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 0"}
{"level":"info","ts":"2026-01-20T20:25:46.904857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 791a7e25b533cd26 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-01-20T20:25:46.904893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 1"}
{"level":"info","ts":"2026-01-20T20:25:46.904951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"}
{"level":"warn","ts":"2026-01-20T20:25:46.912321Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-01-20T20:25:46.916527Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-01-20T20:25:46.920021Z","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-01-20T20:25:46.928301Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"791a7e25b533cd26","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-01-20T20:25:46.928685Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"791a7e25b533cd26","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-01-20T20:25:46.928835Z","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-01-20T20:25:46.928891Z","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-01-20T20:25:46.928919Z","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-01-20T20:25:46.929487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"}
{"level":"info","ts":"2026-01-20T20:25:46.938009Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","added-peer-id":"791a7e25b533cd26","added-peer-peer-urls":["https://162.253.55.62:2380"]}
{"level":"info","ts":"2026-01-20T20:25:46.942223Z","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-01-20T20:25:46.942471Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"791a7e25b533cd26","initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-01-20T20:25:46.942535Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-01-20T20:25:46.943099Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.62:2380"}
{"level":"info","ts":"2026-01-20T20:25:46.943142Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.62:2380"}
{"level":"info","ts":"2026-01-20T20:25:47.20642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 is starting a new election at term 1"}
{"level":"info","ts":"2026-01-20T20:25:47.206463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became pre-candidate at term 1"}
{"level":"info","ts":"2026-01-20T20:25:47.206604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgPreVoteResp from 791a7e25b533cd26 at term 1"}
{"level":"info","ts":"2026-01-20T20:25:47.206624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became candidate at term 2"}
{"level":"info","ts":"2026-01-20T20:25:47.206678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgVoteResp from 791a7e25b533cd26 at term 2"}
{"level":"info","ts":"2026-01-20T20:25:47.20673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became leader at term 2"}
{"level":"info","ts":"2026-01-20T20:25:47.206743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 791a7e25b533cd26 elected leader 791a7e25b533cd26 at term 2"}
{"level":"info","ts":"2026-01-20T20:25:47.208529Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-20T20:25:47.208893Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"791a7e25b533cd26","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.62:2379]}","request-path":"/0/members/791a7e25b533cd26/attributes","cluster-id":"be484d2748da72cd","publish-timeout":"7s"}
{"level":"info","ts":"2026-01-20T20:25:47.208949Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-20T20:25:47.20946Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-01-20T20:25:47.20988Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-01-20T20:25:47.209913Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-01-20T20:25:47.214456Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-01-20T20:25:47.214676Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-20T20:25:47.21483Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-20T20:25:47.214959Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-01-20T20:25:47.21761Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.62:2379"}
{"level":"info","ts":"2026-01-20T20:26:05.923123Z","caller":"traceutil/trace.go:171","msg":"trace[2043660731] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:420; }","duration":"118.748558ms","start":"2026-01-20T20:26:05.804358Z","end":"2026-01-20T20:26:05.923106Z","steps":["trace[2043660731] 'read index received'  (duration: 118.582725ms)","trace[2043660731] 'applied index is now lower than readState.Index'  (duration: 165.153µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:05.923268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.880201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:26:05.923307Z","caller":"traceutil/trace.go:171","msg":"trace[1358637246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:410; }","duration":"118.967645ms","start":"2026-01-20T20:26:05.80433Z","end":"2026-01-20T20:26:05.923298Z","steps":["trace[1358637246] 'agreement among raft nodes before linearized reading'  (duration: 118.866482ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:05.923313Z","caller":"traceutil/trace.go:171","msg":"trace[2055991600] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"261.860517ms","start":"2026-01-20T20:26:05.661444Z","end":"2026-01-20T20:26:05.923305Z","steps":["trace[2055991600] 'process raft request'  (duration: 261.54497ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:07.181953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.379307ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744729745 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:405 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T20:26:07.182141Z","caller":"traceutil/trace.go:171","msg":"trace[154808606] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"1.255709666s","start":"2026-01-20T20:26:05.926417Z","end":"2026-01-20T20:26:07.182126Z","steps":["trace[154808606] 'process raft request'  (duration: 504.774896ms)","trace[154808606] 'compare'  (duration: 750.285585ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:07.18218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:05.926402Z","time spent":"1.255760866s","remote":"127.0.0.1:47812","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:405 > 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-01-20T20:26:07.517131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.109813ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744729746 > lease_revoke:<id:4d269bdd15b89ae1>","response":"size:28"}
{"level":"info","ts":"2026-01-20T20:26:07.517207Z","caller":"traceutil/trace.go:171","msg":"trace[89376855] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:421; }","duration":"1.252833352s","start":"2026-01-20T20:26:06.264363Z","end":"2026-01-20T20:26:07.517196Z","steps":["trace[89376855] 'read index received'  (duration: 166.924932ms)","trace[89376855] 'applied index is now lower than readState.Index'  (duration: 1.08590754s)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:07.517402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.253037186s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-01-20T20:26:07.517417Z","caller":"traceutil/trace.go:171","msg":"trace[107577589] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"1.253088877s","start":"2026-01-20T20:26:06.264323Z","end":"2026-01-20T20:26:07.517412Z","steps":["trace[107577589] 'agreement among raft nodes before linearized reading'  (duration: 1.253046946s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:07.517434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:06.264294Z","time spent":"1.253135698s","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-01-20T20:26:07.517535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.964705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:26:07.517549Z","caller":"traceutil/trace.go:171","msg":"trace[1393117488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:411; }","duration":"499.029898ms","start":"2026-01-20T20:26:07.018514Z","end":"2026-01-20T20:26:07.517544Z","steps":["trace[1393117488] 'agreement among raft nodes before linearized reading'  (duration: 499.011387ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:07.51756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:07.018488Z","time spent":"499.070118ms","remote":"127.0.0.1:47562","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-01-20T20:26:07.517654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.522341ms","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-01-20T20:26:07.517667Z","caller":"traceutil/trace.go:171","msg":"trace[1282940731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:411; }","duration":"258.587602ms","start":"2026-01-20T20:26:07.259075Z","end":"2026-01-20T20:26:07.517663Z","steps":["trace[1282940731] 'agreement among raft nodes before linearized reading'  (duration: 258.562252ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:19.755645Z","caller":"traceutil/trace.go:171","msg":"trace[1931875042] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"164.121629ms","start":"2026-01-20T20:26:19.591514Z","end":"2026-01-20T20:26:19.755635Z","steps":["trace[1931875042] 'process raft request'  (duration: 163.403162ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:19.755897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.093282ms","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-01-20T20:26:19.755916Z","caller":"traceutil/trace.go:171","msg":"trace[1166040170] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:475; }","duration":"141.139763ms","start":"2026-01-20T20:26:19.614771Z","end":"2026-01-20T20:26:19.75591Z","steps":["trace[1166040170] 'agreement among raft nodes before linearized reading'  (duration: 141.093962ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:19.755022Z","caller":"traceutil/trace.go:171","msg":"trace[946383248] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"140.214761ms","start":"2026-01-20T20:26:19.614792Z","end":"2026-01-20T20:26:19.755007Z","steps":["trace[946383248] 'read index received'  (duration: 140.072888ms)","trace[946383248] 'applied index is now lower than readState.Index'  (duration: 140.973µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:26:20.652024Z","caller":"traceutil/trace.go:171","msg":"trace[1108188502] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"337.437996ms","start":"2026-01-20T20:26:20.314555Z","end":"2026-01-20T20:26:20.651993Z","steps":["trace[1108188502] 'process raft request'  (duration: 337.247481ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:20.652214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:20.31454Z","time spent":"337.569308ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:419 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-01-20T20:26:20.940834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.806475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-01-20T20:26:20.940887Z","caller":"traceutil/trace.go:171","msg":"trace[4808369] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:478; }","duration":"132.899798ms","start":"2026-01-20T20:26:20.807971Z","end":"2026-01-20T20:26:20.940871Z","steps":["trace[4808369] 'range keys from in-memory index tree'  (duration: 132.732294ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:21.991088Z","caller":"traceutil/trace.go:171","msg":"trace[1413667321] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:494; }","duration":"202.958603ms","start":"2026-01-20T20:26:21.788113Z","end":"2026-01-20T20:26:21.991071Z","steps":["trace[1413667321] 'read index received'  (duration: 202.8303ms)","trace[1413667321] 'applied index is now lower than readState.Index'  (duration: 125.903µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:26:21.991294Z","caller":"traceutil/trace.go:171","msg":"trace[1424780722] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"748.308201ms","start":"2026-01-20T20:26:21.24298Z","end":"2026-01-20T20:26:21.991288Z","steps":["trace[1424780722] 'process raft request'  (duration: 748.004134ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:21.991396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:21.242969Z","time spent":"748.339761ms","remote":"127.0.0.1:47812","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:474 > 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-01-20T20:26:21.991502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.390763ms","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-01-20T20:26:21.991518Z","caller":"traceutil/trace.go:171","msg":"trace[514911869] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:480; }","duration":"203.428984ms","start":"2026-01-20T20:26:21.788084Z","end":"2026-01-20T20:26:21.991513Z","steps":["trace[514911869] 'agreement among raft nodes before linearized reading'  (duration: 203.396303ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:21.991584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.405413ms","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-01-20T20:26:21.991596Z","caller":"traceutil/trace.go:171","msg":"trace[470676308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:480; }","duration":"167.442704ms","start":"2026-01-20T20:26:21.824149Z","end":"2026-01-20T20:26:21.991592Z","steps":["trace[470676308] 'agreement among raft nodes before linearized reading'  (duration: 167.421533ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:23.000755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.182506ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744729900 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:475 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T20:26:23.00094Z","caller":"traceutil/trace.go:171","msg":"trace[587510908] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:495; }","duration":"994.040844ms","start":"2026-01-20T20:26:22.006872Z","end":"2026-01-20T20:26:23.000913Z","steps":["trace[587510908] 'read index received'  (duration: 145.625873ms)","trace[587510908] 'applied index is now lower than readState.Index'  (duration: 848.414051ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:26:23.002039Z","caller":"traceutil/trace.go:171","msg":"trace[1633312870] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"1.000603492s","start":"2026-01-20T20:26:22.001418Z","end":"2026-01-20T20:26:23.002021Z","steps":["trace[1633312870] 'process raft request'  (duration: 151.069846ms)","trace[1633312870] 'compare'  (duration: 848.074343ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:23.002123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:22.001406Z","time spent":"1.000676154s","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:475 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-20T20:26:23.004029Z","caller":"traceutil/trace.go:171","msg":"trace[152876219] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"1.002489044s","start":"2026-01-20T20:26:22.001517Z","end":"2026-01-20T20:26:23.004006Z","steps":["trace[152876219] 'process raft request'  (duration: 999.337174ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:23.004123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:22.001512Z","time spent":"1.002564546s","remote":"127.0.0.1:47812","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:476 > 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-01-20T20:26:23.004261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.380959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:26:23.004301Z","caller":"traceutil/trace.go:171","msg":"trace[1805802157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:482; }","duration":"997.434291ms","start":"2026-01-20T20:26:22.006853Z","end":"2026-01-20T20:26:23.004287Z","steps":["trace[1805802157] 'agreement among raft nodes before linearized reading'  (duration: 997.361369ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:23.004335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:22.006846Z","time spent":"997.481391ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-20T20:26:23.004439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.510488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:26:23.004489Z","caller":"traceutil/trace.go:171","msg":"trace[1421319212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:482; }","duration":"975.557458ms","start":"2026-01-20T20:26:22.0289Z","end":"2026-01-20T20:26:23.004458Z","steps":["trace[1421319212] 'agreement among raft nodes before linearized reading'  (duration: 975.513047ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:23.004516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:22.028888Z","time spent":"975.62104ms","remote":"127.0.0.1:47562","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-01-20T20:26:23.425Z","caller":"traceutil/trace.go:171","msg":"trace[1483272318] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"146.062152ms","start":"2026-01-20T20:26:23.278914Z","end":"2026-01-20T20:26:23.424976Z","steps":["trace[1483272318] 'process raft request'  (duration: 145.926219ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:28.321888Z","caller":"traceutil/trace.go:171","msg":"trace[1161439410] linearizableReadLoop","detail":"{readStateIndex:512; appliedIndex:511; }","duration":"296.131176ms","start":"2026-01-20T20:26:28.025733Z","end":"2026-01-20T20:26:28.321864Z","steps":["trace[1161439410] 'read index received'  (duration: 295.898749ms)","trace[1161439410] 'applied index is now lower than readState.Index'  (duration: 231.577µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:26:28.322025Z","caller":"traceutil/trace.go:171","msg":"trace[1465394842] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"703.491115ms","start":"2026-01-20T20:26:27.618524Z","end":"2026-01-20T20:26:28.322016Z","steps":["trace[1465394842] 'process raft request'  (duration: 703.182527ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:28.322135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:27.618506Z","time spent":"703.550596ms","remote":"127.0.0.1:47726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-2jhlb\" mod_revision:463 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-2jhlb\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-2jhlb\" > >"}
{"level":"warn","ts":"2026-01-20T20:26:28.322366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.127277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:26:28.322465Z","caller":"traceutil/trace.go:171","msg":"trace[1158823376] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:496; }","duration":"292.274369ms","start":"2026-01-20T20:26:28.030167Z","end":"2026-01-20T20:26:28.322441Z","steps":["trace[1158823376] 'agreement among raft nodes before linearized reading'  (duration: 292.114186ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:28.322667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.934923ms","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-01-20T20:26:28.322708Z","caller":"traceutil/trace.go:171","msg":"trace[882971549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:496; }","duration":"296.997305ms","start":"2026-01-20T20:26:28.025699Z","end":"2026-01-20T20:26:28.322696Z","steps":["trace[882971549] 'agreement among raft nodes before linearized reading'  (duration: 296.857942ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:31.156003Z","caller":"traceutil/trace.go:171","msg":"trace[2017490221] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"115.464306ms","start":"2026-01-20T20:26:31.040486Z","end":"2026-01-20T20:26:31.155951Z","steps":["trace[2017490221] 'read index received'  (duration: 115.18999ms)","trace[2017490221] 'applied index is now lower than readState.Index'  (duration: 272.376µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:26:31.156273Z","caller":"traceutil/trace.go:171","msg":"trace[728192616] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"278.018289ms","start":"2026-01-20T20:26:30.878202Z","end":"2026-01-20T20:26:31.15622Z","steps":["trace[728192616] 'process raft request'  (duration: 277.499427ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:31.156871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.351826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-01-20T20:26:31.156913Z","caller":"traceutil/trace.go:171","msg":"trace[713777624] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:519; }","duration":"116.455878ms","start":"2026-01-20T20:26:31.040443Z","end":"2026-01-20T20:26:31.156899Z","steps":["trace[713777624] 'agreement among raft nodes before linearized reading'  (duration: 116.205351ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:31.16515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.047905ms","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-01-20T20:26:31.165247Z","caller":"traceutil/trace.go:171","msg":"trace[1486005374] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"123.203929ms","start":"2026-01-20T20:26:31.042027Z","end":"2026-01-20T20:26:31.165231Z","steps":["trace[1486005374] 'agreement among raft nodes before linearized reading'  (duration: 122.990874ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:31.165438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.681312ms","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-01-20T20:26:31.165496Z","caller":"traceutil/trace.go:171","msg":"trace[1493900577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:519; }","duration":"115.750183ms","start":"2026-01-20T20:26:31.049738Z","end":"2026-01-20T20:26:31.165488Z","steps":["trace[1493900577] 'agreement among raft nodes before linearized reading'  (duration: 115.650471ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:31.838941Z","caller":"traceutil/trace.go:171","msg":"trace[2140994822] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"159.482915ms","start":"2026-01-20T20:26:31.679432Z","end":"2026-01-20T20:26:31.838915Z","steps":["trace[2140994822] 'process raft request'  (duration: 101.548852ms)","trace[2140994822] 'compare'  (duration: 57.324679ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:26:40.828055Z","caller":"traceutil/trace.go:171","msg":"trace[1947932170] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"210.560343ms","start":"2026-01-20T20:26:40.617466Z","end":"2026-01-20T20:26:40.828026Z","steps":["trace[1947932170] 'process raft request'  (duration: 210.433271ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:41.392116Z","caller":"traceutil/trace.go:171","msg":"trace[1677002184] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"172.621839ms","start":"2026-01-20T20:26:41.219466Z","end":"2026-01-20T20:26:41.392088Z","steps":["trace[1677002184] 'process raft request'  (duration: 172.432045ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:41.392493Z","caller":"traceutil/trace.go:171","msg":"trace[519095593] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:648; }","duration":"122.958464ms","start":"2026-01-20T20:26:41.269527Z","end":"2026-01-20T20:26:41.392486Z","steps":["trace[519095593] 'read index received'  (duration: 122.955364ms)","trace[519095593] 'applied index is now lower than readState.Index'  (duration: 2.55µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:41.392683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.031166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-01-20T20:26:41.392718Z","caller":"traceutil/trace.go:171","msg":"trace[1055588306] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"123.141358ms","start":"2026-01-20T20:26:41.269571Z","end":"2026-01-20T20:26:41.392712Z","steps":["trace[1055588306] 'agreement among raft nodes before linearized reading'  (duration: 122.956374ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:41.393026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.499637ms","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-01-20T20:26:41.393046Z","caller":"traceutil/trace.go:171","msg":"trace[353558515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"123.548438ms","start":"2026-01-20T20:26:41.269493Z","end":"2026-01-20T20:26:41.393041Z","steps":["trace[353558515] 'agreement among raft nodes before linearized reading'  (duration: 123.488997ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:41.393756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.811413ms","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-01-20T20:26:41.393778Z","caller":"traceutil/trace.go:171","msg":"trace[1095801517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"123.852113ms","start":"2026-01-20T20:26:41.269921Z","end":"2026-01-20T20:26:41.393773Z","steps":["trace[1095801517] 'agreement among raft nodes before linearized reading'  (duration: 123.790142ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:41.567643Z","caller":"traceutil/trace.go:171","msg":"trace[428796878] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"167.518936ms","start":"2026-01-20T20:26:41.400098Z","end":"2026-01-20T20:26:41.567617Z","steps":["trace[428796878] 'process raft request'  (duration: 90.721309ms)","trace[428796878] 'compare'  (duration: 76.682085ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:26:41.572105Z","caller":"traceutil/trace.go:171","msg":"trace[14671359] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"171.912854ms","start":"2026-01-20T20:26:41.400172Z","end":"2026-01-20T20:26:41.572085Z","steps":["trace[14671359] 'process raft request'  (duration: 171.613958ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:41.573078Z","caller":"traceutil/trace.go:171","msg":"trace[135506125] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"169.715816ms","start":"2026-01-20T20:26:41.403345Z","end":"2026-01-20T20:26:41.573061Z","steps":["trace[135506125] 'process raft request'  (duration: 168.566519ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:41.572446Z","caller":"traceutil/trace.go:171","msg":"trace[393246605] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"166.462742ms","start":"2026-01-20T20:26:41.405977Z","end":"2026-01-20T20:26:41.57244Z","steps":["trace[393246605] 'process raft request'  (duration: 166.073352ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:42.318601Z","caller":"traceutil/trace.go:171","msg":"trace[2107935207] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"236.899955ms","start":"2026-01-20T20:26:42.081672Z","end":"2026-01-20T20:26:42.318572Z","steps":["trace[2107935207] 'process raft request'  (duration: 235.232067ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:51.182843Z","caller":"traceutil/trace.go:171","msg":"trace[1684330373] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:717; }","duration":"294.719754ms","start":"2026-01-20T20:26:50.888093Z","end":"2026-01-20T20:26:51.182813Z","steps":["trace[1684330373] 'read index received'  (duration: 294.607252ms)","trace[1684330373] 'applied index is now lower than readState.Index'  (duration: 110.692µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:51.182859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:50.832966Z","time spent":"349.882105ms","remote":"127.0.0.1:47594","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-01-20T20:26:51.183126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.992031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:26:51.183166Z","caller":"traceutil/trace.go:171","msg":"trace[130285565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:695; }","duration":"295.120484ms","start":"2026-01-20T20:26:50.888032Z","end":"2026-01-20T20:26:51.183152Z","steps":["trace[130285565] 'agreement among raft nodes before linearized reading'  (duration: 294.902169ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:51.347045Z","caller":"traceutil/trace.go:171","msg":"trace[215572841] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:719; }","duration":"154.773529ms","start":"2026-01-20T20:26:51.192248Z","end":"2026-01-20T20:26:51.347022Z","steps":["trace[215572841] 'read index received'  (duration: 95.295052ms)","trace[215572841] 'applied index is now lower than readState.Index'  (duration: 59.477726ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:51.347233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.962143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-01-20T20:26:51.347254Z","caller":"traceutil/trace.go:171","msg":"trace[1839474833] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:697; }","duration":"155.047104ms","start":"2026-01-20T20:26:51.192201Z","end":"2026-01-20T20:26:51.347248Z","steps":["trace[1839474833] 'agreement among raft nodes before linearized reading'  (duration: 154.915652ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:26:51.347406Z","caller":"traceutil/trace.go:171","msg":"trace[718007415] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"156.445767ms","start":"2026-01-20T20:26:51.190952Z","end":"2026-01-20T20:26:51.347398Z","steps":["trace[718007415] 'process raft request'  (duration: 96.673914ms)","trace[718007415] 'compare'  (duration: 59.128629ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:26:51.613963Z","caller":"traceutil/trace.go:171","msg":"trace[1282819194] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"136.394346ms","start":"2026-01-20T20:26:51.477542Z","end":"2026-01-20T20:26:51.613936Z","steps":["trace[1282819194] 'process raft request'  (duration: 66.178298ms)","trace[1282819194] 'compare'  (duration: 69.673646ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:52.516024Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730333,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-20T20:26:52.910598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.873632ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744730335 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:695 > 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-01-20T20:26:52.910736Z","caller":"traceutil/trace.go:171","msg":"trace[1691068136] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:724; }","duration":"895.022728ms","start":"2026-01-20T20:26:52.015676Z","end":"2026-01-20T20:26:52.910698Z","steps":["trace[1691068136] 'read index received'  (duration: 759.8609ms)","trace[1691068136] 'applied index is now lower than readState.Index'  (duration: 135.160738ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:52.91086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.177641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:26:52.910897Z","caller":"traceutil/trace.go:171","msg":"trace[1641710514] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:702; }","duration":"895.256523ms","start":"2026-01-20T20:26:52.01563Z","end":"2026-01-20T20:26:52.910887Z","steps":["trace[1641710514] 'agreement among raft nodes before linearized reading'  (duration: 895.142781ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:26:52.910941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:52.015609Z","time spent":"895.321365ms","remote":"127.0.0.1:47562","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-01-20T20:26:52.911798Z","caller":"traceutil/trace.go:171","msg":"trace[544791223] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"1.200120555s","start":"2026-01-20T20:26:51.711662Z","end":"2026-01-20T20:26:52.911782Z","steps":["trace[544791223] 'process raft request'  (duration: 1.063925774s)","trace[544791223] 'compare'  (duration: 134.490773ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:26:52.911879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:26:51.711636Z","time spent":"1.200209078s","remote":"127.0.0.1:47812","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:695 > 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-01-20T20:26:53.356544Z","caller":"traceutil/trace.go:171","msg":"trace[1050483636] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"115.899575ms","start":"2026-01-20T20:26:53.240627Z","end":"2026-01-20T20:26:53.356526Z","steps":["trace[1050483636] 'process raft request'  (duration: 115.524797ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:05.936397Z","caller":"traceutil/trace.go:171","msg":"trace[1588796213] linearizableReadLoop","detail":"{readStateIndex:770; appliedIndex:769; }","duration":"192.39123ms","start":"2026-01-20T20:27:05.743982Z","end":"2026-01-20T20:27:05.936374Z","steps":["trace[1588796213] 'read index received'  (duration: 192.163085ms)","trace[1588796213] 'applied index is now lower than readState.Index'  (duration: 227.005µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:05.936495Z","caller":"traceutil/trace.go:171","msg":"trace[346948328] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"204.906989ms","start":"2026-01-20T20:27:05.731582Z","end":"2026-01-20T20:27:05.936489Z","steps":["trace[346948328] 'process raft request'  (duration: 204.663913ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:05.936718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.715907ms","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-01-20T20:27:05.93674Z","caller":"traceutil/trace.go:171","msg":"trace[1602369358] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:744; }","duration":"192.814179ms","start":"2026-01-20T20:27:05.743918Z","end":"2026-01-20T20:27:05.936732Z","steps":["trace[1602369358] 'agreement among raft nodes before linearized reading'  (duration: 192.677456ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:06.204283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.48806ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744730464 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:739 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T20:27:06.204444Z","caller":"traceutil/trace.go:171","msg":"trace[473109621] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"243.120068ms","start":"2026-01-20T20:27:05.961288Z","end":"2026-01-20T20:27:06.204408Z","steps":["trace[473109621] 'process raft request'  (duration: 70.393014ms)","trace[473109621] 'compare'  (duration: 172.351116ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:06.42462Z","caller":"traceutil/trace.go:171","msg":"trace[1182537300] linearizableReadLoop","detail":"{readStateIndex:772; appliedIndex:770; }","duration":"409.307354ms","start":"2026-01-20T20:27:06.015288Z","end":"2026-01-20T20:27:06.424595Z","steps":["trace[1182537300] 'read index received'  (duration: 16.398293ms)","trace[1182537300] 'applied index is now lower than readState.Index'  (duration: 392.908451ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:06.424766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.446437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:06.424785Z","caller":"traceutil/trace.go:171","msg":"trace[18483121] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:746; }","duration":"409.516839ms","start":"2026-01-20T20:27:06.015262Z","end":"2026-01-20T20:27:06.424779Z","steps":["trace[18483121] 'agreement among raft nodes before linearized reading'  (duration: 409.423367ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:06.424809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:06.015252Z","time spent":"409.55145ms","remote":"127.0.0.1:47562","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-01-20T20:27:06.425919Z","caller":"traceutil/trace.go:171","msg":"trace[1624588791] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"463.601871ms","start":"2026-01-20T20:27:05.962291Z","end":"2026-01-20T20:27:06.425893Z","steps":["trace[1624588791] 'process raft request'  (duration: 461.66973ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:06.426059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:05.962284Z","time spent":"463.694134ms","remote":"127.0.0.1:47812","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:740 > 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-01-20T20:27:06.789626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.038255ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744730468 > lease_revoke:<id:4d269bdd15b89ecf>","response":"size:28"}
{"level":"info","ts":"2026-01-20T20:27:07.369633Z","caller":"traceutil/trace.go:171","msg":"trace[621941143] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"385.754559ms","start":"2026-01-20T20:27:06.983849Z","end":"2026-01-20T20:27:07.369604Z","steps":["trace[621941143] 'process raft request'  (duration: 385.603756ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:07.369791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:06.983835Z","time spent":"385.871631ms","remote":"127.0.0.1:47812","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:742 > 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-01-20T20:27:08.125008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.392136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:08.125112Z","caller":"traceutil/trace.go:171","msg":"trace[257516306] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:747; }","duration":"170.517529ms","start":"2026-01-20T20:27:07.954572Z","end":"2026-01-20T20:27:08.12509Z","steps":["trace[257516306] 'count revisions from in-memory index tree'  (duration: 170.289464ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:08.125192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.441573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:27:08.125221Z","caller":"traceutil/trace.go:171","msg":"trace[614648588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:747; }","duration":"583.501084ms","start":"2026-01-20T20:27:07.54171Z","end":"2026-01-20T20:27:08.125211Z","steps":["trace[614648588] 'range keys from in-memory index tree'  (duration: 583.28769ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:08.125244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:07.541692Z","time spent":"583.544175ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-20T20:27:08.125344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.318771ms","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-01-20T20:27:08.125367Z","caller":"traceutil/trace.go:171","msg":"trace[620180525] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:747; }","duration":"161.401573ms","start":"2026-01-20T20:27:07.963958Z","end":"2026-01-20T20:27:08.125359Z","steps":["trace[620180525] 'range keys from in-memory index tree'  (duration: 161.237508ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:08.125457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.984317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:08.125476Z","caller":"traceutil/trace.go:171","msg":"trace[1728562914] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:747; }","duration":"110.038217ms","start":"2026-01-20T20:27:08.015432Z","end":"2026-01-20T20:27:08.12547Z","steps":["trace[1728562914] 'range keys from in-memory index tree'  (duration: 109.934996ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:08.540929Z","caller":"traceutil/trace.go:171","msg":"trace[512472710] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"412.018066ms","start":"2026-01-20T20:27:08.128883Z","end":"2026-01-20T20:27:08.540901Z","steps":["trace[512472710] 'process raft request'  (duration: 411.865883ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:08.541087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:08.128871Z","time spent":"412.130878ms","remote":"127.0.0.1:47812","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:743 > 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-01-20T20:27:08.586406Z","caller":"traceutil/trace.go:171","msg":"trace[187697754] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:775; }","duration":"377.238038ms","start":"2026-01-20T20:27:08.209138Z","end":"2026-01-20T20:27:08.586377Z","steps":["trace[187697754] 'read index received'  (duration: 332.393043ms)","trace[187697754] 'applied index is now lower than readState.Index'  (duration: 44.843815ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:08.586823Z","caller":"traceutil/trace.go:171","msg":"trace[1716660905] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"456.154935ms","start":"2026-01-20T20:27:08.130656Z","end":"2026-01-20T20:27:08.586811Z","steps":["trace[1716660905] 'process raft request'  (duration: 455.592223ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:08.586941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:08.130649Z","time spent":"456.205306ms","remote":"127.0.0.1:47812","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:744 > 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-01-20T20:27:08.587248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.075195ms","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-01-20T20:27:08.587286Z","caller":"traceutil/trace.go:171","msg":"trace[1957781498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:749; }","duration":"378.188267ms","start":"2026-01-20T20:27:08.209087Z","end":"2026-01-20T20:27:08.587275Z","steps":["trace[1957781498] 'agreement among raft nodes before linearized reading'  (duration: 378.025594ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:08.587314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:08.209064Z","time spent":"378.243588ms","remote":"127.0.0.1:47812","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-01-20T20:27:08.587526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.418883ms","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-01-20T20:27:08.587554Z","caller":"traceutil/trace.go:171","msg":"trace[1213870618] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:749; }","duration":"135.479814ms","start":"2026-01-20T20:27:08.452067Z","end":"2026-01-20T20:27:08.587547Z","steps":["trace[1213870618] 'agreement among raft nodes before linearized reading'  (duration: 135.401373ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:08.992136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.915824ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744730481 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:745 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T20:27:08.993362Z","caller":"traceutil/trace.go:171","msg":"trace[905536537] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"358.898591ms","start":"2026-01-20T20:27:08.634441Z","end":"2026-01-20T20:27:08.99334Z","steps":["trace[905536537] 'process raft request'  (duration: 358.82903ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:08.993891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:08.634418Z","time spent":"359.417262ms","remote":"127.0.0.1:47812","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:746 > 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-01-20T20:27:08.993398Z","caller":"traceutil/trace.go:171","msg":"trace[932314562] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"368.58625ms","start":"2026-01-20T20:27:08.62479Z","end":"2026-01-20T20:27:08.993376Z","steps":["trace[932314562] 'process raft request'  (duration: 112.406839ms)","trace[932314562] 'compare'  (duration: 254.728479ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:08.994139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:08.624767Z","time spent":"369.325155ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:745 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-01-20T20:27:09.752928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.083168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:27:09.752996Z","caller":"traceutil/trace.go:171","msg":"trace[5637231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:751; }","duration":"380.203031ms","start":"2026-01-20T20:27:09.372778Z","end":"2026-01-20T20:27:09.752981Z","steps":["trace[5637231] 'range keys from in-memory index tree'  (duration: 379.940195ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:09.753028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:09.372759Z","time spent":"380.261981ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-01-20T20:27:10.285983Z","caller":"traceutil/trace.go:171","msg":"trace[2072180213] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:778; }","duration":"258.318737ms","start":"2026-01-20T20:27:10.027642Z","end":"2026-01-20T20:27:10.285961Z","steps":["trace[2072180213] 'read index received'  (duration: 258.083502ms)","trace[2072180213] 'applied index is now lower than readState.Index'  (duration: 234.185µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:10.286307Z","caller":"traceutil/trace.go:171","msg":"trace[782363398] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"530.146094ms","start":"2026-01-20T20:27:09.756154Z","end":"2026-01-20T20:27:10.2863Z","steps":["trace[782363398] 'process raft request'  (duration: 529.651644ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:10.286397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:09.756132Z","time spent":"530.195107ms","remote":"127.0.0.1:47812","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:747 > 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-01-20T20:27:10.286628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.508079ms","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-01-20T20:27:10.286721Z","caller":"traceutil/trace.go:171","msg":"trace[1109766632] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:752; }","duration":"223.683702ms","start":"2026-01-20T20:27:10.063017Z","end":"2026-01-20T20:27:10.286701Z","steps":["trace[1109766632] 'agreement among raft nodes before linearized reading'  (duration: 223.474467ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:10.286662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.016473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:10.286835Z","caller":"traceutil/trace.go:171","msg":"trace[1488660187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:752; }","duration":"259.222326ms","start":"2026-01-20T20:27:10.027604Z","end":"2026-01-20T20:27:10.286826Z","steps":["trace[1488660187] 'agreement among raft nodes before linearized reading'  (duration: 259.019712ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:12.932267Z","caller":"traceutil/trace.go:171","msg":"trace[922066571] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"353.863042ms","start":"2026-01-20T20:27:12.578394Z","end":"2026-01-20T20:27:12.932257Z","steps":["trace[922066571] 'process raft request'  (duration: 353.564746ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:12.932425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:12.578378Z","time spent":"353.968364ms","remote":"127.0.0.1:47812","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:753 > 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-01-20T20:27:12.932135Z","caller":"traceutil/trace.go:171","msg":"trace[2042154815] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:787; }","duration":"294.830364ms","start":"2026-01-20T20:27:12.637278Z","end":"2026-01-20T20:27:12.932108Z","steps":["trace[2042154815] 'read index received'  (duration: 294.613549ms)","trace[2042154815] 'applied index is now lower than readState.Index'  (duration: 215.995µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:12.932787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.508588ms","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-01-20T20:27:12.932805Z","caller":"traceutil/trace.go:171","msg":"trace[2120974000] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:760; }","duration":"295.568509ms","start":"2026-01-20T20:27:12.63723Z","end":"2026-01-20T20:27:12.932799Z","steps":["trace[2120974000] 'agreement among raft nodes before linearized reading'  (duration: 295.445427ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:13.418013Z","caller":"traceutil/trace.go:171","msg":"trace[1865875559] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:788; }","duration":"412.056245ms","start":"2026-01-20T20:27:13.005929Z","end":"2026-01-20T20:27:13.417986Z","steps":["trace[1865875559] 'read index received'  (duration: 317.073912ms)","trace[1865875559] 'applied index is now lower than readState.Index'  (duration: 94.981083ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:13.418322Z","caller":"traceutil/trace.go:171","msg":"trace[165885450] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"481.635272ms","start":"2026-01-20T20:27:12.936671Z","end":"2026-01-20T20:27:13.418306Z","steps":["trace[165885450] 'process raft request'  (duration: 386.384193ms)","trace[165885450] 'compare'  (duration: 94.785018ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:13.41846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:12.936654Z","time spent":"481.711494ms","remote":"127.0.0.1:47812","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:754 > 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-01-20T20:27:13.41861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.410353ms","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-01-20T20:27:13.418751Z","caller":"traceutil/trace.go:171","msg":"trace[720055664] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:761; }","duration":"412.643549ms","start":"2026-01-20T20:27:13.006077Z","end":"2026-01-20T20:27:13.41872Z","steps":["trace[720055664] 'agreement among raft nodes before linearized reading'  (duration: 412.25764ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:13.41881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:13.006048Z","time spent":"412.75044ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-20T20:27:13.418906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.972425ms","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-01-20T20:27:13.418951Z","caller":"traceutil/trace.go:171","msg":"trace[408979110] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:761; }","duration":"413.058177ms","start":"2026-01-20T20:27:13.005877Z","end":"2026-01-20T20:27:13.418936Z","steps":["trace[408979110] 'agreement among raft nodes before linearized reading'  (duration: 412.909364ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:13.418982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:13.005854Z","time spent":"413.122148ms","remote":"127.0.0.1:47812","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-01-20T20:27:13.669454Z","caller":"traceutil/trace.go:171","msg":"trace[897696843] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"241.443066ms","start":"2026-01-20T20:27:13.427975Z","end":"2026-01-20T20:27:13.669418Z","steps":["trace[897696843] 'process raft request'  (duration: 144.005509ms)","trace[897696843] 'compare'  (duration: 97.299984ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:30.011584Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730730,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-20T20:27:30.018978Z","caller":"traceutil/trace.go:171","msg":"trace[816400558] linearizableReadLoop","detail":"{readStateIndex:890; appliedIndex:889; }","duration":"508.296274ms","start":"2026-01-20T20:27:29.510663Z","end":"2026-01-20T20:27:30.018959Z","steps":["trace[816400558] 'read index received'  (duration: 508.049599ms)","trace[816400558] 'applied index is now lower than readState.Index'  (duration: 245.895µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:30.019255Z","caller":"traceutil/trace.go:171","msg":"trace[1668511816] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"861.085356ms","start":"2026-01-20T20:27:29.158162Z","end":"2026-01-20T20:27:30.019247Z","steps":["trace[1668511816] 'process raft request'  (duration: 860.620896ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:30.019335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:29.158151Z","time spent":"861.124737ms","remote":"127.0.0.1:47812","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:852 > 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-01-20T20:27:30.019705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.039971ms","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-01-20T20:27:30.019728Z","caller":"traceutil/trace.go:171","msg":"trace[853038366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:857; }","duration":"509.094753ms","start":"2026-01-20T20:27:29.510626Z","end":"2026-01-20T20:27:30.01972Z","steps":["trace[853038366] 'agreement among raft nodes before linearized reading'  (duration: 508.99778ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:30.019747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:29.510604Z","time spent":"509.139264ms","remote":"127.0.0.1:47812","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-01-20T20:27:30.01987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.432587ms","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-01-20T20:27:30.019887Z","caller":"traceutil/trace.go:171","msg":"trace[697487456] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:857; }","duration":"335.478228ms","start":"2026-01-20T20:27:29.684403Z","end":"2026-01-20T20:27:30.019882Z","steps":["trace[697487456] 'agreement among raft nodes before linearized reading'  (duration: 335.422437ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:30.019903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:29.684386Z","time spent":"335.513658ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-20T20:27:30.020053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.980513ms","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-01-20T20:27:30.020073Z","caller":"traceutil/trace.go:171","msg":"trace[275446527] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:857; }","duration":"260.003294ms","start":"2026-01-20T20:27:29.760065Z","end":"2026-01-20T20:27:30.020068Z","steps":["trace[275446527] 'agreement among raft nodes before linearized reading'  (duration: 259.945583ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:30.54889Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730734,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-20T20:27:30.6768Z","caller":"traceutil/trace.go:171","msg":"trace[1225933273] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"629.013452ms","start":"2026-01-20T20:27:30.04776Z","end":"2026-01-20T20:27:30.676774Z","steps":["trace[1225933273] 'process raft request'  (duration: 573.762864ms)","trace[1225933273] 'compare'  (duration: 54.570343ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:30.676944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:30.047741Z","time spent":"629.127684ms","remote":"127.0.0.1:47812","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:853 > 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-01-20T20:27:31.068528Z","caller":"traceutil/trace.go:171","msg":"trace[2127930372] linearizableReadLoop","detail":"{readStateIndex:893; appliedIndex:890; }","duration":"1.019706908s","start":"2026-01-20T20:27:30.048802Z","end":"2026-01-20T20:27:31.068509Z","steps":["trace[2127930372] 'read index received'  (duration: 572.730652ms)","trace[2127930372] 'applied index is now lower than readState.Index'  (duration: 446.975446ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:31.068731Z","caller":"traceutil/trace.go:171","msg":"trace[1330072402] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"1.020812361s","start":"2026-01-20T20:27:30.047911Z","end":"2026-01-20T20:27:31.068724Z","steps":["trace[1330072402] 'process raft request'  (duration: 955.259941ms)","trace[1330072402] 'compare'  (duration: 65.198993ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:31.0688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:30.047905Z","time spent":"1.020843042s","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:855 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-20T20:27:31.068937Z","caller":"traceutil/trace.go:171","msg":"trace[365543340] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"1.006031044s","start":"2026-01-20T20:27:30.0629Z","end":"2026-01-20T20:27:31.068931Z","steps":["trace[365543340] 'process raft request'  (duration: 1.005577134s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:31.068963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:30.062888Z","time spent":"1.006060184s","remote":"127.0.0.1:47812","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:854 > 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-01-20T20:27:31.069035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020234909s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:31.069051Z","caller":"traceutil/trace.go:171","msg":"trace[15664959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:860; }","duration":"1.02028128s","start":"2026-01-20T20:27:30.048765Z","end":"2026-01-20T20:27:31.069046Z","steps":["trace[15664959] 'agreement among raft nodes before linearized reading'  (duration: 1.020253219s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:31.069065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:30.048737Z","time spent":"1.02032446s","remote":"127.0.0.1:47562","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-01-20T20:27:31.069162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.516293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-20T20:27:31.069176Z","caller":"traceutil/trace.go:171","msg":"trace[1272859592] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:860; }","duration":"973.531164ms","start":"2026-01-20T20:27:30.09564Z","end":"2026-01-20T20:27:31.069171Z","steps":["trace[1272859592] 'agreement among raft nodes before linearized reading'  (duration: 973.492353ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:31.06919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:30.0956Z","time spent":"973.587075ms","remote":"127.0.0.1:47648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":15,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-01-20T20:27:31.069339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.952362ms","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-01-20T20:27:31.069352Z","caller":"traceutil/trace.go:171","msg":"trace[783512065] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:860; }","duration":"201.017753ms","start":"2026-01-20T20:27:30.868331Z","end":"2026-01-20T20:27:31.069348Z","steps":["trace[783512065] 'agreement among raft nodes before linearized reading'  (duration: 200.991833ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:31.069467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.127469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-01-20T20:27:31.069479Z","caller":"traceutil/trace.go:171","msg":"trace[806391705] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:860; }","duration":"235.168109ms","start":"2026-01-20T20:27:30.834307Z","end":"2026-01-20T20:27:31.069475Z","steps":["trace[806391705] 'agreement among raft nodes before linearized reading'  (duration: 235.107558ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:31.069571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.732235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:27:31.069582Z","caller":"traceutil/trace.go:171","msg":"trace[1429813659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:860; }","duration":"509.784837ms","start":"2026-01-20T20:27:30.559794Z","end":"2026-01-20T20:27:31.069578Z","steps":["trace[1429813659] 'agreement among raft nodes before linearized reading'  (duration: 509.747286ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:31.069593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:30.559776Z","time spent":"509.814098ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-20T20:27:31.069657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.636063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:31.06967Z","caller":"traceutil/trace.go:171","msg":"trace[37847005] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:860; }","duration":"766.716595ms","start":"2026-01-20T20:27:30.302948Z","end":"2026-01-20T20:27:31.069665Z","steps":["trace[37847005] 'agreement among raft nodes before linearized reading'  (duration: 766.692385ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:31.069684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:30.302925Z","time spent":"766.756155ms","remote":"127.0.0.1:47850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "}
{"level":"info","ts":"2026-01-20T20:27:34.784951Z","caller":"traceutil/trace.go:171","msg":"trace[1815007450] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"126.154575ms","start":"2026-01-20T20:27:34.658772Z","end":"2026-01-20T20:27:34.784927Z","steps":["trace[1815007450] 'process raft request'  (duration: 125.49884ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:35.043938Z","caller":"traceutil/trace.go:171","msg":"trace[1205729581] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"252.342079ms","start":"2026-01-20T20:27:34.791563Z","end":"2026-01-20T20:27:35.043905Z","steps":["trace[1205729581] 'process raft request'  (duration: 186.504413ms)","trace[1205729581] 'compare'  (duration: 65.726683ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:37.31183Z","caller":"traceutil/trace.go:171","msg":"trace[521244099] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"121.598886ms","start":"2026-01-20T20:27:37.190211Z","end":"2026-01-20T20:27:37.31181Z","steps":["trace[521244099] 'process raft request'  (duration: 121.071835ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:41.187201Z","caller":"traceutil/trace.go:171","msg":"trace[1096899924] linearizableReadLoop","detail":"{readStateIndex:921; appliedIndex:920; }","duration":"230.770544ms","start":"2026-01-20T20:27:40.956404Z","end":"2026-01-20T20:27:41.187174Z","steps":["trace[1096899924] 'read index received'  (duration: 230.631261ms)","trace[1096899924] 'applied index is now lower than readState.Index'  (duration: 137.713µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:41.187207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:40.836461Z","time spent":"350.737016ms","remote":"127.0.0.1:47594","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-01-20T20:27:41.187414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.951279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-20T20:27:41.187437Z","caller":"traceutil/trace.go:171","msg":"trace[271003145] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:885; }","duration":"231.07403ms","start":"2026-01-20T20:27:40.956357Z","end":"2026-01-20T20:27:41.187431Z","steps":["trace[271003145] 'agreement among raft nodes before linearized reading'  (duration: 230.960968ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:41.187645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.422322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:41.187659Z","caller":"traceutil/trace.go:171","msg":"trace[976444624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:885; }","duration":"161.470733ms","start":"2026-01-20T20:27:41.026183Z","end":"2026-01-20T20:27:41.187653Z","steps":["trace[976444624] 'agreement among raft nodes before linearized reading'  (duration: 161.444493ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:41.187861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.940452ms","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-01-20T20:27:41.187876Z","caller":"traceutil/trace.go:171","msg":"trace[573205248] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:885; }","duration":"120.997073ms","start":"2026-01-20T20:27:41.066873Z","end":"2026-01-20T20:27:41.18787Z","steps":["trace[573205248] 'agreement among raft nodes before linearized reading'  (duration: 120.960362ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:41.298621Z","caller":"traceutil/trace.go:171","msg":"trace[140857864] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"101.086995ms","start":"2026-01-20T20:27:41.197509Z","end":"2026-01-20T20:27:41.298596Z","steps":["trace[140857864] 'process raft request'  (duration: 101.044294ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:41.298988Z","caller":"traceutil/trace.go:171","msg":"trace[137502197] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"107.292858ms","start":"2026-01-20T20:27:41.191686Z","end":"2026-01-20T20:27:41.298979Z","steps":["trace[137502197] 'process raft request'  (duration: 72.126401ms)","trace[137502197] 'compare'  (duration: 34.507313ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:41.299097Z","caller":"traceutil/trace.go:171","msg":"trace[607894264] linearizableReadLoop","detail":"{readStateIndex:922; appliedIndex:921; }","duration":"107.330639ms","start":"2026-01-20T20:27:41.191759Z","end":"2026-01-20T20:27:41.299089Z","steps":["trace[607894264] 'read index received'  (duration: 72.0776ms)","trace[607894264] 'applied index is now lower than readState.Index'  (duration: 35.252069ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:41.299171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.39144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:41.299193Z","caller":"traceutil/trace.go:171","msg":"trace[1544943919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:889; }","duration":"107.449901ms","start":"2026-01-20T20:27:41.191737Z","end":"2026-01-20T20:27:41.299187Z","steps":["trace[1544943919] 'agreement among raft nodes before linearized reading'  (duration: 107.3772ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:41.299321Z","caller":"traceutil/trace.go:171","msg":"trace[1353807315] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"107.439031ms","start":"2026-01-20T20:27:41.191876Z","end":"2026-01-20T20:27:41.299315Z","steps":["trace[1353807315] 'process raft request'  (duration: 106.595803ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:41.299476Z","caller":"traceutil/trace.go:171","msg":"trace[827489288] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"104.316554ms","start":"2026-01-20T20:27:41.195153Z","end":"2026-01-20T20:27:41.299469Z","steps":["trace[827489288] 'process raft request'  (duration: 103.376454ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:41.522859Z","caller":"traceutil/trace.go:171","msg":"trace[916221617] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"194.874303ms","start":"2026-01-20T20:27:41.327959Z","end":"2026-01-20T20:27:41.522833Z","steps":["trace[916221617] 'process raft request'  (duration: 117.12995ms)","trace[916221617] 'compare'  (duration: 77.658971ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:43.515696Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730828,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-20T20:27:44.016087Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730828,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-20T20:27:44.166867Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.427003182s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-20T20:27:44.167232Z","caller":"traceutil/trace.go:171","msg":"trace[742526577] linearizableReadLoop","detail":"{readStateIndex:928; appliedIndex:927; }","duration":"1.152552967s","start":"2026-01-20T20:27:43.014636Z","end":"2026-01-20T20:27:44.167189Z","steps":["trace[742526577] 'read index received'  (duration: 1.152366713s)","trace[742526577] 'applied index is now lower than readState.Index'  (duration: 185.434µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:44.167649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.200572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-01-20T20:27:44.167687Z","caller":"traceutil/trace.go:171","msg":"trace[661786118] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:892; }","duration":"864.296774ms","start":"2026-01-20T20:27:43.303375Z","end":"2026-01-20T20:27:44.167671Z","steps":["trace[661786118] 'agreement among raft nodes before linearized reading'  (duration: 864.11122ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:44.167718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:43.303343Z","time spent":"864.368806ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-20T20:27:44.167708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.702125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:27:44.167745Z","caller":"traceutil/trace.go:171","msg":"trace[398326361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:892; }","duration":"641.803248ms","start":"2026-01-20T20:27:43.525935Z","end":"2026-01-20T20:27:44.167739Z","steps":["trace[398326361] 'agreement among raft nodes before linearized reading'  (duration: 641.649404ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:44.167766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:43.525919Z","time spent":"641.842429ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-01-20T20:27:44.167856Z","caller":"traceutil/trace.go:171","msg":"trace[684533170] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"1.428083065s","start":"2026-01-20T20:27:42.739765Z","end":"2026-01-20T20:27:44.167848Z","steps":["trace[684533170] 'process raft request'  (duration: 1.427269168s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:44.167921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:42.739743Z","time spent":"1.428134996s","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:864 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-01-20T20:27:44.167982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.153347374s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:44.167994Z","caller":"traceutil/trace.go:171","msg":"trace[1514381541] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:892; }","duration":"1.153400585s","start":"2026-01-20T20:27:43.014589Z","end":"2026-01-20T20:27:44.16799Z","steps":["trace[1514381541] 'agreement among raft nodes before linearized reading'  (duration: 1.153376834s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:44.168026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.61337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"warn","ts":"2026-01-20T20:27:44.16803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:43.014573Z","time spent":"1.153453806s","remote":"127.0.0.1:47564","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-01-20T20:27:44.168043Z","caller":"traceutil/trace.go:171","msg":"trace[1332602163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:892; }","duration":"863.638061ms","start":"2026-01-20T20:27:43.304399Z","end":"2026-01-20T20:27:44.168037Z","steps":["trace[1332602163] 'agreement among raft nodes before linearized reading'  (duration: 863.59085ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:44.168057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:43.304394Z","time spent":"863.659071ms","remote":"127.0.0.1:47812","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-01-20T20:27:44.168155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.659982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-01-20T20:27:44.168169Z","caller":"traceutil/trace.go:171","msg":"trace[1382000076] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:892; }","duration":"864.680413ms","start":"2026-01-20T20:27:43.303484Z","end":"2026-01-20T20:27:44.168164Z","steps":["trace[1382000076] 'agreement among raft nodes before linearized reading'  (duration: 864.640762ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:44.168181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:43.303475Z","time spent":"864.702683ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-01-20T20:27:44.384046Z","caller":"traceutil/trace.go:171","msg":"trace[336401317] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"207.781581ms","start":"2026-01-20T20:27:44.176229Z","end":"2026-01-20T20:27:44.384011Z","steps":["trace[336401317] 'process raft request'  (duration: 148.837212ms)","trace[336401317] 'compare'  (duration: 58.261814ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:44.384227Z","caller":"traceutil/trace.go:171","msg":"trace[984868108] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:928; }","duration":"204.681644ms","start":"2026-01-20T20:27:44.179522Z","end":"2026-01-20T20:27:44.384204Z","steps":["trace[984868108] 'read index received'  (duration: 145.770986ms)","trace[984868108] 'applied index is now lower than readState.Index'  (duration: 58.910048ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:44.384364Z","caller":"traceutil/trace.go:171","msg":"trace[41387751] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"207.086926ms","start":"2026-01-20T20:27:44.177272Z","end":"2026-01-20T20:27:44.384358Z","steps":["trace[41387751] 'process raft request'  (duration: 206.683288ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:44.384467Z","caller":"traceutil/trace.go:171","msg":"trace[746866608] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"207.012803ms","start":"2026-01-20T20:27:44.177451Z","end":"2026-01-20T20:27:44.384464Z","steps":["trace[746866608] 'process raft request'  (duration: 206.671896ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:44.384508Z","caller":"traceutil/trace.go:171","msg":"trace[1003665702] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"204.52546ms","start":"2026-01-20T20:27:44.179978Z","end":"2026-01-20T20:27:44.384504Z","steps":["trace[1003665702] 'process raft request'  (duration: 204.199493ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:44.384581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.036341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:44.384608Z","caller":"traceutil/trace.go:171","msg":"trace[298402120] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:896; }","duration":"205.100993ms","start":"2026-01-20T20:27:44.179502Z","end":"2026-01-20T20:27:44.384603Z","steps":["trace[298402120] 'agreement among raft nodes before linearized reading'  (duration: 205.038481ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:44.384766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.640518ms","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-01-20T20:27:44.384778Z","caller":"traceutil/trace.go:171","msg":"trace[1206170646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:896; }","duration":"108.689589ms","start":"2026-01-20T20:27:44.276084Z","end":"2026-01-20T20:27:44.384774Z","steps":["trace[1206170646] 'agreement among raft nodes before linearized reading'  (duration: 108.610937ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:27:45.039473Z","caller":"traceutil/trace.go:171","msg":"trace[1717258793] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"132.96715ms","start":"2026-01-20T20:27:44.906483Z","end":"2026-01-20T20:27:45.039451Z","steps":["trace[1717258793] 'process raft request'  (duration: 127.152905ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:46.00408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.783371ms","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-01-20T20:27:46.004169Z","caller":"traceutil/trace.go:171","msg":"trace[1076241381] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:898; }","duration":"280.933455ms","start":"2026-01-20T20:27:45.723212Z","end":"2026-01-20T20:27:46.004146Z","steps":["trace[1076241381] 'count revisions from in-memory index tree'  (duration: 280.7061ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.50622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.103228127s","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744730845 > lease_revoke:<id:4d269bdd15b8a074>","response":"size:28"}
{"level":"info","ts":"2026-01-20T20:27:47.506387Z","caller":"traceutil/trace.go:171","msg":"trace[1002084517] linearizableReadLoop","detail":"{readStateIndex:935; appliedIndex:934; }","duration":"1.113708522s","start":"2026-01-20T20:27:46.392654Z","end":"2026-01-20T20:27:47.506362Z","steps":["trace[1002084517] 'read index received'  (duration: 10.255321ms)","trace[1002084517] 'applied index is now lower than readState.Index'  (duration: 1.103451191s)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:47.507224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114549899s","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-01-20T20:27:47.507269Z","caller":"traceutil/trace.go:171","msg":"trace[1219111865] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:898; }","duration":"1.114640592s","start":"2026-01-20T20:27:46.392617Z","end":"2026-01-20T20:27:47.507257Z","steps":["trace[1219111865] 'agreement among raft nodes before linearized reading'  (duration: 1.114400267s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.507309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:46.3926Z","time spent":"1.114699363s","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-20T20:27:47.507911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.11500602s","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-01-20T20:27:47.508128Z","caller":"traceutil/trace.go:171","msg":"trace[108797822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:898; }","duration":"1.115275026s","start":"2026-01-20T20:27:46.392828Z","end":"2026-01-20T20:27:47.508103Z","steps":["trace[108797822] 'agreement among raft nodes before linearized reading'  (duration: 1.114877167s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.508308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:46.392818Z","time spent":"1.115474331s","remote":"127.0.0.1:47812","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-01-20T20:27:47.508445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.325902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:47.508491Z","caller":"traceutil/trace.go:171","msg":"trace[924236729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:898; }","duration":"491.405793ms","start":"2026-01-20T20:27:47.017075Z","end":"2026-01-20T20:27:47.50848Z","steps":["trace[924236729] 'agreement among raft nodes before linearized reading'  (duration: 491.340352ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.508525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:47.017057Z","time spent":"491.462614ms","remote":"127.0.0.1:47562","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-01-20T20:27:47.508874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.244289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:47.508908Z","caller":"traceutil/trace.go:171","msg":"trace[1937508659] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:898; }","duration":"444.298319ms","start":"2026-01-20T20:27:47.064602Z","end":"2026-01-20T20:27:47.5089Z","steps":["trace[1937508659] 'agreement among raft nodes before linearized reading'  (duration: 444.245008ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.508962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:47.064594Z","time spent":"444.35993ms","remote":"127.0.0.1:47936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "}
{"level":"warn","ts":"2026-01-20T20:27:47.509341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054300932s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:27:47.50938Z","caller":"traceutil/trace.go:171","msg":"trace[1855316180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:898; }","duration":"1.054371594s","start":"2026-01-20T20:27:46.454999Z","end":"2026-01-20T20:27:47.509371Z","steps":["trace[1855316180] 'agreement among raft nodes before linearized reading'  (duration: 1.054275692s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.509407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:46.454964Z","time spent":"1.054438006s","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-20T20:27:47.509498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.792946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:47.509528Z","caller":"traceutil/trace.go:171","msg":"trace[702525647] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:898; }","duration":"633.868727ms","start":"2026-01-20T20:27:46.875652Z","end":"2026-01-20T20:27:47.509521Z","steps":["trace[702525647] 'agreement among raft nodes before linearized reading'  (duration: 633.827137ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.509552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:46.875631Z","time spent":"633.915568ms","remote":"127.0.0.1:47836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"warn","ts":"2026-01-20T20:27:47.509826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114321955s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:27:47.51001Z","caller":"traceutil/trace.go:171","msg":"trace[810869019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:898; }","duration":"1.114495579s","start":"2026-01-20T20:27:46.39547Z","end":"2026-01-20T20:27:47.509966Z","steps":["trace[810869019] 'agreement among raft nodes before linearized reading'  (duration: 1.114267594s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.50988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116781118s","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-01-20T20:27:47.51324Z","caller":"traceutil/trace.go:171","msg":"trace[1819729616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:898; }","duration":"1.12013644s","start":"2026-01-20T20:27:46.393082Z","end":"2026-01-20T20:27:47.513218Z","steps":["trace[1819729616] 'agreement among raft nodes before linearized reading'  (duration: 1.116729657s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.513461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:46.393077Z","time spent":"1.120372065s","remote":"127.0.0.1:47812","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-01-20T20:27:47.510194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:46.395438Z","time spent":"1.114741204s","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-01-20T20:27:47.881721Z","caller":"traceutil/trace.go:171","msg":"trace[2019316419] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"361.577609ms","start":"2026-01-20T20:27:47.520117Z","end":"2026-01-20T20:27:47.881695Z","steps":["trace[2019316419] 'process raft request'  (duration: 361.421036ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:47.881887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:47.520107Z","time spent":"361.684522ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:894 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-01-20T20:27:48.574983Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730848,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-20T20:27:49.076114Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730848,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-20T20:27:49.162202Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.280735454s","expected-duration":"1s"}
{"level":"info","ts":"2026-01-20T20:27:49.202912Z","caller":"traceutil/trace.go:171","msg":"trace[1506705162] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"1.682650702s","start":"2026-01-20T20:27:47.520235Z","end":"2026-01-20T20:27:49.202886Z","steps":["trace[1506705162] 'process raft request'  (duration: 1.642657581s)","trace[1506705162] 'compare'  (duration: 39.820907ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:49.203085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:47.52023Z","time spent":"1.682752165s","remote":"127.0.0.1:47812","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:896 > 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-01-20T20:27:49.203254Z","caller":"traceutil/trace.go:171","msg":"trace[1242605246] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"1.682873817s","start":"2026-01-20T20:27:47.520374Z","end":"2026-01-20T20:27:49.203248Z","steps":["trace[1242605246] 'process raft request'  (duration: 1.682476208s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:49.203297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:47.520371Z","time spent":"1.682904738s","remote":"127.0.0.1:47812","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:895 > 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-01-20T20:27:49.204751Z","caller":"traceutil/trace.go:171","msg":"trace[1727046891] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"1.68440771s","start":"2026-01-20T20:27:47.520336Z","end":"2026-01-20T20:27:49.204743Z","steps":["trace[1727046891] 'process raft request'  (duration: 1.682885908s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:49.204805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:47.52033Z","time spent":"1.684449131s","remote":"127.0.0.1:47812","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:893 > 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-01-20T20:27:49.204969Z","caller":"traceutil/trace.go:171","msg":"trace[1879407375] linearizableReadLoop","detail":"{readStateIndex:940; appliedIndex:936; }","duration":"1.130060132s","start":"2026-01-20T20:27:48.0749Z","end":"2026-01-20T20:27:49.20496Z","steps":["trace[1879407375] 'read index received'  (duration: 1.088000377s)","trace[1879407375] 'applied index is now lower than readState.Index'  (duration: 42.058915ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:49.205059Z","caller":"traceutil/trace.go:171","msg":"trace[1984964698] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"1.684639794s","start":"2026-01-20T20:27:47.520414Z","end":"2026-01-20T20:27:49.205053Z","steps":["trace[1984964698] 'process raft request'  (duration: 1.684300807s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:49.2051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:47.520409Z","time spent":"1.684667945s","remote":"127.0.0.1:47812","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:897 > 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-01-20T20:27:49.205214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130322289s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-20T20:27:49.205243Z","caller":"traceutil/trace.go:171","msg":"trace[47771965] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:903; }","duration":"1.130386519s","start":"2026-01-20T20:27:48.074848Z","end":"2026-01-20T20:27:49.205235Z","steps":["trace[47771965] 'agreement among raft nodes before linearized reading'  (duration: 1.130300667s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:49.205264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:48.074821Z","time spent":"1.130436851s","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":88,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-01-20T20:27:49.205389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.064681846s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-20T20:27:49.205414Z","caller":"traceutil/trace.go:171","msg":"trace[526598542] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:903; }","duration":"1.064798799s","start":"2026-01-20T20:27:48.140608Z","end":"2026-01-20T20:27:49.205407Z","steps":["trace[526598542] 'agreement among raft nodes before linearized reading'  (duration: 1.064757778s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:49.205432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:48.140589Z","time spent":"1.064838759s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-01-20T20:27:49.205561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.316088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:49.205584Z","caller":"traceutil/trace.go:171","msg":"trace[437022421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:903; }","duration":"186.378729ms","start":"2026-01-20T20:27:49.0192Z","end":"2026-01-20T20:27:49.205579Z","steps":["trace[437022421] 'agreement among raft nodes before linearized reading'  (duration: 186.346619ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:49.205683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.674081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-20T20:27:49.205705Z","caller":"traceutil/trace.go:171","msg":"trace[1164851967] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:903; }","duration":"612.735172ms","start":"2026-01-20T20:27:48.592965Z","end":"2026-01-20T20:27:49.2057Z","steps":["trace[1164851967] 'agreement among raft nodes before linearized reading'  (duration: 612.701021ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:49.205722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:48.592946Z","time spent":"612.771532ms","remote":"127.0.0.1:48038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "}
{"level":"warn","ts":"2026-01-20T20:27:50.409515Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730857,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-20T20:27:50.661267Z","caller":"traceutil/trace.go:171","msg":"trace[817482459] linearizableReadLoop","detail":"{readStateIndex:941; appliedIndex:940; }","duration":"752.749495ms","start":"2026-01-20T20:27:49.908489Z","end":"2026-01-20T20:27:50.661238Z","steps":["trace[817482459] 'read index received'  (duration: 752.52434ms)","trace[817482459] 'applied index is now lower than readState.Index'  (duration: 224.245µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:50.661598Z","caller":"traceutil/trace.go:171","msg":"trace[1991387507] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"773.036701ms","start":"2026-01-20T20:27:49.888549Z","end":"2026-01-20T20:27:50.661586Z","steps":["trace[1991387507] 'process raft request'  (duration: 772.52917ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:50.661744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:49.888526Z","time spent":"773.109273ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:899 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-01-20T20:27:50.66196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.46151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:50.662002Z","caller":"traceutil/trace.go:171","msg":"trace[1685415725] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:904; }","duration":"753.503721ms","start":"2026-01-20T20:27:49.908485Z","end":"2026-01-20T20:27:50.661989Z","steps":["trace[1685415725] 'agreement among raft nodes before linearized reading'  (duration: 753.430859ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:50.662041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:49.908479Z","time spent":"753.548452ms","remote":"127.0.0.1:51806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "}
{"level":"warn","ts":"2026-01-20T20:27:50.662294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.847528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-01-20T20:27:50.662326Z","caller":"traceutil/trace.go:171","msg":"trace[1407472179] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:904; }","duration":"311.91571ms","start":"2026-01-20T20:27:50.350401Z","end":"2026-01-20T20:27:50.662317Z","steps":["trace[1407472179] 'agreement among raft nodes before linearized reading'  (duration: 311.858968ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:50.662355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:50.350387Z","time spent":"311.96033ms","remote":"127.0.0.1:51800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":2,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "}
{"level":"warn","ts":"2026-01-20T20:27:51.457856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.154185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-01-20T20:27:51.459586Z","caller":"traceutil/trace.go:171","msg":"trace[551220935] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:904; }","duration":"623.920394ms","start":"2026-01-20T20:27:50.835628Z","end":"2026-01-20T20:27:51.459549Z","steps":["trace[551220935] 'range keys from in-memory index tree'  (duration: 621.993062ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:51.459731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:50.835601Z","time spent":"624.084387ms","remote":"127.0.0.1:47594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.62\" "}
{"level":"warn","ts":"2026-01-20T20:27:51.460356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.134277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:51.460406Z","caller":"traceutil/trace.go:171","msg":"trace[618258719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:904; }","duration":"445.223809ms","start":"2026-01-20T20:27:51.015168Z","end":"2026-01-20T20:27:51.460392Z","steps":["trace[618258719] 'range keys from in-memory index tree'  (duration: 444.948153ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:51.460587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:51.015139Z","time spent":"445.433974ms","remote":"127.0.0.1:47562","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-01-20T20:27:51.461513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.000076ms","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-01-20T20:27:51.461574Z","caller":"traceutil/trace.go:171","msg":"trace[1617822748] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:904; }","duration":"248.104278ms","start":"2026-01-20T20:27:51.213451Z","end":"2026-01-20T20:27:51.461556Z","steps":["trace[1617822748] 'range keys from in-memory index tree'  (duration: 247.878564ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:51.461834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.215151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:27:51.461862Z","caller":"traceutil/trace.go:171","msg":"trace[2060961067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:904; }","duration":"248.260492ms","start":"2026-01-20T20:27:51.213593Z","end":"2026-01-20T20:27:51.461853Z","steps":["trace[2060961067] 'range keys from in-memory index tree'  (duration: 248.142639ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:51.462027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.379474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:27:51.462055Z","caller":"traceutil/trace.go:171","msg":"trace[494478092] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:904; }","duration":"248.427095ms","start":"2026-01-20T20:27:51.213618Z","end":"2026-01-20T20:27:51.462045Z","steps":["trace[494478092] 'range keys from in-memory index tree'  (duration: 248.279271ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:51.462234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.658946ms","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-01-20T20:27:51.46226Z","caller":"traceutil/trace.go:171","msg":"trace[417556637] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:904; }","duration":"245.684776ms","start":"2026-01-20T20:27:51.216567Z","end":"2026-01-20T20:27:51.462252Z","steps":["trace[417556637] 'range keys from in-memory index tree'  (duration: 245.598534ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:52.518455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.871002ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744730869 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:901 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T20:27:52.518699Z","caller":"traceutil/trace.go:171","msg":"trace[667367358] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"1.045759469s","start":"2026-01-20T20:27:51.472925Z","end":"2026-01-20T20:27:52.518685Z","steps":["trace[667367358] 'process raft request'  (duration: 1.045733689s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:52.51874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:51.4729Z","time spent":"1.045821961s","remote":"127.0.0.1:47812","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:900 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-01-20T20:27:52.519011Z","caller":"traceutil/trace.go:171","msg":"trace[602876238] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"1.049867068s","start":"2026-01-20T20:27:51.469137Z","end":"2026-01-20T20:27:52.519004Z","steps":["trace[602876238] 'process raft request'  (duration: 1.049429929s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:52.519042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:51.469131Z","time spent":"1.049893609s","remote":"127.0.0.1:47812","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:903 > 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-01-20T20:27:52.519027Z","caller":"traceutil/trace.go:171","msg":"trace[219449801] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"1.0499311s","start":"2026-01-20T20:27:51.469049Z","end":"2026-01-20T20:27:52.51898Z","steps":["trace[219449801] 'process raft request'  (duration: 419.455006ms)","trace[219449801] 'compare'  (duration: 629.615945ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:52.519102Z","caller":"traceutil/trace.go:171","msg":"trace[590261268] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"1.048640011s","start":"2026-01-20T20:27:51.470458Z","end":"2026-01-20T20:27:52.519098Z","steps":["trace[590261268] 'process raft request'  (duration: 1.048183202s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:52.51913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:51.470451Z","time spent":"1.048663202s","remote":"127.0.0.1:47812","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:902 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-01-20T20:27:52.519185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:51.469035Z","time spent":"1.050064072s","remote":"127.0.0.1:47812","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:901 > 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-01-20T20:27:52.539639Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730873,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-01-20T20:27:52.997598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.433193ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744730874 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.62\" mod_revision:887 > success:<request_put:<key:\"/registry/masterleases/162.253.55.62\" value_size:66 lease:5559302163889955059 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.62\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T20:27:52.997669Z","caller":"traceutil/trace.go:171","msg":"trace[1173580921] linearizableReadLoop","detail":"{readStateIndex:947; appliedIndex:946; }","duration":"958.194815ms","start":"2026-01-20T20:27:52.039464Z","end":"2026-01-20T20:27:52.997659Z","steps":["trace[1173580921] 'read index received'  (duration: 749.591528ms)","trace[1173580921] 'applied index is now lower than readState.Index'  (duration: 208.602167ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:52.997696Z","caller":"traceutil/trace.go:171","msg":"trace[1059192284] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"1.477896905s","start":"2026-01-20T20:27:51.519774Z","end":"2026-01-20T20:27:52.997671Z","steps":["trace[1059192284] 'process raft request'  (duration: 1.269319159s)","trace[1059192284] 'compare'  (duration: 208.26914ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:27:52.997753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.288537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:27:52.997768Z","caller":"traceutil/trace.go:171","msg":"trace[2111059024] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:909; }","duration":"958.338988ms","start":"2026-01-20T20:27:52.039424Z","end":"2026-01-20T20:27:52.997763Z","steps":["trace[2111059024] 'agreement among raft nodes before linearized reading'  (duration: 958.290617ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:52.997785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:52.039408Z","time spent":"958.372759ms","remote":"127.0.0.1:47562","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-01-20T20:27:52.997811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:51.519754Z","time spent":"1.477989638s","remote":"127.0.0.1:47594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.62\" mod_revision:887 > success:<request_put:<key:\"/registry/masterleases/162.253.55.62\" value_size:66 lease:5559302163889955059 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.62\" > >"}
{"level":"warn","ts":"2026-01-20T20:27:52.997939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.129819ms","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-01-20T20:27:52.997953Z","caller":"traceutil/trace.go:171","msg":"trace[601835227] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:909; }","duration":"308.1678ms","start":"2026-01-20T20:27:52.689781Z","end":"2026-01-20T20:27:52.997949Z","steps":["trace[601835227] 'agreement among raft nodes before linearized reading'  (duration: 308.108889ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:52.997965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:52.689758Z","time spent":"308.204181ms","remote":"127.0.0.1:47812","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-01-20T20:27:57.461093Z","caller":"traceutil/trace.go:171","msg":"trace[116309803] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"154.681598ms","start":"2026-01-20T20:27:57.306389Z","end":"2026-01-20T20:27:57.461071Z","steps":["trace[116309803] 'process raft request'  (duration: 151.614012ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:59.211218Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744730941,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-20T20:27:59.53701Z","caller":"traceutil/trace.go:171","msg":"trace[1481197907] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:981; }","duration":"826.251186ms","start":"2026-01-20T20:27:58.710743Z","end":"2026-01-20T20:27:59.536994Z","steps":["trace[1481197907] 'read index received'  (duration: 825.613632ms)","trace[1481197907] 'applied index is now lower than readState.Index'  (duration: 636.944µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:27:59.537084Z","caller":"traceutil/trace.go:171","msg":"trace[284247233] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"865.595523ms","start":"2026-01-20T20:27:58.671484Z","end":"2026-01-20T20:27:59.53708Z","steps":["trace[284247233] 'process raft request'  (duration: 865.366648ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:59.537164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:58.671473Z","time spent":"865.637443ms","remote":"127.0.0.1:47812","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:927 > 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-01-20T20:27:59.537298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.554813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:27:59.537314Z","caller":"traceutil/trace.go:171","msg":"trace[506849624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:943; }","duration":"826.570694ms","start":"2026-01-20T20:27:58.710738Z","end":"2026-01-20T20:27:59.537309Z","steps":["trace[506849624] 'agreement among raft nodes before linearized reading'  (duration: 826.503003ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:59.537327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:58.710694Z","time spent":"826.630265ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-20T20:27:59.537507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.376249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-01-20T20:27:59.537537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.794447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-01-20T20:27:59.537561Z","caller":"traceutil/trace.go:171","msg":"trace[1576129720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:943; }","duration":"469.848779ms","start":"2026-01-20T20:27:59.067705Z","end":"2026-01-20T20:27:59.537554Z","steps":["trace[1576129720] 'agreement among raft nodes before linearized reading'  (duration: 469.800628ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:59.537574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:59.067687Z","time spent":"469.883539ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-01-20T20:27:59.537571Z","caller":"traceutil/trace.go:171","msg":"trace[1783247749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:943; }","duration":"826.445111ms","start":"2026-01-20T20:27:58.711107Z","end":"2026-01-20T20:27:59.537552Z","steps":["trace[1783247749] 'agreement among raft nodes before linearized reading'  (duration: 826.281657ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:59.537636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:58.711089Z","time spent":"826.539172ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-20T20:27:59.537688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.110875ms","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-01-20T20:27:59.537703Z","caller":"traceutil/trace.go:171","msg":"trace[347594593] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:943; }","duration":"821.125586ms","start":"2026-01-20T20:27:58.716573Z","end":"2026-01-20T20:27:59.537699Z","steps":["trace[347594593] 'agreement among raft nodes before linearized reading'  (duration: 821.086185ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:27:59.537714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:27:58.716559Z","time spent":"821.152616ms","remote":"127.0.0.1:47812","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-01-20T20:28:04.546218Z","caller":"traceutil/trace.go:171","msg":"trace[242866257] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"100.681268ms","start":"2026-01-20T20:28:04.44552Z","end":"2026-01-20T20:28:04.546201Z","steps":["trace[242866257] 'process raft request'  (duration: 34.033899ms)","trace[242866257] 'compare'  (duration: 66.541737ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:28:05.833472Z","caller":"traceutil/trace.go:171","msg":"trace[106316095] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"123.76537ms","start":"2026-01-20T20:28:05.709672Z","end":"2026-01-20T20:28:05.833437Z","steps":["trace[106316095] 'read index received'  (duration: 123.567196ms)","trace[106316095] 'applied index is now lower than readState.Index'  (duration: 197.044µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:28:05.833764Z","caller":"traceutil/trace.go:171","msg":"trace[879419980] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"223.601881ms","start":"2026-01-20T20:28:05.61015Z","end":"2026-01-20T20:28:05.833752Z","steps":["trace[879419980] 'process raft request'  (duration: 223.167341ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:05.834137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.450754ms","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-01-20T20:28:05.834204Z","caller":"traceutil/trace.go:171","msg":"trace[27571358] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:974; }","duration":"124.565357ms","start":"2026-01-20T20:28:05.70962Z","end":"2026-01-20T20:28:05.834186Z","steps":["trace[27571358] 'agreement among raft nodes before linearized reading'  (duration: 124.347622ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:05.83421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.976296ms","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-01-20T20:28:05.834249Z","caller":"traceutil/trace.go:171","msg":"trace[1604803220] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:974; }","duration":"102.027907ms","start":"2026-01-20T20:28:05.732209Z","end":"2026-01-20T20:28:05.834237Z","steps":["trace[1604803220] 'agreement among raft nodes before linearized reading'  (duration: 101.868174ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:05.835545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.377076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:28:05.835597Z","caller":"traceutil/trace.go:171","msg":"trace[635472509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:974; }","duration":"102.441047ms","start":"2026-01-20T20:28:05.733141Z","end":"2026-01-20T20:28:05.835582Z","steps":["trace[635472509] 'agreement among raft nodes before linearized reading'  (duration: 102.287473ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:05.836026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.183993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:28:05.836067Z","caller":"traceutil/trace.go:171","msg":"trace[1806089146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:974; }","duration":"103.249845ms","start":"2026-01-20T20:28:05.732803Z","end":"2026-01-20T20:28:05.836053Z","steps":["trace[1806089146] 'agreement among raft nodes before linearized reading'  (duration: 103.096161ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:05.864401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.960277ms","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-01-20T20:28:05.866003Z","caller":"traceutil/trace.go:171","msg":"trace[147153688] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:974; }","duration":"113.571891ms","start":"2026-01-20T20:28:05.751322Z","end":"2026-01-20T20:28:05.864894Z","steps":["trace[147153688] 'agreement among raft nodes before linearized reading'  (duration: 83.058375ms)","trace[147153688] 'range keys from bolt db'  (duration: 29.953733ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:28:06.131117Z","caller":"traceutil/trace.go:171","msg":"trace[342309900] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"218.946469ms","start":"2026-01-20T20:28:05.912152Z","end":"2026-01-20T20:28:06.131099Z","steps":["trace[342309900] 'process raft request'  (duration: 210.015205ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:06.504578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.643401ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744731020 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:955 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T20:28:06.504652Z","caller":"traceutil/trace.go:171","msg":"trace[916892293] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"363.806289ms","start":"2026-01-20T20:28:06.140834Z","end":"2026-01-20T20:28:06.50464Z","steps":["trace[916892293] 'process raft request'  (duration: 135.040305ms)","trace[916892293] 'compare'  (duration: 228.563359ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:28:06.504695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:06.140824Z","time spent":"363.850129ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:955 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-01-20T20:28:08.350582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.480277ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744731021 > lease_revoke:<id:4d269bdd15b8a0f3>","response":"size:28"}
{"level":"info","ts":"2026-01-20T20:28:08.350738Z","caller":"traceutil/trace.go:171","msg":"trace[1257741082] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"1.128799526s","start":"2026-01-20T20:28:07.221896Z","end":"2026-01-20T20:28:08.350696Z","steps":["trace[1257741082] 'read index received'  (duration: 207.826828ms)","trace[1257741082] 'applied index is now lower than readState.Index'  (duration: 920.970238ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:28:08.351019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.129093552s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:28:08.351052Z","caller":"traceutil/trace.go:171","msg":"trace[1226586020] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:980; }","duration":"1.129201965s","start":"2026-01-20T20:28:07.221839Z","end":"2026-01-20T20:28:08.351041Z","steps":["trace[1226586020] 'agreement among raft nodes before linearized reading'  (duration: 1.129104772s)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:08.351095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:07.221823Z","time spent":"1.129258705s","remote":"127.0.0.1:47668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-01-20T20:28:08.351678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.77596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:28:08.351775Z","caller":"traceutil/trace.go:171","msg":"trace[465093820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:980; }","duration":"434.906583ms","start":"2026-01-20T20:28:07.916845Z","end":"2026-01-20T20:28:08.351751Z","steps":["trace[465093820] 'agreement among raft nodes before linearized reading'  (duration: 434.578236ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:08.351815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.52837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-01-20T20:28:08.351829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:07.916822Z","time spent":"434.997505ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-01-20T20:28:08.351878Z","caller":"traceutil/trace.go:171","msg":"trace[1947569955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:980; }","duration":"333.589851ms","start":"2026-01-20T20:28:08.018271Z","end":"2026-01-20T20:28:08.351861Z","steps":["trace[1947569955] 'agreement among raft nodes before linearized reading'  (duration: 333.490979ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:08.351918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:08.018224Z","time spent":"333.681853ms","remote":"127.0.0.1:47562","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-01-20T20:28:08.352201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.778528ms","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":"warn","ts":"2026-01-20T20:28:08.352215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.611298ms","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-01-20T20:28:08.352234Z","caller":"traceutil/trace.go:171","msg":"trace[1694846181] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:980; }","duration":"433.82389ms","start":"2026-01-20T20:28:07.9184Z","end":"2026-01-20T20:28:08.352223Z","steps":["trace[1694846181] 'agreement among raft nodes before linearized reading'  (duration: 433.728358ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:28:08.352248Z","caller":"traceutil/trace.go:171","msg":"trace[2044927999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:980; }","duration":"216.69523ms","start":"2026-01-20T20:28:08.135542Z","end":"2026-01-20T20:28:08.352237Z","steps":["trace[2044927999] 'agreement among raft nodes before linearized reading'  (duration: 216.547807ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:08.352265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:07.918393Z","time spent":"433.865121ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-20T20:28:08.352416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.425364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:28:08.352445Z","caller":"traceutil/trace.go:171","msg":"trace[637163601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:980; }","duration":"435.485895ms","start":"2026-01-20T20:28:07.916947Z","end":"2026-01-20T20:28:08.352433Z","steps":["trace[637163601] 'agreement among raft nodes before linearized reading'  (duration: 435.395103ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:08.352471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:07.916942Z","time spent":"435.522536ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-20T20:28:08.352585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.645939ms","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-01-20T20:28:08.352609Z","caller":"traceutil/trace.go:171","msg":"trace[2114025594] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:980; }","duration":"435.69273ms","start":"2026-01-20T20:28:07.916908Z","end":"2026-01-20T20:28:08.352601Z","steps":["trace[2114025594] 'agreement among raft nodes before linearized reading'  (duration: 435.624149ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:08.352634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:07.91688Z","time spent":"435.748101ms","remote":"127.0.0.1:47812","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-01-20T20:28:08.815096Z","caller":"traceutil/trace.go:171","msg":"trace[1276505603] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"452.608947ms","start":"2026-01-20T20:28:08.362454Z","end":"2026-01-20T20:28:08.815063Z","steps":["trace[1276505603] 'process raft request'  (duration: 431.941968ms)","trace[1276505603] 'compare'  (duration: 19.377212ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:28:08.815266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:08.362446Z","time spent":"452.717601ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:975 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-20T20:28:08.882876Z","caller":"traceutil/trace.go:171","msg":"trace[1561708751] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"517.268795ms","start":"2026-01-20T20:28:08.365576Z","end":"2026-01-20T20:28:08.882845Z","steps":["trace[1561708751] 'process raft request'  (duration: 448.506169ms)","trace[1561708751] 'store kv pair into bolt db' {req_type:put; key:/registry/leases/kube-system/plndr-cp-lock; req_size:416; } (duration: 68.141611ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:28:08.883331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:08.365569Z","time spent":"517.671423ms","remote":"127.0.0.1:47812","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:976 > 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-01-20T20:28:08.883563Z","caller":"traceutil/trace.go:171","msg":"trace[605141994] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"515.646059ms","start":"2026-01-20T20:28:08.36791Z","end":"2026-01-20T20:28:08.883556Z","steps":["trace[605141994] 'process raft request'  (duration: 514.892303ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:08.883615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:08.367889Z","time spent":"515.698469ms","remote":"127.0.0.1:47812","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:978 > 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-01-20T20:28:08.883441Z","caller":"traceutil/trace.go:171","msg":"trace[303651355] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"514.208448ms","start":"2026-01-20T20:28:08.369223Z","end":"2026-01-20T20:28:08.883431Z","steps":["trace[303651355] 'process raft request'  (duration: 514.174647ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:08.883862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:08.369214Z","time spent":"514.626577ms","remote":"127.0.0.1:47812","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:977 > 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-01-20T20:28:09.341065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.395512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:28:09.341122Z","caller":"traceutil/trace.go:171","msg":"trace[1914302733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"319.490315ms","start":"2026-01-20T20:28:09.021619Z","end":"2026-01-20T20:28:09.341109Z","steps":["trace[1914302733] 'range keys from in-memory index tree'  (duration: 319.321081ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:09.34115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:09.021601Z","time spent":"319.543165ms","remote":"127.0.0.1:47562","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-01-20T20:28:09.583415Z","caller":"traceutil/trace.go:171","msg":"trace[1723058913] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"115.942581ms","start":"2026-01-20T20:28:09.467452Z","end":"2026-01-20T20:28:09.583395Z","steps":["trace[1723058913] 'process raft request'  (duration: 115.799378ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:28:11.657771Z","caller":"traceutil/trace.go:171","msg":"trace[1844948564] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"145.961153ms","start":"2026-01-20T20:28:11.511787Z","end":"2026-01-20T20:28:11.657748Z","steps":["trace[1844948564] 'process raft request'  (duration: 130.408295ms)","trace[1844948564] 'compare'  (duration: 15.471476ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:28:12.939984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003168886s","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744731062 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:996 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T20:28:12.940192Z","caller":"traceutil/trace.go:171","msg":"trace[1305349512] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1041; }","duration":"632.023109ms","start":"2026-01-20T20:28:12.308152Z","end":"2026-01-20T20:28:12.940175Z","steps":["trace[1305349512] 'read index received'  (duration: 30.721µs)","trace[1305349512] 'applied index is now lower than readState.Index'  (duration: 631.991118ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:28:12.940403Z","caller":"traceutil/trace.go:171","msg":"trace[29007166] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"1.030089582s","start":"2026-01-20T20:28:11.9103Z","end":"2026-01-20T20:28:12.940389Z","steps":["trace[29007166] 'process raft request'  (duration: 26.443126ms)","trace[29007166] 'compare'  (duration: 1.002574543s)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:28:12.940468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:11.910279Z","time spent":"1.030152873s","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:996 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-01-20T20:28:12.94065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.500409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:28:12.940677Z","caller":"traceutil/trace.go:171","msg":"trace[1345761867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1000; }","duration":"632.55264ms","start":"2026-01-20T20:28:12.308116Z","end":"2026-01-20T20:28:12.940669Z","steps":["trace[1345761867] 'agreement among raft nodes before linearized reading'  (duration: 632.506699ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:12.940705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:12.308102Z","time spent":"632.597681ms","remote":"127.0.0.1:47562","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-01-20T20:28:12.94091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.862318ms","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-01-20T20:28:12.940938Z","caller":"traceutil/trace.go:171","msg":"trace[1282335626] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1000; }","duration":"529.918009ms","start":"2026-01-20T20:28:12.411012Z","end":"2026-01-20T20:28:12.94093Z","steps":["trace[1282335626] 'agreement among raft nodes before linearized reading'  (duration: 529.819237ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:12.940968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:12.410996Z","time spent":"529.96533ms","remote":"127.0.0.1:47812","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-01-20T20:28:13.450344Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744731064,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-20T20:28:13.665186Z","caller":"traceutil/trace.go:171","msg":"trace[782714566] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"717.448084ms","start":"2026-01-20T20:28:12.947716Z","end":"2026-01-20T20:28:13.665164Z","steps":["trace[782714566] 'process raft request'  (duration: 716.888092ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:13.665267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:12.947697Z","time spent":"717.528816ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:988 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-01-20T20:28:13.899728Z","caller":"traceutil/trace.go:171","msg":"trace[778172721] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1043; }","duration":"949.893627ms","start":"2026-01-20T20:28:12.949808Z","end":"2026-01-20T20:28:13.899702Z","steps":["trace[778172721] 'read index received'  (duration: 715.663316ms)","trace[778172721] 'applied index is now lower than readState.Index'  (duration: 234.229021ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:28:13.899889Z","caller":"traceutil/trace.go:171","msg":"trace[1484426527] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"865.681377ms","start":"2026-01-20T20:28:13.034193Z","end":"2026-01-20T20:28:13.899874Z","steps":["trace[1484426527] 'process raft request'  (duration: 808.706058ms)","trace[1484426527] 'compare'  (duration: 56.684202ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:28:13.900003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:13.034179Z","time spent":"865.742649ms","remote":"127.0.0.1:47812","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:987 > 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-01-20T20:28:13.900201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.834306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:28:13.900283Z","caller":"traceutil/trace.go:171","msg":"trace[1441471454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1002; }","duration":"926.947249ms","start":"2026-01-20T20:28:12.973314Z","end":"2026-01-20T20:28:13.900261Z","steps":["trace[1441471454] 'agreement among raft nodes before linearized reading'  (duration: 926.709204ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:13.900324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:12.973308Z","time spent":"927.0057ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-20T20:28:13.90072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.908149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:28:13.900743Z","caller":"traceutil/trace.go:171","msg":"trace[652150360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1002; }","duration":"950.936781ms","start":"2026-01-20T20:28:12.949796Z","end":"2026-01-20T20:28:13.900733Z","steps":["trace[652150360] 'agreement among raft nodes before linearized reading'  (duration: 950.879869ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:13.90076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:12.949791Z","time spent":"950.965571ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-20T20:28:13.900847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.922782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:28:13.900867Z","caller":"traceutil/trace.go:171","msg":"trace[1687602915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1002; }","duration":"871.961873ms","start":"2026-01-20T20:28:13.028899Z","end":"2026-01-20T20:28:13.900861Z","steps":["trace[1687602915] 'agreement among raft nodes before linearized reading'  (duration: 871.932063ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:13.900882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:13.028886Z","time spent":"871.992754ms","remote":"127.0.0.1:47564","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-01-20T20:28:13.901031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.782025ms","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-01-20T20:28:13.90105Z","caller":"traceutil/trace.go:171","msg":"trace[846200739] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1002; }","duration":"920.800415ms","start":"2026-01-20T20:28:12.980243Z","end":"2026-01-20T20:28:13.901044Z","steps":["trace[846200739] 'agreement among raft nodes before linearized reading'  (duration: 920.727284ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:28:13.901068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:28:12.980228Z","time spent":"920.835176ms","remote":"127.0.0.1:47812","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-01-20T20:28:21.788665Z","caller":"traceutil/trace.go:171","msg":"trace[193144666] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"111.607236ms","start":"2026-01-20T20:28:21.677037Z","end":"2026-01-20T20:28:21.788644Z","steps":["trace[193144666] 'process raft request'  (duration: 111.465263ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:28:21.898696Z","caller":"traceutil/trace.go:171","msg":"trace[134422976] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"106.451895ms","start":"2026-01-20T20:28:21.792214Z","end":"2026-01-20T20:28:21.898666Z","steps":["trace[134422976] 'process raft request'  (duration: 80.744376ms)","trace[134422976] 'compare'  (duration: 25.586906ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:28:21.899183Z","caller":"traceutil/trace.go:171","msg":"trace[1182375084] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"102.846757ms","start":"2026-01-20T20:28:21.796324Z","end":"2026-01-20T20:28:21.899171Z","steps":["trace[1182375084] 'process raft request'  (duration: 102.784455ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:30:18.783535Z","caller":"traceutil/trace.go:171","msg":"trace[1222524676] transaction","detail":"{read_only:false; response_revision:1526; number_of_response:1; }","duration":"184.187271ms","start":"2026-01-20T20:30:18.59933Z","end":"2026-01-20T20:30:18.783517Z","steps":["trace[1222524676] 'process raft request'  (duration: 184.094369ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:30:18.787043Z","caller":"traceutil/trace.go:171","msg":"trace[1288269286] linearizableReadLoop","detail":"{readStateIndex:1594; appliedIndex:1593; }","duration":"181.628306ms","start":"2026-01-20T20:30:18.605405Z","end":"2026-01-20T20:30:18.787033Z","steps":["trace[1288269286] 'read index received'  (duration: 178.408347ms)","trace[1288269286] 'applied index is now lower than readState.Index'  (duration: 3.219429ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:30:18.787299Z","caller":"traceutil/trace.go:171","msg":"trace[185804589] transaction","detail":"{read_only:false; response_revision:1527; number_of_response:1; }","duration":"186.401607ms","start":"2026-01-20T20:30:18.600888Z","end":"2026-01-20T20:30:18.78729Z","steps":["trace[185804589] 'process raft request'  (duration: 186.087861ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:30:18.788294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.873943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-01-20T20:30:18.788429Z","caller":"traceutil/trace.go:171","msg":"trace[970549310] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1527; }","duration":"182.954105ms","start":"2026-01-20T20:30:18.605394Z","end":"2026-01-20T20:30:18.788349Z","steps":["trace[970549310] 'agreement among raft nodes before linearized reading'  (duration: 182.826202ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:30:18.899776Z","caller":"traceutil/trace.go:171","msg":"trace[1786888258] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"102.55295ms","start":"2026-01-20T20:30:18.79719Z","end":"2026-01-20T20:30:18.899743Z","steps":["trace[1786888258] 'process raft request'  (duration: 102.13496ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:30:18.899801Z","caller":"traceutil/trace.go:171","msg":"trace[235368700] transaction","detail":"{read_only:false; response_revision:1530; number_of_response:1; }","duration":"101.632651ms","start":"2026-01-20T20:30:18.798148Z","end":"2026-01-20T20:30:18.899781Z","steps":["trace[235368700] 'process raft request'  (duration: 101.355554ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:30:20.010763Z","caller":"traceutil/trace.go:171","msg":"trace[164125088] transaction","detail":"{read_only:false; response_revision:1532; number_of_response:1; }","duration":"117.493989ms","start":"2026-01-20T20:30:19.893252Z","end":"2026-01-20T20:30:20.010746Z","steps":["trace[164125088] 'process raft request'  (duration: 117.391897ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:30:22.847604Z","caller":"traceutil/trace.go:171","msg":"trace[1270065362] transaction","detail":"{read_only:false; response_revision:1541; number_of_response:1; }","duration":"110.109812ms","start":"2026-01-20T20:30:22.737469Z","end":"2026-01-20T20:30:22.847579Z","steps":["trace[1270065362] 'process raft request'  (duration: 110.00006ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:30:39.711757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.812243ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744732623 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1599 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >>","response":"size:16"}
{"level":"info","ts":"2026-01-20T20:30:39.711877Z","caller":"traceutil/trace.go:171","msg":"trace[1926421083] linearizableReadLoop","detail":"{readStateIndex:1681; appliedIndex:1680; }","duration":"574.9799ms","start":"2026-01-20T20:30:39.136879Z","end":"2026-01-20T20:30:39.711859Z","steps":["trace[1926421083] 'read index received'  (duration: 300.891272ms)","trace[1926421083] 'applied index is now lower than readState.Index'  (duration: 274.083638ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:30:39.711966Z","caller":"traceutil/trace.go:171","msg":"trace[284677476] transaction","detail":"{read_only:false; response_revision:1610; number_of_response:1; }","duration":"608.357576ms","start":"2026-01-20T20:30:39.1036Z","end":"2026-01-20T20:30:39.711957Z","steps":["trace[284677476] 'process raft request'  (duration: 334.245318ms)","trace[284677476] 'compare'  (duration: 273.670589ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:30:39.712011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:30:39.103581Z","time spent":"608.407568ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1599 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}
{"level":"warn","ts":"2026-01-20T20:30:39.712114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.586488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-01-20T20:30:39.712181Z","caller":"traceutil/trace.go:171","msg":"trace[1292811709] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1610; }","duration":"571.67474ms","start":"2026-01-20T20:30:39.14049Z","end":"2026-01-20T20:30:39.712165Z","steps":["trace[1292811709] 'agreement among raft nodes before linearized reading'  (duration: 571.530427ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:30:39.71221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:30:39.140469Z","time spent":"571.735362ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-01-20T20:30:39.712406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.301838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:30:39.712424Z","caller":"traceutil/trace.go:171","msg":"trace[152433640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1610; }","duration":"478.340459ms","start":"2026-01-20T20:30:39.234077Z","end":"2026-01-20T20:30:39.712418Z","steps":["trace[152433640] 'agreement among raft nodes before linearized reading'  (duration: 478.280318ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:30:39.712446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:30:39.234068Z","time spent":"478.37325ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-20T20:30:39.712667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.789398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:30:39.712686Z","caller":"traceutil/trace.go:171","msg":"trace[1661265722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1610; }","duration":"575.84722ms","start":"2026-01-20T20:30:39.136832Z","end":"2026-01-20T20:30:39.71268Z","steps":["trace[1661265722] 'agreement among raft nodes before linearized reading'  (duration: 575.786878ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:30:39.712704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:30:39.13682Z","time spent":"575.879901ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-20T20:30:41.897484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.712919ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744732653 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1612 > 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-01-20T20:30:41.897601Z","caller":"traceutil/trace.go:171","msg":"trace[513872861] transaction","detail":"{read_only:false; response_revision:1621; number_of_response:1; }","duration":"126.8422ms","start":"2026-01-20T20:30:41.77074Z","end":"2026-01-20T20:30:41.897582Z","steps":["trace[513872861] 'process raft request'  (duration: 12.934867ms)","trace[513872861] 'compare'  (duration: 113.26213ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:30:58.778851Z","caller":"traceutil/trace.go:171","msg":"trace[1896823296] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"276.49848ms","start":"2026-01-20T20:30:58.502333Z","end":"2026-01-20T20:30:58.778832Z","steps":["trace[1896823296] 'process raft request'  (duration: 276.402058ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:20.496201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.044829ms","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:509"}
{"level":"info","ts":"2026-01-20T20:31:20.496292Z","caller":"traceutil/trace.go:171","msg":"trace[1388720328] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1804; }","duration":"287.185343ms","start":"2026-01-20T20:31:20.209087Z","end":"2026-01-20T20:31:20.496273Z","steps":["trace[1388720328] 'range keys from in-memory index tree'  (duration: 286.848925ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:20.645773Z","caller":"traceutil/trace.go:171","msg":"trace[748001912] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"146.75084ms","start":"2026-01-20T20:31:20.498997Z","end":"2026-01-20T20:31:20.645747Z","steps":["trace[748001912] 'process raft request'  (duration: 146.176568ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:27.565138Z","caller":"traceutil/trace.go:171","msg":"trace[379247834] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"300.442308ms","start":"2026-01-20T20:31:27.264683Z","end":"2026-01-20T20:31:27.565125Z","steps":["trace[379247834] 'process raft request'  (duration: 300.06281ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:27.565508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:27.264674Z","time spent":"300.795195ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1813 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:404 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-01-20T20:31:27.564878Z","caller":"traceutil/trace.go:171","msg":"trace[886691786] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1916; }","duration":"156.688313ms","start":"2026-01-20T20:31:27.408172Z","end":"2026-01-20T20:31:27.56486Z","steps":["trace[886691786] 'read index received'  (duration: 156.53161ms)","trace[886691786] 'applied index is now lower than readState.Index'  (duration: 155.823µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:31:27.565436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.251285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-20T20:31:27.566168Z","caller":"traceutil/trace.go:171","msg":"trace[566775099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1835; }","duration":"158.018662ms","start":"2026-01-20T20:31:27.408141Z","end":"2026-01-20T20:31:27.566159Z","steps":["trace[566775099] 'agreement among raft nodes before linearized reading'  (duration: 157.212685ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:27.566073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.683128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:31:27.566603Z","caller":"traceutil/trace.go:171","msg":"trace[1595788144] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1835; }","duration":"134.24768ms","start":"2026-01-20T20:31:27.432347Z","end":"2026-01-20T20:31:27.566595Z","steps":["trace[1595788144] 'agreement among raft nodes before linearized reading'  (duration: 133.702529ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:27.56613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.498686ms","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-01-20T20:31:27.567283Z","caller":"traceutil/trace.go:171","msg":"trace[98754662] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1835; }","duration":"129.663513ms","start":"2026-01-20T20:31:27.437612Z","end":"2026-01-20T20:31:27.567275Z","steps":["trace[98754662] 'agreement among raft nodes before linearized reading'  (duration: 128.476696ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:27.776564Z","caller":"traceutil/trace.go:171","msg":"trace[1700692676] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1918; }","duration":"202.920908ms","start":"2026-01-20T20:31:27.573627Z","end":"2026-01-20T20:31:27.776548Z","steps":["trace[1700692676] 'read index received'  (duration: 36.605718ms)","trace[1700692676] 'applied index is now lower than readState.Index'  (duration: 166.31449ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:31:27.776668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.01312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:31:27.776705Z","caller":"traceutil/trace.go:171","msg":"trace[703209596] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1837; }","duration":"203.066591ms","start":"2026-01-20T20:31:27.573613Z","end":"2026-01-20T20:31:27.77668Z","steps":["trace[703209596] 'agreement among raft nodes before linearized reading'  (duration: 202.99389ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:27.776936Z","caller":"traceutil/trace.go:171","msg":"trace[2052072572] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"203.345807ms","start":"2026-01-20T20:31:27.573584Z","end":"2026-01-20T20:31:27.77693Z","steps":["trace[2052072572] 'process raft request'  (duration: 107.582796ms)","trace[2052072572] 'compare'  (duration: 95.299552ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:31:28.524179Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674200744733213,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-01-20T20:31:28.908687Z","caller":"traceutil/trace.go:171","msg":"trace[775802958] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"901.078929ms","start":"2026-01-20T20:31:28.007583Z","end":"2026-01-20T20:31:28.908662Z","steps":["trace[775802958] 'process raft request'  (duration: 900.959236ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:28.908831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:28.007564Z","time spent":"901.191622ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1829 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}
{"level":"info","ts":"2026-01-20T20:31:28.985343Z","caller":"traceutil/trace.go:171","msg":"trace[336508621] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"961.953021ms","start":"2026-01-20T20:31:28.023375Z","end":"2026-01-20T20:31:28.985328Z","steps":["trace[336508621] 'read index received'  (duration: 885.972035ms)","trace[336508621] 'applied index is now lower than readState.Index'  (duration: 75.980436ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:28.98543Z","caller":"traceutil/trace.go:171","msg":"trace[491351071] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"301.147824ms","start":"2026-01-20T20:31:28.684275Z","end":"2026-01-20T20:31:28.985423Z","steps":["trace[491351071] 'process raft request'  (duration: 301.028852ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:28.985407Z","caller":"traceutil/trace.go:171","msg":"trace[1351808261] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"976.193517ms","start":"2026-01-20T20:31:28.009181Z","end":"2026-01-20T20:31:28.985375Z","steps":["trace[1351808261] 'process raft request'  (duration: 976.027134ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:28.985498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:28.684259Z","time spent":"301.186075ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1796 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-01-20T20:31:28.985561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:28.009171Z","time spent":"976.307839ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1830 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-01-20T20:31:28.985779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.3887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-01-20T20:31:28.985805Z","caller":"traceutil/trace.go:171","msg":"trace[870711791] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1840; }","duration":"962.466072ms","start":"2026-01-20T20:31:28.02333Z","end":"2026-01-20T20:31:28.985796Z","steps":["trace[870711791] 'agreement among raft nodes before linearized reading'  (duration: 962.344289ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:28.985831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:28.02332Z","time spent":"962.506363ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-01-20T20:31:28.985916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"931.185817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-01-20T20:31:28.985934Z","caller":"traceutil/trace.go:171","msg":"trace[1680756473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1840; }","duration":"931.229648ms","start":"2026-01-20T20:31:28.054699Z","end":"2026-01-20T20:31:28.985929Z","steps":["trace[1680756473] 'agreement among raft nodes before linearized reading'  (duration: 931.178867ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:28.98595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:28.054686Z","time spent":"931.259949ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-01-20T20:31:28.986109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.894331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"}
{"level":"warn","ts":"2026-01-20T20:31:28.986121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.059638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-01-20T20:31:28.986141Z","caller":"traceutil/trace.go:171","msg":"trace[1163076172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1840; }","duration":"874.114399ms","start":"2026-01-20T20:31:28.11202Z","end":"2026-01-20T20:31:28.986134Z","steps":["trace[1163076172] 'agreement among raft nodes before linearized reading'  (duration: 874.058808ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:28.986142Z","caller":"traceutil/trace.go:171","msg":"trace[1326917568] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1840; }","duration":"146.959143ms","start":"2026-01-20T20:31:28.839172Z","end":"2026-01-20T20:31:28.986131Z","steps":["trace[1326917568] 'agreement among raft nodes before linearized reading'  (duration: 146.863411ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:28.986156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:28.112001Z","time spent":"874.151559ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-01-20T20:31:31.01949Z","caller":"traceutil/trace.go:171","msg":"trace[37266994] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"150.790907ms","start":"2026-01-20T20:31:30.868687Z","end":"2026-01-20T20:31:31.019478Z","steps":["trace[37266994] 'process raft request'  (duration: 123.741294ms)","trace[37266994] 'compare'  (duration: 26.93282ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:31.019435Z","caller":"traceutil/trace.go:171","msg":"trace[1673558672] linearizableReadLoop","detail":"{readStateIndex:1936; appliedIndex:1935; }","duration":"119.455153ms","start":"2026-01-20T20:31:30.899968Z","end":"2026-01-20T20:31:31.019423Z","steps":["trace[1673558672] 'read index received'  (duration: 92.706616ms)","trace[1673558672] 'applied index is now lower than readState.Index'  (duration: 26.747847ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:31:31.019714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.735398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:31:31.020088Z","caller":"traceutil/trace.go:171","msg":"trace[1766453722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1853; }","duration":"120.140636ms","start":"2026-01-20T20:31:30.899939Z","end":"2026-01-20T20:31:31.02008Z","steps":["trace[1766453722] 'agreement among raft nodes before linearized reading'  (duration: 119.709177ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:31.020245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.095955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-01-20T20:31:31.020264Z","caller":"traceutil/trace.go:171","msg":"trace[538614574] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1853; }","duration":"106.142035ms","start":"2026-01-20T20:31:30.914118Z","end":"2026-01-20T20:31:31.02026Z","steps":["trace[538614574] 'agreement among raft nodes before linearized reading'  (duration: 106.082844ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:38.444633Z","caller":"traceutil/trace.go:171","msg":"trace[1407032652] linearizableReadLoop","detail":"{readStateIndex:1967; appliedIndex:1966; }","duration":"159.447952ms","start":"2026-01-20T20:31:38.285163Z","end":"2026-01-20T20:31:38.444611Z","steps":["trace[1407032652] 'read index received'  (duration: 159.124265ms)","trace[1407032652] 'applied index is now lower than readState.Index'  (duration: 322.737µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:38.444929Z","caller":"traceutil/trace.go:171","msg":"trace[912026453] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"182.951689ms","start":"2026-01-20T20:31:38.261962Z","end":"2026-01-20T20:31:38.444914Z","steps":["trace[912026453] 'process raft request'  (duration: 182.416447ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:38.445269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.982197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpoint-controller\" ","response":"range_response_count:1 size:751"}
{"level":"warn","ts":"2026-01-20T20:31:38.445287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.106887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:disruption-controller\" ","response":"range_response_count:1 size:759"}
{"level":"info","ts":"2026-01-20T20:31:38.445336Z","caller":"traceutil/trace.go:171","msg":"trace[800100441] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpoint-controller; range_end:; response_count:1; response_revision:1883; }","duration":"123.07437ms","start":"2026-01-20T20:31:38.322243Z","end":"2026-01-20T20:31:38.445317Z","steps":["trace[800100441] 'agreement among raft nodes before linearized reading'  (duration: 122.967448ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:38.445638Z","caller":"traceutil/trace.go:171","msg":"trace[1358935947] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:disruption-controller; range_end:; response_count:1; response_revision:1883; }","duration":"160.311261ms","start":"2026-01-20T20:31:38.285155Z","end":"2026-01-20T20:31:38.445466Z","steps":["trace[1358935947] 'agreement among raft nodes before linearized reading'  (duration: 160.042715ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:38.685276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.941726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:deployment-controller\" ","response":"range_response_count:1 size:913"}
{"level":"info","ts":"2026-01-20T20:31:38.685344Z","caller":"traceutil/trace.go:171","msg":"trace[389089174] range","detail":"{range_begin:/registry/clusterroles/system:controller:deployment-controller; range_end:; response_count:1; response_revision:1885; }","duration":"136.038109ms","start":"2026-01-20T20:31:38.549289Z","end":"2026-01-20T20:31:38.685327Z","steps":["trace[389089174] 'range keys from in-memory index tree'  (duration: 135.869295ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:38.686586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.946537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpoint-controller\" ","response":"range_response_count:1 size:751"}
{"level":"info","ts":"2026-01-20T20:31:38.686639Z","caller":"traceutil/trace.go:171","msg":"trace[945104267] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpoint-controller; range_end:; response_count:1; response_revision:1885; }","duration":"116.056939ms","start":"2026-01-20T20:31:38.57057Z","end":"2026-01-20T20:31:38.686626Z","steps":["trace[945104267] 'range keys from in-memory index tree'  (duration: 115.820734ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:39.175533Z","caller":"traceutil/trace.go:171","msg":"trace[773691635] linearizableReadLoop","detail":"{readStateIndex:1971; appliedIndex:1970; }","duration":"123.542849ms","start":"2026-01-20T20:31:39.051973Z","end":"2026-01-20T20:31:39.175515Z","steps":["trace[773691635] 'read index received'  (duration: 91.836367ms)","trace[773691635] 'applied index is now lower than readState.Index'  (duration: 31.705532ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:39.176068Z","caller":"traceutil/trace.go:171","msg":"trace[12096406] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"134.973136ms","start":"2026-01-20T20:31:39.041069Z","end":"2026-01-20T20:31:39.176043Z","steps":["trace[12096406] 'process raft request'  (duration: 102.817884ms)","trace[12096406] 'compare'  (duration: 31.278012ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:31:39.176892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.91175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:endpointslice-controller\" ","response":"range_response_count:1 size:791"}
{"level":"info","ts":"2026-01-20T20:31:39.17731Z","caller":"traceutil/trace.go:171","msg":"trace[121086752] range","detail":"{range_begin:/registry/clusterroles/system:controller:endpointslice-controller; range_end:; response_count:1; response_revision:1887; }","duration":"125.356129ms","start":"2026-01-20T20:31:39.05194Z","end":"2026-01-20T20:31:39.177296Z","steps":["trace[121086752] 'agreement among raft nodes before linearized reading'  (duration: 124.893299ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:43.523422Z","caller":"traceutil/trace.go:171","msg":"trace[1029106048] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"139.155665ms","start":"2026-01-20T20:31:43.384251Z","end":"2026-01-20T20:31:43.523406Z","steps":["trace[1029106048] 'process raft request'  (duration: 139.036102ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:43.537621Z","caller":"traceutil/trace.go:171","msg":"trace[1659777074] linearizableReadLoop","detail":"{readStateIndex:1993; appliedIndex:1991; }","duration":"150.715164ms","start":"2026-01-20T20:31:43.38689Z","end":"2026-01-20T20:31:43.537605Z","steps":["trace[1659777074] 'read index received'  (duration: 136.637971ms)","trace[1659777074] 'applied index is now lower than readState.Index'  (duration: 14.076803ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:43.53773Z","caller":"traceutil/trace.go:171","msg":"trace[78917343] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"153.305931ms","start":"2026-01-20T20:31:43.384419Z","end":"2026-01-20T20:31:43.537725Z","steps":["trace[78917343] 'process raft request'  (duration: 153.135147ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:43.537795Z","caller":"traceutil/trace.go:171","msg":"trace[1221747189] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"152.841991ms","start":"2026-01-20T20:31:43.384948Z","end":"2026-01-20T20:31:43.53779Z","steps":["trace[1221747189] 'process raft request'  (duration: 152.641447ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:43.538774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.97081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:ttl-controller\" ","response":"range_response_count:1 size:731"}
{"level":"info","ts":"2026-01-20T20:31:43.538801Z","caller":"traceutil/trace.go:171","msg":"trace[489336469] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:ttl-controller; range_end:; response_count:1; response_revision:1908; }","duration":"151.924671ms","start":"2026-01-20T20:31:43.38687Z","end":"2026-01-20T20:31:43.538794Z","steps":["trace[489336469] 'agreement among raft nodes before linearized reading'  (duration: 150.96784ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:47.868469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.045558ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14782674200744733833 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1917 > 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-01-20T20:31:47.868617Z","caller":"traceutil/trace.go:171","msg":"trace[724694577] linearizableReadLoop","detail":"{readStateIndex:2011; appliedIndex:2010; }","duration":"121.68133ms","start":"2026-01-20T20:31:47.746924Z","end":"2026-01-20T20:31:47.868605Z","steps":["trace[724694577] 'read index received'  (duration: 18.307945ms)","trace[724694577] 'applied index is now lower than readState.Index'  (duration: 103.372105ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:47.868907Z","caller":"traceutil/trace.go:171","msg":"trace[1785374653] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"130.191493ms","start":"2026-01-20T20:31:47.738704Z","end":"2026-01-20T20:31:47.868896Z","steps":["trace[1785374653] 'process raft request'  (duration: 26.502121ms)","trace[1785374653] 'compare'  (duration: 102.818933ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:31:47.868967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.038828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/default/kube-root-ca.crt\" ","response":"range_response_count:1 size:1738"}
{"level":"info","ts":"2026-01-20T20:31:47.874497Z","caller":"traceutil/trace.go:171","msg":"trace[1677055396] range","detail":"{range_begin:/registry/configmaps/default/kube-root-ca.crt; range_end:; response_count:1; response_revision:1925; }","duration":"127.584508ms","start":"2026-01-20T20:31:47.746902Z","end":"2026-01-20T20:31:47.874487Z","steps":["trace[1677055396] 'agreement among raft nodes before linearized reading'  (duration: 122.029908ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:47.869288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.761726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/kube-node-lease/\" range_end:\"/registry/cronjobs/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:31:47.874695Z","caller":"traceutil/trace.go:171","msg":"trace[2028042699] range","detail":"{range_begin:/registry/cronjobs/kube-node-lease/; range_end:/registry/cronjobs/kube-node-lease0; response_count:0; response_revision:1925; }","duration":"117.169413ms","start":"2026-01-20T20:31:47.757517Z","end":"2026-01-20T20:31:47.874686Z","steps":["trace[2028042699] 'agreement among raft nodes before linearized reading'  (duration: 111.748516ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:49.243488Z","caller":"traceutil/trace.go:171","msg":"trace[1431637256] linearizableReadLoop","detail":"{readStateIndex:2013; appliedIndex:2012; }","duration":"123.240693ms","start":"2026-01-20T20:31:49.120233Z","end":"2026-01-20T20:31:49.243474Z","steps":["trace[1431637256] 'read index received'  (duration: 123.09116ms)","trace[1431637256] 'applied index is now lower than readState.Index'  (duration: 148.973µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:49.243776Z","caller":"traceutil/trace.go:171","msg":"trace[281319784] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"173.205358ms","start":"2026-01-20T20:31:49.070563Z","end":"2026-01-20T20:31:49.243768Z","steps":["trace[281319784] 'process raft request'  (duration: 172.81646ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:49.244011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.763815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-node-lease/default\" ","response":"range_response_count:1 size:187"}
{"level":"info","ts":"2026-01-20T20:31:49.244031Z","caller":"traceutil/trace.go:171","msg":"trace[221464755] range","detail":"{range_begin:/registry/serviceaccounts/kube-node-lease/default; range_end:; response_count:1; response_revision:1927; }","duration":"123.817376ms","start":"2026-01-20T20:31:49.120208Z","end":"2026-01-20T20:31:49.244026Z","steps":["trace[221464755] 'agreement among raft nodes before linearized reading'  (duration: 123.748974ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:49.446219Z","caller":"traceutil/trace.go:171","msg":"trace[844932024] linearizableReadLoop","detail":"{readStateIndex:2014; appliedIndex:2013; }","duration":"172.178758ms","start":"2026-01-20T20:31:49.274025Z","end":"2026-01-20T20:31:49.446204Z","steps":["trace[844932024] 'read index received'  (duration: 141.744822ms)","trace[844932024] 'applied index is now lower than readState.Index'  (duration: 30.433006ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:49.446395Z","caller":"traceutil/trace.go:171","msg":"trace[1134952684] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"192.124787ms","start":"2026-01-20T20:31:49.254259Z","end":"2026-01-20T20:31:49.446384Z","steps":["trace[1134952684] 'process raft request'  (duration: 161.553278ms)","trace[1134952684] 'compare'  (duration: 30.18384ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:31:49.44656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.522185ms","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-01-20T20:31:49.446583Z","caller":"traceutil/trace.go:171","msg":"trace[2113687585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1928; }","duration":"172.576256ms","start":"2026-01-20T20:31:49.273999Z","end":"2026-01-20T20:31:49.446575Z","steps":["trace[2113687585] 'agreement among raft nodes before linearized reading'  (duration: 172.494504ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:49.446682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.11131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"info","ts":"2026-01-20T20:31:49.446867Z","caller":"traceutil/trace.go:171","msg":"trace[1981959132] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1928; }","duration":"142.317145ms","start":"2026-01-20T20:31:49.304545Z","end":"2026-01-20T20:31:49.446862Z","steps":["trace[1981959132] 'agreement among raft nodes before linearized reading'  (duration: 142.11789ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:49.447274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.359543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-node-lease/default\" ","response":"range_response_count:1 size:187"}
{"level":"info","ts":"2026-01-20T20:31:49.447294Z","caller":"traceutil/trace.go:171","msg":"trace[949994031] range","detail":"{range_begin:/registry/serviceaccounts/kube-node-lease/default; range_end:; response_count:1; response_revision:1928; }","duration":"115.395385ms","start":"2026-01-20T20:31:49.331893Z","end":"2026-01-20T20:31:49.447288Z","steps":["trace[949994031] 'agreement among raft nodes before linearized reading'  (duration: 115.359724ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:49.447463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.316464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:129945"}
{"level":"info","ts":"2026-01-20T20:31:49.447482Z","caller":"traceutil/trace.go:171","msg":"trace[1203704450] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1928; }","duration":"136.345706ms","start":"2026-01-20T20:31:49.31113Z","end":"2026-01-20T20:31:49.447476Z","steps":["trace[1203704450] 'agreement among raft nodes before linearized reading'  (duration: 136.273504ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:49.656452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.896234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"}
{"level":"info","ts":"2026-01-20T20:31:49.656779Z","caller":"traceutil/trace.go:171","msg":"trace[987310073] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1929; }","duration":"102.256172ms","start":"2026-01-20T20:31:49.554502Z","end":"2026-01-20T20:31:49.656758Z","steps":["trace[987310073] 'range keys from in-memory index tree'  (duration: 101.824833ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:31:49.825798Z","caller":"traceutil/trace.go:171","msg":"trace[263022430] linearizableReadLoop","detail":"{readStateIndex:2017; appliedIndex:2015; }","duration":"163.542481ms","start":"2026-01-20T20:31:49.662231Z","end":"2026-01-20T20:31:49.825774Z","steps":["trace[263022430] 'read index received'  (duration: 40.793888ms)","trace[263022430] 'applied index is now lower than readState.Index'  (duration: 122.747783ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:49.826037Z","caller":"traceutil/trace.go:171","msg":"trace[779277082] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"163.902848ms","start":"2026-01-20T20:31:49.662123Z","end":"2026-01-20T20:31:49.826026Z","steps":["trace[779277082] 'process raft request'  (duration: 125.951512ms)","trace[779277082] 'compare'  (duration: 37.539767ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:31:49.826184Z","caller":"traceutil/trace.go:171","msg":"trace[1795061206] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"163.868957ms","start":"2026-01-20T20:31:49.66231Z","end":"2026-01-20T20:31:49.826179Z","steps":["trace[1795061206] 'process raft request'  (duration: 163.426778ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:49.82639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.136363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"}
{"level":"info","ts":"2026-01-20T20:31:49.826416Z","caller":"traceutil/trace.go:171","msg":"trace[42065809] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1932; }","duration":"164.197324ms","start":"2026-01-20T20:31:49.662212Z","end":"2026-01-20T20:31:49.82641Z","steps":["trace[42065809] 'agreement among raft nodes before linearized reading'  (duration: 164.028851ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:49.826599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.313338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-01-20T20:31:49.826616Z","caller":"traceutil/trace.go:171","msg":"trace[1916096183] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1932; }","duration":"164.330428ms","start":"2026-01-20T20:31:49.66228Z","end":"2026-01-20T20:31:49.82661Z","steps":["trace[1916096183] 'agreement among raft nodes before linearized reading'  (duration: 164.269176ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:59.431468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.07763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-01-20T20:31:59.431548Z","caller":"traceutil/trace.go:171","msg":"trace[870074548] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1968; }","duration":"130.196113ms","start":"2026-01-20T20:31:59.301333Z","end":"2026-01-20T20:31:59.431529Z","steps":["trace[870074548] 'range keys from in-memory index tree'  (duration: 129.902016ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:59.431626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.429321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:1 size:201"}
{"level":"info","ts":"2026-01-20T20:31:59.432372Z","caller":"traceutil/trace.go:171","msg":"trace[669609334] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:1; response_revision:1968; }","duration":"172.309139ms","start":"2026-01-20T20:31:59.260036Z","end":"2026-01-20T20:31:59.432345Z","steps":["trace[669609334] 'range keys from in-memory index tree'  (duration: 171.330348ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:31:59.432015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.087432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-dns\" ","response":"range_response_count:1 size:1211"}
{"level":"info","ts":"2026-01-20T20:31:59.433242Z","caller":"traceutil/trace.go:171","msg":"trace[1019804847] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-dns; range_end:; response_count:1; response_revision:1968; }","duration":"158.39032ms","start":"2026-01-20T20:31:59.274831Z","end":"2026-01-20T20:31:59.433221Z","steps":["trace[1019804847] 'range keys from in-memory index tree'  (duration: 156.924818ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:00.149452Z","caller":"traceutil/trace.go:171","msg":"trace[697696452] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"235.277685ms","start":"2026-01-20T20:31:59.914155Z","end":"2026-01-20T20:32:00.149433Z","steps":["trace[697696452] 'process raft request'  (duration: 235.179243ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:00.149579Z","caller":"traceutil/trace.go:171","msg":"trace[1379395797] linearizableReadLoop","detail":"{readStateIndex:2060; appliedIndex:2060; }","duration":"215.791235ms","start":"2026-01-20T20:31:59.933698Z","end":"2026-01-20T20:32:00.149489Z","steps":["trace[1379395797] 'read index received'  (duration: 215.786405ms)","trace[1379395797] 'applied index is now lower than readState.Index'  (duration: 3.92µs)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:32:00.150138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.42229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:118 size:90755"}
{"level":"info","ts":"2026-01-20T20:32:00.150277Z","caller":"traceutil/trace.go:171","msg":"trace[290668016] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:118; response_revision:1972; }","duration":"216.599764ms","start":"2026-01-20T20:31:59.933667Z","end":"2026-01-20T20:32:00.150267Z","steps":["trace[290668016] 'agreement among raft nodes before linearized reading'  (duration: 216.006281ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:00.28888Z","caller":"traceutil/trace.go:171","msg":"trace[1721172917] linearizableReadLoop","detail":"{readStateIndex:2061; appliedIndex:2060; }","duration":"139.203606ms","start":"2026-01-20T20:32:00.149658Z","end":"2026-01-20T20:32:00.288862Z","steps":["trace[1721172917] 'read index received'  (duration: 96.208131ms)","trace[1721172917] 'applied index is now lower than readState.Index'  (duration: 42.994465ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:32:00.28899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.021679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-01-20T20:32:00.289035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.841291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-01-20T20:32:00.289055Z","caller":"traceutil/trace.go:171","msg":"trace[633231977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1973; }","duration":"283.877361ms","start":"2026-01-20T20:32:00.005171Z","end":"2026-01-20T20:32:00.289048Z","steps":["trace[633231977] 'agreement among raft nodes before linearized reading'  (duration: 283.788459ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:00.289154Z","caller":"traceutil/trace.go:171","msg":"trace[669355932] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"332.228602ms","start":"2026-01-20T20:31:59.956913Z","end":"2026-01-20T20:32:00.289141Z","steps":["trace[669355932] 'process raft request'  (duration: 288.974211ms)","trace[669355932] 'compare'  (duration: 42.901294ms)"],"step_count":2}
{"level":"warn","ts":"2026-01-20T20:32:00.289225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:59.956897Z","time spent":"332.279033ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1930 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-01-20T20:32:00.289248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.429541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-01-20T20:32:00.289269Z","caller":"traceutil/trace.go:171","msg":"trace[1228787960] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1973; }","duration":"289.451492ms","start":"2026-01-20T20:31:59.999811Z","end":"2026-01-20T20:32:00.289263Z","steps":["trace[1228787960] 'agreement among raft nodes before linearized reading'  (duration: 289.39217ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:00.289345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.023303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-01-20T20:32:00.28936Z","caller":"traceutil/trace.go:171","msg":"trace[1093967894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1973; }","duration":"303.051664ms","start":"2026-01-20T20:31:59.986304Z","end":"2026-01-20T20:32:00.289356Z","steps":["trace[1093967894] 'agreement among raft nodes before linearized reading'  (duration: 303.006823ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:00.289418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:59.986298Z","time spent":"303.114956ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-01-20T20:32:00.289478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.89015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-01-20T20:32:00.289493Z","caller":"traceutil/trace.go:171","msg":"trace[141230480] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:1973; }","duration":"315.92775ms","start":"2026-01-20T20:31:59.97356Z","end":"2026-01-20T20:32:00.289488Z","steps":["trace[141230480] 'agreement among raft nodes before linearized reading'  (duration: 315.89687ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:00.28951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-20T20:31:59.973551Z","time spent":"315.953492ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "}
{"level":"warn","ts":"2026-01-20T20:32:00.289666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.650136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-01-20T20:32:00.289683Z","caller":"traceutil/trace.go:171","msg":"trace[188910848] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1973; }","duration":"106.694027ms","start":"2026-01-20T20:32:00.182984Z","end":"2026-01-20T20:32:00.289678Z","steps":["trace[188910848] 'agreement among raft nodes before linearized reading'  (duration: 106.613476ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:00.289032Z","caller":"traceutil/trace.go:171","msg":"trace[1791578759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1973; }","duration":"274.109551ms","start":"2026-01-20T20:32:00.01491Z","end":"2026-01-20T20:32:00.289019Z","steps":["trace[1791578759] 'agreement among raft nodes before linearized reading'  (duration: 274.002429ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:00.99356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.467598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-01-20T20:32:00.993668Z","caller":"traceutil/trace.go:171","msg":"trace[150839156] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:1978; }","duration":"143.636332ms","start":"2026-01-20T20:32:00.850014Z","end":"2026-01-20T20:32:00.99365Z","steps":["trace[150839156] 'range keys from in-memory index tree'  (duration: 143.328286ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:00.994594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.664368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:118 size:90755"}
{"level":"info","ts":"2026-01-20T20:32:00.994696Z","caller":"traceutil/trace.go:171","msg":"trace[1558239497] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:118; response_revision:1978; }","duration":"140.781481ms","start":"2026-01-20T20:32:00.8539Z","end":"2026-01-20T20:32:00.994681Z","steps":["trace[1558239497] 'range keys from in-memory index tree'  (duration: 140.121427ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:01.103033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.06465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:1 size:220"}
{"level":"info","ts":"2026-01-20T20:32:01.103085Z","caller":"traceutil/trace.go:171","msg":"trace[661425261] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:1; response_revision:1978; }","duration":"104.146262ms","start":"2026-01-20T20:32:00.998931Z","end":"2026-01-20T20:32:01.103077Z","steps":["trace[661425261] 'agreement among raft nodes before linearized reading'  (duration: 104.05801ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:01.102735Z","caller":"traceutil/trace.go:171","msg":"trace[1517211753] linearizableReadLoop","detail":"{readStateIndex:2067; appliedIndex:2066; }","duration":"103.763254ms","start":"2026-01-20T20:32:00.998957Z","end":"2026-01-20T20:32:01.10272Z","steps":["trace[1517211753] 'read index received'  (duration: 103.722463ms)","trace[1517211753] 'applied index is now lower than readState.Index'  (duration: 40.101µs)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:32:01.156651Z","caller":"traceutil/trace.go:171","msg":"trace[682532584] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"112.130534ms","start":"2026-01-20T20:32:01.044497Z","end":"2026-01-20T20:32:01.156627Z","steps":["trace[682532584] 'process raft request'  (duration: 111.93639ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:01.156916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.487865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-01-20T20:32:01.156961Z","caller":"traceutil/trace.go:171","msg":"trace[2124265168] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1979; }","duration":"140.587457ms","start":"2026-01-20T20:32:01.016357Z","end":"2026-01-20T20:32:01.156944Z","steps":["trace[2124265168] 'agreement among raft nodes before linearized reading'  (duration: 140.521555ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:01.894895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.104733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"}
{"level":"info","ts":"2026-01-20T20:32:01.895905Z","caller":"traceutil/trace.go:171","msg":"trace[1377859951] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1981; }","duration":"139.013793ms","start":"2026-01-20T20:32:01.756752Z","end":"2026-01-20T20:32:01.895766Z","steps":["trace[1377859951] 'range keys from in-memory index tree'  (duration: 137.812016ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:01.897027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.606298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:118 size:90755"}
{"level":"info","ts":"2026-01-20T20:32:01.898032Z","caller":"traceutil/trace.go:171","msg":"trace[2053730663] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:118; response_revision:1981; }","duration":"155.658411ms","start":"2026-01-20T20:32:01.742342Z","end":"2026-01-20T20:32:01.898Z","steps":["trace[2053730663] 'range keys from in-memory index tree'  (duration: 152.533284ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:04.580719Z","caller":"traceutil/trace.go:171","msg":"trace[1870935281] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"130.139631ms","start":"2026-01-20T20:32:04.450546Z","end":"2026-01-20T20:32:04.580685Z","steps":["trace[1870935281] 'process raft request'  (duration: 117.584111ms)","trace[1870935281] 'compare'  (duration: 11.910996ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:32:04.580978Z","caller":"traceutil/trace.go:171","msg":"trace[566033026] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"130.377397ms","start":"2026-01-20T20:32:04.450591Z","end":"2026-01-20T20:32:04.580968Z","steps":["trace[566033026] 'process raft request'  (duration: 129.600231ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:04.581124Z","caller":"traceutil/trace.go:171","msg":"trace[583097410] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"129.034168ms","start":"2026-01-20T20:32:04.452081Z","end":"2026-01-20T20:32:04.581116Z","steps":["trace[583097410] 'process raft request'  (duration: 128.18103ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:06.764294Z","caller":"traceutil/trace.go:171","msg":"trace[2142530129] linearizableReadLoop","detail":"{readStateIndex:2092; appliedIndex:2090; }","duration":"147.67849ms","start":"2026-01-20T20:32:06.616589Z","end":"2026-01-20T20:32:06.764268Z","steps":["trace[2142530129] 'read index received'  (duration: 6.365976ms)","trace[2142530129] 'applied index is now lower than readState.Index'  (duration: 141.311113ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:32:06.76442Z","caller":"traceutil/trace.go:171","msg":"trace[377990409] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"150.166724ms","start":"2026-01-20T20:32:06.614217Z","end":"2026-01-20T20:32:06.764384Z","steps":["trace[377990409] 'process raft request'  (duration: 123.55619ms)","trace[377990409] 'compare'  (duration: 26.272247ms)"],"step_count":2}
{"level":"info","ts":"2026-01-20T20:32:06.764914Z","caller":"traceutil/trace.go:171","msg":"trace[437732226] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"149.276194ms","start":"2026-01-20T20:32:06.615622Z","end":"2026-01-20T20:32:06.764898Z","steps":["trace[437732226] 'process raft request'  (duration: 148.582259ms)"],"step_count":1}
{"level":"warn","ts":"2026-01-20T20:32:06.765429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.813983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-dhvcz\" ","response":"range_response_count:1 size:11187"}
{"level":"info","ts":"2026-01-20T20:32:06.76566Z","caller":"traceutil/trace.go:171","msg":"trace[2064251992] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-dhvcz; range_end:; response_count:1; response_revision:2002; }","duration":"149.051339ms","start":"2026-01-20T20:32:06.616577Z","end":"2026-01-20T20:32:06.765628Z","steps":["trace[2064251992] 'agreement among raft nodes before linearized reading'  (duration: 148.695242ms)"],"step_count":1}
{"level":"info","ts":"2026-01-20T20:32:08.744241Z","caller":"traceutil/trace.go:171","msg":"trace[583992273] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"113.912992ms","start":"2026-01-20T20:32:08.630313Z","end":"2026-01-20T20:32:08.744226Z","steps":["trace[583992273] 'process raft request'  (duration: 113.82701ms)"],"step_count":1}