{"level":"warn","ts":"2026-03-06T20:17:43.273361Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-06T20:17:43.273474Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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-03-06T20:17:43.273562Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-06T20:17:43.273578Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-03-06T20:17:43.2736Z","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-03-06T20:17:43.274451Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]}
{"level":"info","ts":"2026-03-06T20:17:43.274546Z","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":8,"max-cpu-available":8,"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.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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-03-06T20:17:43.280969Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.076024ms"}
{"level":"info","ts":"2026-03-06T20:17:43.288935Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"}
{"level":"info","ts":"2026-03-06T20:17:43.289006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-06T20:17:43.289061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"}
{"level":"info","ts":"2026-03-06T20:17:43.289081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-06T20:17:43.289093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"}
{"level":"info","ts":"2026-03-06T20:17:43.289136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"warn","ts":"2026-03-06T20:17:43.294827Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-06T20:17:43.296122Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-06T20:17:43.297373Z","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-03-06T20:17:43.299288Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-06T20:17:43.299395Z","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-03-06T20:17:43.299765Z","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-03-06T20:17:43.300853Z","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-03-06T20:17:43.304264Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-06T20:17:43.30773Z","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-03-06T20:17:43.30802Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-06T20:17:43.308049Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-06T20:17:43.308139Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-03-06T20:17:43.308204Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-03-06T20:17:43.309283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"info","ts":"2026-03-06T20:17:43.309413Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-03-06T20:17:43.489805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-06T20:17:43.4899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-06T20:17:43.489996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"}
{"level":"info","ts":"2026-03-06T20:17:43.490066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"}
{"level":"info","ts":"2026-03-06T20:17:43.490095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-03-06T20:17:43.490221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"}
{"level":"info","ts":"2026-03-06T20:17:43.490249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-03-06T20:17:43.491606Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T20:17:43.492707Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-06T20:17:43.492837Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-06T20:17:43.492877Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-06T20:17:43.494578Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-06T20:17:43.494607Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-06T20:17:43.496581Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T20:17:43.496875Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T20:17:43.497011Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-06T20:17:43.499389Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"}
{"level":"info","ts":"2026-03-06T20:17:43.509905Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-06T20:18:07.854535Z","caller":"traceutil/trace.go:171","msg":"trace[386085362] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"212.614855ms","start":"2026-03-06T20:18:07.641888Z","end":"2026-03-06T20:18:07.854503Z","steps":["trace[386085362] 'process raft request'  (duration: 212.437341ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:11.855303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.859318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:18:11.85541Z","caller":"traceutil/trace.go:171","msg":"trace[1414367419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:466; }","duration":"106.046022ms","start":"2026-03-06T20:18:11.749344Z","end":"2026-03-06T20:18:11.85539Z","steps":["trace[1414367419] 'range keys from in-memory index tree'  (duration: 105.783247ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:18.02084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.896517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-06T20:18:18.020968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.249829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:18:18.021083Z","caller":"traceutil/trace.go:171","msg":"trace[1801749273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:480; }","duration":"271.430924ms","start":"2026-03-06T20:18:17.749635Z","end":"2026-03-06T20:18:18.021066Z","steps":["trace[1801749273] 'range keys from in-memory index tree'  (duration: 271.171878ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:18:18.021095Z","caller":"traceutil/trace.go:171","msg":"trace[151344488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:480; }","duration":"105.188074ms","start":"2026-03-06T20:18:17.91589Z","end":"2026-03-06T20:18:18.020889Z","steps":["trace[151344488] 'range keys from in-memory index tree'  (duration: 104.783865ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:18.021108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.713866ms","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-03-06T20:18:18.02117Z","caller":"traceutil/trace.go:171","msg":"trace[1653005188] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:480; }","duration":"554.841919ms","start":"2026-03-06T20:18:17.466313Z","end":"2026-03-06T20:18:18.021155Z","steps":["trace[1653005188] 'range keys from in-memory index tree'  (duration: 554.490742ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:18.021223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:17.466294Z","time spent":"554.922171ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-06T20:18:19.301287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.023229ms","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-03-06T20:18:19.301369Z","caller":"traceutil/trace.go:171","msg":"trace[118455734] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:487; }","duration":"120.166392ms","start":"2026-03-06T20:18:19.181185Z","end":"2026-03-06T20:18:19.301352Z","steps":["trace[118455734] 'range keys from in-memory index tree'  (duration: 119.869025ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:20.25072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812337626316101,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-06T20:18:20.628739Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.091150531s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-06T20:18:20.629283Z","caller":"traceutil/trace.go:171","msg":"trace[1709979243] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"879.149979ms","start":"2026-03-06T20:18:19.750106Z","end":"2026-03-06T20:18:20.629256Z","steps":["trace[1709979243] 'read index received'  (duration: 878.776591ms)","trace[1709979243] 'applied index is now lower than readState.Index'  (duration: 372.198µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:18:20.629371Z","caller":"traceutil/trace.go:171","msg":"trace[1953529518] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"1.091898377s","start":"2026-03-06T20:18:19.537463Z","end":"2026-03-06T20:18:20.629361Z","steps":["trace[1953529518] 'process raft request'  (duration: 1.09155937s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:20.629567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.446775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:18:20.629626Z","caller":"traceutil/trace.go:171","msg":"trace[1149027383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:489; }","duration":"879.535777ms","start":"2026-03-06T20:18:19.750072Z","end":"2026-03-06T20:18:20.629608Z","steps":["trace[1149027383] 'agreement among raft nodes before linearized reading'  (duration: 879.451535ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:20.629655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:19.750052Z","time spent":"879.596788ms","remote":"127.0.0.1:39410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-06T20:18:20.629646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.828752ms","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-03-06T20:18:20.62972Z","caller":"traceutil/trace.go:171","msg":"trace[1764594225] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:489; }","duration":"567.958785ms","start":"2026-03-06T20:18:20.06174Z","end":"2026-03-06T20:18:20.629698Z","steps":["trace[1764594225] 'agreement among raft nodes before linearized reading'  (duration: 567.810822ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:20.629769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:20.061724Z","time spent":"568.031756ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-06T20:18:20.62982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.022037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-06T20:18:20.629847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.57466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-06T20:18:20.629856Z","caller":"traceutil/trace.go:171","msg":"trace[1269848948] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:489; }","duration":"568.082347ms","start":"2026-03-06T20:18:20.061763Z","end":"2026-03-06T20:18:20.629846Z","steps":["trace[1269848948] 'agreement among raft nodes before linearized reading'  (duration: 568.016326ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:20.629904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:20.061748Z","time spent":"568.150399ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-06T20:18:20.629893Z","caller":"traceutil/trace.go:171","msg":"trace[1398561514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:489; }","duration":"474.708063ms","start":"2026-03-06T20:18:20.155172Z","end":"2026-03-06T20:18:20.62988Z","steps":["trace[1398561514] 'agreement among raft nodes before linearized reading'  (duration: 474.459358ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:20.629962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:20.155125Z","time spent":"474.825856ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-06T20:18:20.630001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:19.53744Z","time spent":"1.091961309s","remote":"127.0.0.1:39578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-lwx5z\" mod_revision:459 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-lwx5z\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-lwx5z\" > >"}
{"level":"info","ts":"2026-03-06T20:18:27.033249Z","caller":"traceutil/trace.go:171","msg":"trace[2021634635] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:594; }","duration":"283.283203ms","start":"2026-03-06T20:18:26.74994Z","end":"2026-03-06T20:18:27.033224Z","steps":["trace[2021634635] 'read index received'  (duration: 34.311931ms)","trace[2021634635] 'applied index is now lower than readState.Index'  (duration: 248.970042ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:18:27.033384Z","caller":"traceutil/trace.go:171","msg":"trace[1147623791] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"310.431547ms","start":"2026-03-06T20:18:26.72294Z","end":"2026-03-06T20:18:27.033372Z","steps":["trace[1147623791] 'process raft request'  (duration: 310.135801ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:27.033659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.690502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-06T20:18:27.033691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.13905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-06T20:18:27.0337Z","caller":"traceutil/trace.go:171","msg":"trace[158914738] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"308.741161ms","start":"2026-03-06T20:18:26.724932Z","end":"2026-03-06T20:18:27.033673Z","steps":["trace[158914738] 'process raft request'  (duration: 308.2544ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:18:27.033759Z","caller":"traceutil/trace.go:171","msg":"trace[1375682407] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:575; }","duration":"146.214731ms","start":"2026-03-06T20:18:26.88753Z","end":"2026-03-06T20:18:27.033745Z","steps":["trace[1375682407] 'agreement among raft nodes before linearized reading'  (duration: 146.103919ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:18:27.033762Z","caller":"traceutil/trace.go:171","msg":"trace[1286779321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"283.846675ms","start":"2026-03-06T20:18:26.749891Z","end":"2026-03-06T20:18:27.033738Z","steps":["trace[1286779321] 'agreement among raft nodes before linearized reading'  (duration: 283.666241ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:27.03384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:26.724922Z","time spent":"308.851713ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:555 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-06T20:18:27.034311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:26.722924Z","time spent":"310.493389ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:554 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-06T20:18:40.924179Z","caller":"traceutil/trace.go:171","msg":"trace[1602150593] linearizableReadLoop","detail":"{readStateIndex:705; appliedIndex:704; }","duration":"175.414ms","start":"2026-03-06T20:18:40.748745Z","end":"2026-03-06T20:18:40.924159Z","steps":["trace[1602150593] 'read index received'  (duration: 175.255987ms)","trace[1602150593] 'applied index is now lower than readState.Index'  (duration: 157.253µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:18:40.924269Z","caller":"traceutil/trace.go:171","msg":"trace[1371313579] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"772.539886ms","start":"2026-03-06T20:18:40.151722Z","end":"2026-03-06T20:18:40.924262Z","steps":["trace[1371313579] 'process raft request'  (duration: 772.327172ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:40.924364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:40.151699Z","time spent":"772.591598ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:671 > 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-03-06T20:18:40.924409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.657007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:18:40.924474Z","caller":"traceutil/trace.go:171","msg":"trace[1788507306] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"175.76083ms","start":"2026-03-06T20:18:40.748694Z","end":"2026-03-06T20:18:40.924455Z","steps":["trace[1788507306] 'agreement among raft nodes before linearized reading'  (duration: 175.648567ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:41.718708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.535752ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812337626316474 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:673 > 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-03-06T20:18:41.718872Z","caller":"traceutil/trace.go:171","msg":"trace[444275466] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"172.544617ms","start":"2026-03-06T20:18:41.546315Z","end":"2026-03-06T20:18:41.71886Z","steps":["trace[444275466] 'process raft request'  (duration: 172.481906ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:18:41.71892Z","caller":"traceutil/trace.go:171","msg":"trace[1931458775] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"615.828675ms","start":"2026-03-06T20:18:41.103063Z","end":"2026-03-06T20:18:41.718892Z","steps":["trace[1931458775] 'process raft request'  (duration: 419.906785ms)","trace[1931458775] 'compare'  (duration: 195.326597ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:18:41.718934Z","caller":"traceutil/trace.go:171","msg":"trace[174811482] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:706; }","duration":"611.468199ms","start":"2026-03-06T20:18:41.107431Z","end":"2026-03-06T20:18:41.718899Z","steps":["trace[174811482] 'read index received'  (duration: 415.61289ms)","trace[174811482] 'applied index is now lower than readState.Index'  (duration: 195.849159ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:18:41.719027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:41.103046Z","time spent":"615.922828ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:673 > 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-03-06T20:18:41.719206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.752246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-06T20:18:41.719297Z","caller":"traceutil/trace.go:171","msg":"trace[1050075238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:680; }","duration":"611.97944ms","start":"2026-03-06T20:18:41.107291Z","end":"2026-03-06T20:18:41.719271Z","steps":["trace[1050075238] 'agreement among raft nodes before linearized reading'  (duration: 611.756615ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:41.719334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:41.107227Z","time spent":"612.099173ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-06T20:18:41.719524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.281955ms","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-03-06T20:18:41.719657Z","caller":"traceutil/trace.go:171","msg":"trace[1038632894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:680; }","duration":"290.50151ms","start":"2026-03-06T20:18:41.429139Z","end":"2026-03-06T20:18:41.719641Z","steps":["trace[1038632894] 'agreement among raft nodes before linearized reading'  (duration: 289.956228ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:18:41.867047Z","caller":"traceutil/trace.go:171","msg":"trace[786221495] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:708; }","duration":"117.401301ms","start":"2026-03-06T20:18:41.74962Z","end":"2026-03-06T20:18:41.867022Z","steps":["trace[786221495] 'read index received'  (duration: 95.191005ms)","trace[786221495] 'applied index is now lower than readState.Index'  (duration: 22.209226ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:18:41.867128Z","caller":"traceutil/trace.go:171","msg":"trace[1643856780] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"143.86457ms","start":"2026-03-06T20:18:41.723239Z","end":"2026-03-06T20:18:41.867103Z","steps":["trace[1643856780] 'process raft request'  (duration: 121.49263ms)","trace[1643856780] 'compare'  (duration: 22.092094ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:18:41.867155Z","caller":"traceutil/trace.go:171","msg":"trace[1183340397] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"143.292817ms","start":"2026-03-06T20:18:41.72383Z","end":"2026-03-06T20:18:41.867123Z","steps":["trace[1183340397] 'process raft request'  (duration: 143.130444ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:41.867195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.530324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:18:41.867246Z","caller":"traceutil/trace.go:171","msg":"trace[1494650603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:682; }","duration":"117.636626ms","start":"2026-03-06T20:18:41.749594Z","end":"2026-03-06T20:18:41.867231Z","steps":["trace[1494650603] 'agreement among raft nodes before linearized reading'  (duration: 117.531754ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:43.582799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.484293ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812337626316481 > lease_revoke:<id:41f79cc4cc837dee>","response":"size:29"}
{"level":"info","ts":"2026-03-06T20:18:43.582876Z","caller":"traceutil/trace.go:171","msg":"trace[172884510] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"836.030828ms","start":"2026-03-06T20:18:42.746826Z","end":"2026-03-06T20:18:43.582857Z","steps":["trace[172884510] 'read index received'  (duration: 460.449183ms)","trace[172884510] 'applied index is now lower than readState.Index'  (duration: 375.580785ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:18:43.582951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.11959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:18:43.582965Z","caller":"traceutil/trace.go:171","msg":"trace[628982668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:682; }","duration":"836.16471ms","start":"2026-03-06T20:18:42.746795Z","end":"2026-03-06T20:18:43.58296Z","steps":["trace[628982668] 'agreement among raft nodes before linearized reading'  (duration: 836.126669ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:43.582983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:42.746782Z","time spent":"836.196561ms","remote":"127.0.0.1:39396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-06T20:18:43.583059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.075615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-03-06T20:18:43.583108Z","caller":"traceutil/trace.go:171","msg":"trace[444258734] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:682; }","duration":"655.163576ms","start":"2026-03-06T20:18:42.927931Z","end":"2026-03-06T20:18:43.583095Z","steps":["trace[444258734] 'agreement among raft nodes before linearized reading'  (duration: 655.024663ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:43.583108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.592238ms","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-03-06T20:18:43.583174Z","caller":"traceutil/trace.go:171","msg":"trace[2073321525] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:682; }","duration":"566.69025ms","start":"2026-03-06T20:18:43.016467Z","end":"2026-03-06T20:18:43.583157Z","steps":["trace[2073321525] 'agreement among raft nodes before linearized reading'  (duration: 566.493325ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:43.583216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:43.016453Z","time spent":"566.755031ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-06T20:18:43.583137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:18:42.927915Z","time spent":"655.215888ms","remote":"127.0.0.1:39664","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":"info","ts":"2026-03-06T20:18:43.823466Z","caller":"traceutil/trace.go:171","msg":"trace[1478280339] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"237.370617ms","start":"2026-03-06T20:18:43.586074Z","end":"2026-03-06T20:18:43.823445Z","steps":["trace[1478280339] 'process raft request'  (duration: 237.191583ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:18:43.831738Z","caller":"traceutil/trace.go:171","msg":"trace[1907563637] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:711; }","duration":"108.322691ms","start":"2026-03-06T20:18:43.723398Z","end":"2026-03-06T20:18:43.831721Z","steps":["trace[1907563637] 'read index received'  (duration: 99.837885ms)","trace[1907563637] 'applied index is now lower than readState.Index'  (duration: 8.484156ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:18:43.831834Z","caller":"traceutil/trace.go:171","msg":"trace[1167882449] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"245.295821ms","start":"2026-03-06T20:18:43.586512Z","end":"2026-03-06T20:18:43.831807Z","steps":["trace[1167882449] 'process raft request'  (duration: 245.108877ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:18:43.831886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.479935ms","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-03-06T20:18:43.831914Z","caller":"traceutil/trace.go:171","msg":"trace[393435506] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:684; }","duration":"108.565736ms","start":"2026-03-06T20:18:43.723342Z","end":"2026-03-06T20:18:43.831908Z","steps":["trace[393435506] 'agreement among raft nodes before linearized reading'  (duration: 108.457363ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:18:54.108892Z","caller":"traceutil/trace.go:171","msg":"trace[65861261] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"128.396356ms","start":"2026-03-06T20:18:53.980479Z","end":"2026-03-06T20:18:54.108876Z","steps":["trace[65861261] 'process raft request'  (duration: 128.304264ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:00.10258Z","caller":"traceutil/trace.go:171","msg":"trace[1195002447] linearizableReadLoop","detail":"{readStateIndex:767; appliedIndex:766; }","duration":"106.812615ms","start":"2026-03-06T20:18:59.995743Z","end":"2026-03-06T20:19:00.102555Z","steps":["trace[1195002447] 'read index received'  (duration: 98.527446ms)","trace[1195002447] 'applied index is now lower than readState.Index'  (duration: 8.284059ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:00.102703Z","caller":"traceutil/trace.go:171","msg":"trace[2018886418] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"125.50251ms","start":"2026-03-06T20:18:59.977188Z","end":"2026-03-06T20:19:00.102691Z","steps":["trace[2018886418] 'process raft request'  (duration: 117.16094ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:00.102959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.332971ms","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-03-06T20:19:00.103031Z","caller":"traceutil/trace.go:171","msg":"trace[941362969] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:735; }","duration":"105.460134ms","start":"2026-03-06T20:18:59.997549Z","end":"2026-03-06T20:19:00.10301Z","steps":["trace[941362969] 'agreement among raft nodes before linearized reading'  (duration: 105.29802ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:00.103131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.352787ms","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-03-06T20:19:00.103222Z","caller":"traceutil/trace.go:171","msg":"trace[341318627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:735; }","duration":"107.46303ms","start":"2026-03-06T20:18:59.995735Z","end":"2026-03-06T20:19:00.103198Z","steps":["trace[341318627] 'agreement among raft nodes before linearized reading'  (duration: 107.165853ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:04.674142Z","caller":"traceutil/trace.go:171","msg":"trace[1912201976] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"481.496053ms","start":"2026-03-06T20:19:04.192625Z","end":"2026-03-06T20:19:04.674121Z","steps":["trace[1912201976] 'read index received'  (duration: 481.36849ms)","trace[1912201976] 'applied index is now lower than readState.Index'  (duration: 124.863µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:04.674243Z","caller":"traceutil/trace.go:171","msg":"trace[44376349] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"680.437897ms","start":"2026-03-06T20:19:03.993765Z","end":"2026-03-06T20:19:04.674203Z","steps":["trace[44376349] 'process raft request'  (duration: 680.235302ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:04.674388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.686126ms","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-03-06T20:19:04.674441Z","caller":"traceutil/trace.go:171","msg":"trace[206871884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:745; }","duration":"394.791868ms","start":"2026-03-06T20:19:04.279641Z","end":"2026-03-06T20:19:04.674433Z","steps":["trace[206871884] 'agreement among raft nodes before linearized reading'  (duration: 394.596573ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:04.674465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:04.279621Z","time spent":"394.835449ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-06T20:19:04.674395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.288177ms","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-03-06T20:19:04.67457Z","caller":"traceutil/trace.go:171","msg":"trace[221484196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:745; }","duration":"394.479541ms","start":"2026-03-06T20:19:04.280074Z","end":"2026-03-06T20:19:04.674553Z","steps":["trace[221484196] 'agreement among raft nodes before linearized reading'  (duration: 394.188453ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:04.674636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:04.280069Z","time spent":"394.553892ms","remote":"127.0.0.1:39664","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-03-06T20:19:04.674742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.033366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-03-06T20:19:04.674812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:03.993749Z","time spent":"680.550969ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:740 > 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-03-06T20:19:04.674831Z","caller":"traceutil/trace.go:171","msg":"trace[919625096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:745; }","duration":"482.240441ms","start":"2026-03-06T20:19:04.192568Z","end":"2026-03-06T20:19:04.674809Z","steps":["trace[919625096] 'agreement among raft nodes before linearized reading'  (duration: 481.654746ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:04.674726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.630144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"warn","ts":"2026-03-06T20:19:04.674948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:04.192546Z","time spent":"482.327522ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-06T20:19:04.674959Z","caller":"traceutil/trace.go:171","msg":"trace[1146119179] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:745; }","duration":"394.8949ms","start":"2026-03-06T20:19:04.280035Z","end":"2026-03-06T20:19:04.67493Z","steps":["trace[1146119179] 'agreement among raft nodes before linearized reading'  (duration: 394.284697ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:04.675673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:04.280026Z","time spent":"395.600546ms","remote":"127.0.0.1:39664","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-03-06T20:19:04.817648Z","caller":"traceutil/trace.go:171","msg":"trace[534402090] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"138.636631ms","start":"2026-03-06T20:19:04.678993Z","end":"2026-03-06T20:19:04.81763Z","steps":["trace[534402090] 'process raft request'  (duration: 84.157098ms)","trace[534402090] 'compare'  (duration: 54.33594ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:04.817859Z","caller":"traceutil/trace.go:171","msg":"trace[352977074] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"138.291003ms","start":"2026-03-06T20:19:04.679559Z","end":"2026-03-06T20:19:04.817851Z","steps":["trace[352977074] 'process raft request'  (duration: 138.037957ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:04.818749Z","caller":"traceutil/trace.go:171","msg":"trace[1063780743] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"138.123859ms","start":"2026-03-06T20:19:04.680604Z","end":"2026-03-06T20:19:04.818728Z","steps":["trace[1063780743] 'process raft request'  (duration: 137.217418ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:06.882938Z","caller":"traceutil/trace.go:171","msg":"trace[577919488] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:783; }","duration":"132.441689ms","start":"2026-03-06T20:19:06.750472Z","end":"2026-03-06T20:19:06.882914Z","steps":["trace[577919488] 'read index received'  (duration: 132.187343ms)","trace[577919488] 'applied index is now lower than readState.Index'  (duration: 253.466µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:06.883089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.599792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:19:06.883039Z","caller":"traceutil/trace.go:171","msg":"trace[1227407788] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"159.050165ms","start":"2026-03-06T20:19:06.72396Z","end":"2026-03-06T20:19:06.88301Z","steps":["trace[1227407788] 'process raft request'  (duration: 158.753878ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:06.883132Z","caller":"traceutil/trace.go:171","msg":"trace[1131814842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:751; }","duration":"132.686254ms","start":"2026-03-06T20:19:06.750431Z","end":"2026-03-06T20:19:06.883118Z","steps":["trace[1131814842] 'agreement among raft nodes before linearized reading'  (duration: 132.603532ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:21.441733Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812337626316871,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-06T20:19:21.942435Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812337626316871,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-06T20:19:22.010662Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.112674798s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-06T20:19:22.011003Z","caller":"traceutil/trace.go:171","msg":"trace[547442821] linearizableReadLoop","detail":"{readStateIndex:880; appliedIndex:879; }","duration":"1.070285133s","start":"2026-03-06T20:19:20.940657Z","end":"2026-03-06T20:19:22.010942Z","steps":["trace[547442821] 'read index received'  (duration: 1.070105369s)","trace[547442821] 'applied index is now lower than readState.Index'  (duration: 178.874µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:22.011151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.070471227s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-06T20:19:22.011154Z","caller":"traceutil/trace.go:171","msg":"trace[954084298] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"1.11318742s","start":"2026-03-06T20:19:20.897904Z","end":"2026-03-06T20:19:22.011091Z","steps":["trace[954084298] 'process raft request'  (duration: 1.112914884s)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:22.011194Z","caller":"traceutil/trace.go:171","msg":"trace[1157918731] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:842; }","duration":"1.070559679s","start":"2026-03-06T20:19:20.940622Z","end":"2026-03-06T20:19:22.011182Z","steps":["trace[1157918731] 'agreement among raft nodes before linearized reading'  (duration: 1.070450317s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:22.01121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.176938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-06T20:19:22.011234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:20.94061Z","time spent":"1.07061388s","remote":"127.0.0.1:39804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":31,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"info","ts":"2026-03-06T20:19:22.011257Z","caller":"traceutil/trace.go:171","msg":"trace[2088630583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:842; }","duration":"263.261191ms","start":"2026-03-06T20:19:21.747981Z","end":"2026-03-06T20:19:22.011242Z","steps":["trace[2088630583] 'agreement among raft nodes before linearized reading'  (duration: 263.182289ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:22.01129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:20.897883Z","time spent":"1.113338733s","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:836 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-06T20:19:22.01137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055028864s","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-03-06T20:19:22.011417Z","caller":"traceutil/trace.go:171","msg":"trace[1929458766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:842; }","duration":"1.055095046s","start":"2026-03-06T20:19:20.956309Z","end":"2026-03-06T20:19:22.011404Z","steps":["trace[1929458766] 'agreement among raft nodes before linearized reading'  (duration: 1.0548214s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:22.011444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:20.9563Z","time spent":"1.055137017s","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-06T20:19:22.011497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042221793s","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-03-06T20:19:22.011548Z","caller":"traceutil/trace.go:171","msg":"trace[1808469001] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:842; }","duration":"1.042308715s","start":"2026-03-06T20:19:20.969216Z","end":"2026-03-06T20:19:22.011525Z","steps":["trace[1808469001] 'agreement among raft nodes before linearized reading'  (duration: 1.042199832s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:22.011576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:20.969199Z","time spent":"1.042369296s","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-06T20:19:22.011599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043596763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T20:19:22.011646Z","caller":"traceutil/trace.go:171","msg":"trace[177037083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:842; }","duration":"1.043681375s","start":"2026-03-06T20:19:20.967953Z","end":"2026-03-06T20:19:22.011634Z","steps":["trace[177037083] 'agreement among raft nodes before linearized reading'  (duration: 1.043571303s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:22.011676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:20.96794Z","time spent":"1.043729217s","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-06T20:19:22.011699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042437548s","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-03-06T20:19:22.011734Z","caller":"traceutil/trace.go:171","msg":"trace[1774136880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:842; }","duration":"1.042509219s","start":"2026-03-06T20:19:20.969216Z","end":"2026-03-06T20:19:22.011725Z","steps":["trace[1774136880] 'agreement among raft nodes before linearized reading'  (duration: 1.042424067s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:22.011761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:20.969196Z","time spent":"1.04255738s","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-06T20:19:22.376833Z","caller":"traceutil/trace.go:171","msg":"trace[649039022] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"361.462419ms","start":"2026-03-06T20:19:22.015346Z","end":"2026-03-06T20:19:22.376808Z","steps":["trace[649039022] 'process raft request'  (duration: 348.556774ms)","trace[649039022] 'compare'  (duration: 12.752251ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:22.377005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:22.015318Z","time spent":"361.605781ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:840 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-06T20:19:22.377062Z","caller":"traceutil/trace.go:171","msg":"trace[606929372] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"361.645572ms","start":"2026-03-06T20:19:22.01537Z","end":"2026-03-06T20:19:22.377016Z","steps":["trace[606929372] 'process raft request'  (duration: 361.396407ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:22.377175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:22.015359Z","time spent":"361.764765ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:839 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-06T20:19:22.377319Z","caller":"traceutil/trace.go:171","msg":"trace[795930556] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"361.843977ms","start":"2026-03-06T20:19:22.015468Z","end":"2026-03-06T20:19:22.377312Z","steps":["trace[795930556] 'process raft request'  (duration: 361.492579ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:22.377348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:22.015459Z","time spent":"361.872707ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:838 > 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-03-06T20:19:32.603116Z","caller":"traceutil/trace.go:171","msg":"trace[1680320622] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"124.022806ms","start":"2026-03-06T20:19:32.479067Z","end":"2026-03-06T20:19:32.60309Z","steps":["trace[1680320622] 'process raft request'  (duration: 121.796375ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:37.724997Z","caller":"traceutil/trace.go:171","msg":"trace[51152494] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"243.869809ms","start":"2026-03-06T20:19:37.481103Z","end":"2026-03-06T20:19:37.724973Z","steps":["trace[51152494] 'process raft request'  (duration: 243.699864ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:38.097492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.783983ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812337626317018 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:858 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T20:19:38.097593Z","caller":"traceutil/trace.go:171","msg":"trace[1460120726] linearizableReadLoop","detail":"{readStateIndex:943; appliedIndex:942; }","duration":"361.278724ms","start":"2026-03-06T20:19:37.736299Z","end":"2026-03-06T20:19:38.097577Z","steps":["trace[1460120726] 'read index received'  (duration: 107.307795ms)","trace[1460120726] 'applied index is now lower than readState.Index'  (duration: 253.969839ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:38.097704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.401957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"info","ts":"2026-03-06T20:19:38.097676Z","caller":"traceutil/trace.go:171","msg":"trace[1010415897] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"412.453011ms","start":"2026-03-06T20:19:37.68519Z","end":"2026-03-06T20:19:38.097643Z","steps":["trace[1010415897] 'process raft request'  (duration: 158.433932ms)","trace[1010415897] 'compare'  (duration: 253.082137ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:38.097742Z","caller":"traceutil/trace.go:171","msg":"trace[1812564815] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:901; }","duration":"361.469188ms","start":"2026-03-06T20:19:37.736264Z","end":"2026-03-06T20:19:38.097733Z","steps":["trace[1812564815] 'agreement among raft nodes before linearized reading'  (duration: 361.396977ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:38.097777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:37.736248Z","time spent":"361.521319ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":688,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-03-06T20:19:38.097835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:37.685168Z","time spent":"412.584264ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:858 > 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-03-06T20:19:38.098023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.153812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-5d8xj\" ","response":"range_response_count:1 size:11061"}
{"level":"info","ts":"2026-03-06T20:19:38.098129Z","caller":"traceutil/trace.go:171","msg":"trace[937261650] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-5d8xj; range_end:; response_count:1; response_revision:901; }","duration":"354.297185ms","start":"2026-03-06T20:19:37.743812Z","end":"2026-03-06T20:19:38.098109Z","steps":["trace[937261650] 'agreement among raft nodes before linearized reading'  (duration: 353.913756ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:38.098273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:37.743798Z","time spent":"354.462669ms","remote":"127.0.0.1:39578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":11085,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-5d8xj\" "}
{"level":"warn","ts":"2026-03-06T20:19:38.332895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.360628ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812337626317026 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:889 > 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-03-06T20:19:38.333193Z","caller":"traceutil/trace.go:171","msg":"trace[1046890405] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"141.959056ms","start":"2026-03-06T20:19:38.191216Z","end":"2026-03-06T20:19:38.333175Z","steps":["trace[1046890405] 'process raft request'  (duration: 141.914895ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:38.333183Z","caller":"traceutil/trace.go:171","msg":"trace[963276979] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"150.549062ms","start":"2026-03-06T20:19:38.182558Z","end":"2026-03-06T20:19:38.333107Z","steps":["trace[963276979] 'process raft request'  (duration: 24.889508ms)","trace[963276979] 'compare'  (duration: 125.237903ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:38.333223Z","caller":"traceutil/trace.go:171","msg":"trace[104765204] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"148.192967ms","start":"2026-03-06T20:19:38.184983Z","end":"2026-03-06T20:19:38.333176Z","steps":["trace[104765204] 'process raft request'  (duration: 148.020663ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:38.333405Z","caller":"traceutil/trace.go:171","msg":"trace[1990109174] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"148.31678ms","start":"2026-03-06T20:19:38.185076Z","end":"2026-03-06T20:19:38.333393Z","steps":["trace[1990109174] 'process raft request'  (duration: 148.009133ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:40.646745Z","caller":"traceutil/trace.go:171","msg":"trace[219937204] linearizableReadLoop","detail":"{readStateIndex:961; appliedIndex:960; }","duration":"308.508211ms","start":"2026-03-06T20:19:40.338218Z","end":"2026-03-06T20:19:40.646726Z","steps":["trace[219937204] 'read index received'  (duration: 308.406669ms)","trace[219937204] 'applied index is now lower than readState.Index'  (duration: 100.512µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:40.646786Z","caller":"traceutil/trace.go:171","msg":"trace[246801572] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"444.338457ms","start":"2026-03-06T20:19:40.20242Z","end":"2026-03-06T20:19:40.646759Z","steps":["trace[246801572] 'process raft request'  (duration: 444.165022ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:40.646921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:40.202375Z","time spent":"444.4719ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:904 > 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-03-06T20:19:40.646983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.750797ms","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-03-06T20:19:40.647016Z","caller":"traceutil/trace.go:171","msg":"trace[1259315979] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:919; }","duration":"308.849649ms","start":"2026-03-06T20:19:40.338158Z","end":"2026-03-06T20:19:40.647008Z","steps":["trace[1259315979] 'agreement among raft nodes before linearized reading'  (duration: 308.673145ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:40.647051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:40.338138Z","time spent":"308.907151ms","remote":"127.0.0.1:39664","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-03-06T20:19:40.647108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.937145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T20:19:40.647164Z","caller":"traceutil/trace.go:171","msg":"trace[1676333393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:919; }","duration":"167.024067ms","start":"2026-03-06T20:19:40.480124Z","end":"2026-03-06T20:19:40.647149Z","steps":["trace[1676333393] 'agreement among raft nodes before linearized reading'  (duration: 166.866043ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:41.554325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.125793ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812337626317054 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:911 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T20:19:41.55483Z","caller":"traceutil/trace.go:171","msg":"trace[1564398920] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"903.283297ms","start":"2026-03-06T20:19:40.651532Z","end":"2026-03-06T20:19:41.554815Z","steps":["trace[1564398920] 'process raft request'  (duration: 490.596301ms)","trace[1564398920] 'compare'  (duration: 411.996469ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:41.554921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:40.651506Z","time spent":"903.39209ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:911 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-06T20:19:41.592395Z","caller":"traceutil/trace.go:171","msg":"trace[855826676] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"940.785761ms","start":"2026-03-06T20:19:40.651582Z","end":"2026-03-06T20:19:41.592367Z","steps":["trace[855826676] 'process raft request'  (duration: 940.605437ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:41.59256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:40.651566Z","time spent":"940.908804ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:905 > 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-03-06T20:19:41.592752Z","caller":"traceutil/trace.go:171","msg":"trace[576841879] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"940.367541ms","start":"2026-03-06T20:19:40.652348Z","end":"2026-03-06T20:19:41.592715Z","steps":["trace[576841879] 'process raft request'  (duration: 939.977982ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:41.592926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:40.652322Z","time spent":"940.516395ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:909 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-06T20:19:41.593006Z","caller":"traceutil/trace.go:171","msg":"trace[231597242] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"940.33851ms","start":"2026-03-06T20:19:40.652654Z","end":"2026-03-06T20:19:41.592993Z","steps":["trace[231597242] 'process raft request'  (duration: 939.939811ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:41.593009Z","caller":"traceutil/trace.go:171","msg":"trace[1077484462] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:961; }","duration":"844.21633ms","start":"2026-03-06T20:19:40.748771Z","end":"2026-03-06T20:19:41.592987Z","steps":["trace[1077484462] 'read index received'  (duration: 393.368185ms)","trace[1077484462] 'applied index is now lower than readState.Index'  (duration: 450.847285ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:41.593107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:40.652644Z","time spent":"940.426232ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:910 > 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-03-06T20:19:41.59319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.410274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:19:41.593231Z","caller":"traceutil/trace.go:171","msg":"trace[1733648225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:924; }","duration":"844.499806ms","start":"2026-03-06T20:19:40.748721Z","end":"2026-03-06T20:19:41.593221Z","steps":["trace[1733648225] 'agreement among raft nodes before linearized reading'  (duration: 844.385734ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:41.593263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:40.748699Z","time spent":"844.556437ms","remote":"127.0.0.1:39410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-06T20:19:41.593195Z","caller":"traceutil/trace.go:171","msg":"trace[1280034941] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"584.518731ms","start":"2026-03-06T20:19:41.008537Z","end":"2026-03-06T20:19:41.593056Z","steps":["trace[1280034941] 'process raft request'  (duration: 584.377548ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:41.593456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:41.008508Z","time spent":"584.866709ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:869 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-06T20:19:42.575468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.910092ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812337626317070 > lease_revoke:<id:41f79cc4cc83806d>","response":"size:29"}
{"level":"info","ts":"2026-03-06T20:19:42.575625Z","caller":"traceutil/trace.go:171","msg":"trace[2124978385] linearizableReadLoop","detail":"{readStateIndex:974; appliedIndex:973; }","duration":"358.796267ms","start":"2026-03-06T20:19:42.216766Z","end":"2026-03-06T20:19:42.575562Z","steps":["trace[2124978385] 'read index received'  (duration: 42.561µs)","trace[2124978385] 'applied index is now lower than readState.Index'  (duration: 358.752096ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:42.575792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.024251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:19:42.575851Z","caller":"traceutil/trace.go:171","msg":"trace[607068242] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:931; }","duration":"359.103853ms","start":"2026-03-06T20:19:42.21671Z","end":"2026-03-06T20:19:42.575814Z","steps":["trace[607068242] 'agreement among raft nodes before linearized reading'  (duration: 358.96245ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:42.575883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:42.216687Z","time spent":"359.188006ms","remote":"127.0.0.1:39900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-03-06T20:19:42.862633Z","caller":"traceutil/trace.go:171","msg":"trace[1456455305] linearizableReadLoop","detail":"{readStateIndex:975; appliedIndex:974; }","duration":"112.643297ms","start":"2026-03-06T20:19:42.749958Z","end":"2026-03-06T20:19:42.862601Z","steps":["trace[1456455305] 'read index received'  (duration: 112.383671ms)","trace[1456455305] 'applied index is now lower than readState.Index'  (duration: 258.486µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:42.862799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.821482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:19:42.862851Z","caller":"traceutil/trace.go:171","msg":"trace[450214843] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:932; }","duration":"112.926824ms","start":"2026-03-06T20:19:42.749909Z","end":"2026-03-06T20:19:42.862835Z","steps":["trace[450214843] 'agreement among raft nodes before linearized reading'  (duration: 112.807822ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:42.862964Z","caller":"traceutil/trace.go:171","msg":"trace[398813544] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"206.104227ms","start":"2026-03-06T20:19:42.656827Z","end":"2026-03-06T20:19:42.862931Z","steps":["trace[398813544] 'process raft request'  (duration: 205.613865ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:43.70213Z","caller":"traceutil/trace.go:171","msg":"trace[546930055] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"101.135754ms","start":"2026-03-06T20:19:43.600957Z","end":"2026-03-06T20:19:43.702093Z","steps":["trace[546930055] 'process raft request'  (duration: 57.93012ms)","trace[546930055] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/plndr-svcs-lock; req_size:418; } (duration: 42.866807ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:43.703073Z","caller":"traceutil/trace.go:171","msg":"trace[692696773] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"101.281168ms","start":"2026-03-06T20:19:43.601731Z","end":"2026-03-06T20:19:43.703012Z","steps":["trace[692696773] 'process raft request'  (duration: 100.549052ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:44.585828Z","caller":"traceutil/trace.go:171","msg":"trace[1828410066] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:979; }","duration":"242.455016ms","start":"2026-03-06T20:19:44.343344Z","end":"2026-03-06T20:19:44.585799Z","steps":["trace[1828410066] 'read index received'  (duration: 242.147849ms)","trace[1828410066] 'applied index is now lower than readState.Index'  (duration: 305.987µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:44.585908Z","caller":"traceutil/trace.go:171","msg":"trace[1729199178] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"428.166358ms","start":"2026-03-06T20:19:44.157713Z","end":"2026-03-06T20:19:44.585879Z","steps":["trace[1729199178] 'process raft request'  (duration: 427.843521ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:44.586001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.63172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-06T20:19:44.586038Z","caller":"traceutil/trace.go:171","msg":"trace[909683440] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:937; }","duration":"242.731702ms","start":"2026-03-06T20:19:44.343296Z","end":"2026-03-06T20:19:44.586028Z","steps":["trace[909683440] 'agreement among raft nodes before linearized reading'  (duration: 242.61968ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:44.586132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:44.157693Z","time spent":"428.282861ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:918 > 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-03-06T20:19:44.890559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.84498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:19:44.890628Z","caller":"traceutil/trace.go:171","msg":"trace[373690640] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:937; }","duration":"140.975152ms","start":"2026-03-06T20:19:44.749635Z","end":"2026-03-06T20:19:44.890611Z","steps":["trace[373690640] 'range keys from in-memory index tree'  (duration: 140.708557ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:45.145062Z","caller":"traceutil/trace.go:171","msg":"trace[1062249112] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"250.828616ms","start":"2026-03-06T20:19:44.894162Z","end":"2026-03-06T20:19:45.144991Z","steps":["trace[1062249112] 'process raft request'  (duration: 250.632102ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:45.878485Z","caller":"traceutil/trace.go:171","msg":"trace[612426487] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:981; }","duration":"244.340758ms","start":"2026-03-06T20:19:45.634114Z","end":"2026-03-06T20:19:45.878455Z","steps":["trace[612426487] 'read index received'  (duration: 244.073422ms)","trace[612426487] 'applied index is now lower than readState.Index'  (duration: 266.166µs)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:45.878831Z","caller":"traceutil/trace.go:171","msg":"trace[227803224] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"297.207504ms","start":"2026-03-06T20:19:45.581606Z","end":"2026-03-06T20:19:45.878813Z","steps":["trace[227803224] 'process raft request'  (duration: 296.652461ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:45.87923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.103475ms","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-03-06T20:19:45.879291Z","caller":"traceutil/trace.go:171","msg":"trace[2089670841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:939; }","duration":"245.207628ms","start":"2026-03-06T20:19:45.634069Z","end":"2026-03-06T20:19:45.879276Z","steps":["trace[2089670841] 'agreement among raft nodes before linearized reading'  (duration: 245.018824ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:45.879559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.872993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T20:19:45.87961Z","caller":"traceutil/trace.go:171","msg":"trace[249275007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:939; }","duration":"173.964085ms","start":"2026-03-06T20:19:45.705634Z","end":"2026-03-06T20:19:45.879598Z","steps":["trace[249275007] 'agreement among raft nodes before linearized reading'  (duration: 173.840432ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:45.879885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.956432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:19:45.879944Z","caller":"traceutil/trace.go:171","msg":"trace[1844903076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:939; }","duration":"130.040345ms","start":"2026-03-06T20:19:45.749882Z","end":"2026-03-06T20:19:45.879923Z","steps":["trace[1844903076] 'agreement among raft nodes before linearized reading'  (duration: 129.964443ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:45.880322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.468153ms","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-03-06T20:19:45.880373Z","caller":"traceutil/trace.go:171","msg":"trace[288678654] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:939; }","duration":"173.562715ms","start":"2026-03-06T20:19:45.7068Z","end":"2026-03-06T20:19:45.880363Z","steps":["trace[288678654] 'agreement among raft nodes before linearized reading'  (duration: 173.425972ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:47.31209Z","caller":"traceutil/trace.go:171","msg":"trace[1655630250] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"108.238027ms","start":"2026-03-06T20:19:47.203831Z","end":"2026-03-06T20:19:47.312069Z","steps":["trace[1655630250] 'process raft request'  (duration: 41.948696ms)","trace[1655630250] 'compare'  (duration: 66.209739ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:47.855368Z","caller":"traceutil/trace.go:171","msg":"trace[1568687942] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"283.114353ms","start":"2026-03-06T20:19:47.572231Z","end":"2026-03-06T20:19:47.855345Z","steps":["trace[1568687942] 'process raft request'  (duration: 283.016891ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:49.252269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.368395937s","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-03-06T20:19:49.252401Z","caller":"traceutil/trace.go:171","msg":"trace[395441703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:946; }","duration":"1.368687603s","start":"2026-03-06T20:19:47.883677Z","end":"2026-03-06T20:19:49.252365Z","steps":["trace[395441703] 'range keys from in-memory index tree'  (duration: 1.368174932s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:49.252445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:47.883661Z","time spent":"1.368775255s","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-06T20:19:49.252537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.354567321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T20:19:49.252609Z","caller":"traceutil/trace.go:171","msg":"trace[1079489708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:946; }","duration":"1.354684364s","start":"2026-03-06T20:19:47.897905Z","end":"2026-03-06T20:19:49.252589Z","steps":["trace[1079489708] 'range keys from in-memory index tree'  (duration: 1.354286855s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:49.252983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:47.897888Z","time spent":"1.354743896s","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-06T20:19:49.253524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34438337s","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-03-06T20:19:49.253637Z","caller":"traceutil/trace.go:171","msg":"trace[1379127701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:946; }","duration":"1.344526734s","start":"2026-03-06T20:19:47.909097Z","end":"2026-03-06T20:19:49.253624Z","steps":["trace[1379127701] 'range keys from in-memory index tree'  (duration: 1.344236587s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:49.253706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:47.909083Z","time spent":"1.344614735s","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-06T20:19:49.25388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.823274ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812337626317122 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:901 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T20:19:49.253933Z","caller":"traceutil/trace.go:171","msg":"trace[1867842577] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:990; }","duration":"654.766363ms","start":"2026-03-06T20:19:48.599155Z","end":"2026-03-06T20:19:49.253921Z","steps":["trace[1867842577] 'read index received'  (duration: 497.939479ms)","trace[1867842577] 'applied index is now lower than readState.Index'  (duration: 156.826094ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:49.25404Z","caller":"traceutil/trace.go:171","msg":"trace[443128191] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"903.253286ms","start":"2026-03-06T20:19:48.350781Z","end":"2026-03-06T20:19:49.254034Z","steps":["trace[443128191] 'process raft request'  (duration: 746.221537ms)","trace[443128191] 'compare'  (duration: 154.818958ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:49.254075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:48.350756Z","time spent":"903.301226ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:901 > 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-03-06T20:19:49.254155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.009158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:19:49.254175Z","caller":"traceutil/trace.go:171","msg":"trace[1059422091] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:947; }","duration":"655.06374ms","start":"2026-03-06T20:19:48.599105Z","end":"2026-03-06T20:19:49.254169Z","steps":["trace[1059422091] 'agreement among raft nodes before linearized reading'  (duration: 655.033389ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:49.254189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:48.599086Z","time spent":"655.09999ms","remote":"127.0.0.1:39908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-03-06T20:19:49.254286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.216851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-06T20:19:49.253636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34440379s","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-03-06T20:19:49.254303Z","caller":"traceutil/trace.go:171","msg":"trace[674401632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:947; }","duration":"504.266883ms","start":"2026-03-06T20:19:48.750032Z","end":"2026-03-06T20:19:49.254299Z","steps":["trace[674401632] 'agreement among raft nodes before linearized reading'  (duration: 504.239942ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:49.254316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:48.750015Z","time spent":"504.298523ms","remote":"127.0.0.1:39410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-06T20:19:49.25432Z","caller":"traceutil/trace.go:171","msg":"trace[682052976] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:946; }","duration":"1.345167578s","start":"2026-03-06T20:19:47.909142Z","end":"2026-03-06T20:19:49.254309Z","steps":["trace[682052976] 'range keys from in-memory index tree'  (duration: 1.344286558s)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:49.25438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:47.90913Z","time spent":"1.345230399s","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-06T20:19:49.25456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.86168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-06T20:19:49.254589Z","caller":"traceutil/trace.go:171","msg":"trace[257540158] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:947; }","duration":"169.933552ms","start":"2026-03-06T20:19:49.084647Z","end":"2026-03-06T20:19:49.25458Z","steps":["trace[257540158] 'agreement among raft nodes before linearized reading'  (duration: 169.83742ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:49.906621Z","caller":"traceutil/trace.go:171","msg":"trace[2112531437] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"649.025662ms","start":"2026-03-06T20:19:49.257567Z","end":"2026-03-06T20:19:49.906593Z","steps":["trace[2112531437] 'process raft request'  (duration: 648.877609ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:49.907233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:49.257528Z","time spent":"649.263547ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:940 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-06T20:19:50.060469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.875278ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812337626317127 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:942 > 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-03-06T20:19:50.061418Z","caller":"traceutil/trace.go:171","msg":"trace[2105914155] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"803.786089ms","start":"2026-03-06T20:19:49.257597Z","end":"2026-03-06T20:19:50.061383Z","steps":["trace[2105914155] 'process raft request'  (duration: 655.758285ms)","trace[2105914155] 'compare'  (duration: 146.735085ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:50.061536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:49.25758Z","time spent":"803.908062ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:942 > 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-03-06T20:19:50.06222Z","caller":"traceutil/trace.go:171","msg":"trace[1260951945] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:992; }","duration":"471.195509ms","start":"2026-03-06T20:19:49.590832Z","end":"2026-03-06T20:19:50.062027Z","steps":["trace[1260951945] 'read index received'  (duration: 316.068584ms)","trace[1260951945] 'applied index is now lower than readState.Index'  (duration: 155.126115ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:50.062425Z","caller":"traceutil/trace.go:171","msg":"trace[833144127] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"804.790633ms","start":"2026-03-06T20:19:49.257625Z","end":"2026-03-06T20:19:50.062416Z","steps":["trace[833144127] 'process raft request'  (duration: 803.694197ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:50.062568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.230526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-06T20:19:50.062606Z","caller":"traceutil/trace.go:171","msg":"trace[920004815] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"804.950867ms","start":"2026-03-06T20:19:49.257632Z","end":"2026-03-06T20:19:50.062583Z","steps":["trace[920004815] 'process raft request'  (duration: 804.317201ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:50.062648Z","caller":"traceutil/trace.go:171","msg":"trace[2144385505] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"787.874067ms","start":"2026-03-06T20:19:49.274753Z","end":"2026-03-06T20:19:50.062627Z","steps":["trace[2144385505] 'process raft request'  (duration: 787.238631ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:50.062717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:49.257623Z","time spent":"805.041378ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:941 > 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-03-06T20:19:50.062621Z","caller":"traceutil/trace.go:171","msg":"trace[2144601631] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"312.313078ms","start":"2026-03-06T20:19:49.750294Z","end":"2026-03-06T20:19:50.062607Z","steps":["trace[2144601631] 'agreement among raft nodes before linearized reading'  (duration: 312.230286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:50.062759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:49.274736Z","time spent":"787.966579ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:939 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-06T20:19:50.062773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.880605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"}
{"level":"warn","ts":"2026-03-06T20:19:50.062845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:49.750272Z","time spent":"312.556354ms","remote":"127.0.0.1:39410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-06T20:19:50.062893Z","caller":"traceutil/trace.go:171","msg":"trace[613556212] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:952; }","duration":"472.071419ms","start":"2026-03-06T20:19:49.590796Z","end":"2026-03-06T20:19:50.062867Z","steps":["trace[613556212] 'agreement among raft nodes before linearized reading'  (duration: 471.68ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:50.062959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:49.590775Z","time spent":"472.173402ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-06T20:19:50.063209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:49.257517Z","time spent":"804.942366ms","remote":"127.0.0.1:39664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:944 > 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":"info","ts":"2026-03-06T20:19:53.308385Z","caller":"traceutil/trace.go:171","msg":"trace[1252864294] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"452.706886ms","start":"2026-03-06T20:19:52.855648Z","end":"2026-03-06T20:19:53.308355Z","steps":["trace[1252864294] 'process raft request'  (duration: 378.180149ms)","trace[1252864294] 'compare'  (duration: 74.378154ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:19:53.308695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:52.855631Z","time spent":"452.84897ms","remote":"127.0.0.1:39678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-pr5rt\" mod_revision:795 > success:<request_put:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-pr5rt\" value_size:1433 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-pr5rt\" > >"}
{"level":"info","ts":"2026-03-06T20:19:53.315553Z","caller":"traceutil/trace.go:171","msg":"trace[1766567534] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1027; }","duration":"196.697122ms","start":"2026-03-06T20:19:53.118828Z","end":"2026-03-06T20:19:53.315526Z","steps":["trace[1766567534] 'read index received'  (duration: 114.9654ms)","trace[1766567534] 'applied index is now lower than readState.Index'  (duration: 81.730892ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:19:53.315756Z","caller":"traceutil/trace.go:171","msg":"trace[1811457092] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"458.642213ms","start":"2026-03-06T20:19:52.857095Z","end":"2026-03-06T20:19:53.315737Z","steps":["trace[1811457092] 'process raft request'  (duration: 458.216764ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:19:53.315771Z","caller":"traceutil/trace.go:171","msg":"trace[165600737] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"454.58602ms","start":"2026-03-06T20:19:52.861133Z","end":"2026-03-06T20:19:53.315719Z","steps":["trace[165600737] 'process raft request'  (duration: 454.326254ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:19:53.315858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:52.857076Z","time spent":"458.726585ms","remote":"127.0.0.1:39564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" mod_revision:794 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" value_size:840 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" > >"}
{"level":"warn","ts":"2026-03-06T20:19:53.315965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-06T20:19:52.861124Z","time spent":"454.756523ms","remote":"127.0.0.1:39894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10921,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" mod_revision:819 > success:<request_put:<key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" value_size:10845 >> failure:<request_range:<key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-69cb97fb6\" > >"}
{"level":"warn","ts":"2026-03-06T20:19:53.315713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.847426ms","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-03-06T20:19:53.316546Z","caller":"traceutil/trace.go:171","msg":"trace[1973600955] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:985; }","duration":"197.714656ms","start":"2026-03-06T20:19:53.118814Z","end":"2026-03-06T20:19:53.316528Z","steps":["trace[1973600955] 'agreement among raft nodes before linearized reading'  (duration: 196.805476ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:21:10.922577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.949995ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812337626318000 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1296 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-06T20:21:10.922935Z","caller":"traceutil/trace.go:171","msg":"trace[1030922257] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"178.536803ms","start":"2026-03-06T20:21:10.744372Z","end":"2026-03-06T20:21:10.922909Z","steps":["trace[1030922257] 'process raft request'  (duration: 55.137128ms)","trace[1030922257] 'compare'  (duration: 122.850813ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:21:11.123427Z","caller":"traceutil/trace.go:171","msg":"trace[1189839784] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"121.356751ms","start":"2026-03-06T20:21:11.002048Z","end":"2026-03-06T20:21:11.123405Z","steps":["trace[1189839784] 'process raft request'  (duration: 121.237978ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:21:18.721803Z","caller":"traceutil/trace.go:171","msg":"trace[1898342971] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"120.86604ms","start":"2026-03-06T20:21:18.600905Z","end":"2026-03-06T20:21:18.721771Z","steps":["trace[1898342971] 'process raft request'  (duration: 120.666345ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:23:07.196865Z","caller":"traceutil/trace.go:171","msg":"trace[2002724754] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"162.293654ms","start":"2026-03-06T20:23:07.03454Z","end":"2026-03-06T20:23:07.196833Z","steps":["trace[2002724754] 'process raft request'  (duration: 83.04905ms)","trace[2002724754] 'compare'  (duration: 79.06961ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:23:07.196855Z","caller":"traceutil/trace.go:171","msg":"trace[1104588597] linearizableReadLoop","detail":"{readStateIndex:1892; appliedIndex:1891; }","duration":"140.404677ms","start":"2026-03-06T20:23:07.056422Z","end":"2026-03-06T20:23:07.196826Z","steps":["trace[1104588597] 'read index received'  (duration: 61.131042ms)","trace[1104588597] 'applied index is now lower than readState.Index'  (duration: 79.272205ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:23:07.197119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.684953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-06T20:23:07.197173Z","caller":"traceutil/trace.go:171","msg":"trace[539237535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1807; }","duration":"140.798495ms","start":"2026-03-06T20:23:07.056365Z","end":"2026-03-06T20:23:07.197163Z","steps":["trace[539237535] 'agreement among raft nodes before linearized reading'  (duration: 140.55216ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:23:07.457456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.027373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-06T20:23:07.457526Z","caller":"traceutil/trace.go:171","msg":"trace[146816983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1808; }","duration":"129.159726ms","start":"2026-03-06T20:23:07.32835Z","end":"2026-03-06T20:23:07.45751Z","steps":["trace[146816983] 'range keys from in-memory index tree'  (duration: 128.84707ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:23:07.988559Z","caller":"traceutil/trace.go:171","msg":"trace[48566677] linearizableReadLoop","detail":"{readStateIndex:1898; appliedIndex:1897; }","duration":"147.783301ms","start":"2026-03-06T20:23:07.840756Z","end":"2026-03-06T20:23:07.98854Z","steps":["trace[48566677] 'read index received'  (duration: 147.600617ms)","trace[48566677] 'applied index is now lower than readState.Index'  (duration: 181.854µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:23:07.988769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.996275ms","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:532"}
{"level":"info","ts":"2026-03-06T20:23:07.988806Z","caller":"traceutil/trace.go:171","msg":"trace[221784613] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1813; }","duration":"148.067157ms","start":"2026-03-06T20:23:07.840729Z","end":"2026-03-06T20:23:07.988796Z","steps":["trace[221784613] 'agreement among raft nodes before linearized reading'  (duration: 147.930294ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-06T20:23:07.989025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.521275ms","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-03-06T20:23:07.989086Z","caller":"traceutil/trace.go:171","msg":"trace[916018851] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1813; }","duration":"116.603396ms","start":"2026-03-06T20:23:07.872472Z","end":"2026-03-06T20:23:07.989075Z","steps":["trace[916018851] 'agreement among raft nodes before linearized reading'  (duration: 116.495894ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:23:07.988621Z","caller":"traceutil/trace.go:171","msg":"trace[1667811346] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"224.046389ms","start":"2026-03-06T20:23:07.764537Z","end":"2026-03-06T20:23:07.988583Z","steps":["trace[1667811346] 'process raft request'  (duration: 223.902875ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:23:33.808164Z","caller":"traceutil/trace.go:171","msg":"trace[1173278704] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"112.445988ms","start":"2026-03-06T20:23:33.695683Z","end":"2026-03-06T20:23:33.808129Z","steps":["trace[1173278704] 'process raft request'  (duration: 67.757723ms)","trace[1173278704] 'compare'  (duration: 44.529662ms)"],"step_count":2}
{"level":"info","ts":"2026-03-06T20:23:33.808286Z","caller":"traceutil/trace.go:171","msg":"trace[418606798] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"110.512257ms","start":"2026-03-06T20:23:33.697762Z","end":"2026-03-06T20:23:33.808275Z","steps":["trace[418606798] 'process raft request'  (duration: 110.354493ms)"],"step_count":1}
{"level":"info","ts":"2026-03-06T20:23:33.808181Z","caller":"traceutil/trace.go:171","msg":"trace[1637883291] linearizableReadLoop","detail":"{readStateIndex:2014; appliedIndex:2013; }","duration":"112.139762ms","start":"2026-03-06T20:23:33.696018Z","end":"2026-03-06T20:23:33.808157Z","steps":["trace[1637883291] 'read index received'  (duration: 67.432747ms)","trace[1637883291] 'applied index is now lower than readState.Index'  (duration: 44.705985ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-06T20:23:33.808419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.387497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-06T20:23:33.808501Z","caller":"traceutil/trace.go:171","msg":"trace[605107946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1925; }","duration":"112.51334ms","start":"2026-03-06T20:23:33.695969Z","end":"2026-03-06T20:23:33.808482Z","steps":["trace[605107946] 'agreement among raft nodes before linearized reading'  (duration: 112.273995ms)"],"step_count":1}