{"level":"warn","ts":"2026-03-08T13:19:00.553899Z","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-08T13:19:00.554024Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-08T13:19:00.554106Z","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-08T13:19:00.554122Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-03-08T13:19:00.554139Z","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-08T13:19:00.554843Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]}
{"level":"info","ts":"2026-03-08T13:19:00.554916Z","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://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-08T13:19:00.559676Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.522365ms"}
{"level":"info","ts":"2026-03-08T13:19:00.572003Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"}
{"level":"info","ts":"2026-03-08T13:19:00.572085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"}
{"level":"info","ts":"2026-03-08T13:19:00.572114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"}
{"level":"info","ts":"2026-03-08T13:19:00.572137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-08T13:19:00.572146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"}
{"level":"info","ts":"2026-03-08T13:19:00.572199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"warn","ts":"2026-03-08T13:19:00.580301Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-08T13:19:00.58151Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-08T13:19:00.582551Z","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-08T13:19:00.584731Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-08T13:19:00.584935Z","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-08T13:19:00.58484Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-08T13:19:00.58551Z","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-08T13:19:00.58554Z","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-08T13:19:00.586865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"info","ts":"2026-03-08T13:19:00.587765Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-03-08T13:19:00.589689Z","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-08T13:19:00.589871Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-03-08T13:19:00.589909Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-03-08T13:19:00.593366Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-08T13:19:00.593415Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-08T13:19:01.373242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"}
{"level":"info","ts":"2026-03-08T13:19:01.373317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-08T13:19:01.373361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"}
{"level":"info","ts":"2026-03-08T13:19:01.373384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"}
{"level":"info","ts":"2026-03-08T13:19:01.373395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-03-08T13:19:01.373414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"}
{"level":"info","ts":"2026-03-08T13:19:01.373436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-03-08T13:19:01.374774Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-08T13:19:01.375926Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-08T13:19:01.376002Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-08T13:19:01.376264Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-08T13:19:01.376329Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-08T13:19:01.376392Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-08T13:19:01.376818Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-08T13:19:01.376944Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-08T13:19:01.376972Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-08T13:19:01.379647Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-08T13:19:01.379779Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"}
{"level":"warn","ts":"2026-03-08T13:19:18.977158Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449472942,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-08T13:19:18.983903Z","caller":"traceutil/trace.go:171","msg":"trace[1004603619] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"506.990389ms","start":"2026-03-08T13:19:18.476884Z","end":"2026-03-08T13:19:18.983874Z","steps":["trace[1004603619] 'read index received'  (duration: 506.744341ms)","trace[1004603619] 'applied index is now lower than readState.Index'  (duration: 244.978µs)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:19:18.984028Z","caller":"traceutil/trace.go:171","msg":"trace[1277971050] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"716.822438ms","start":"2026-03-08T13:19:18.267164Z","end":"2026-03-08T13:19:18.983986Z","steps":["trace[1277971050] 'process raft request'  (duration: 716.531299ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:19:18.984124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.211357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-08T13:19:18.984206Z","caller":"traceutil/trace.go:171","msg":"trace[1635775291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:418; }","duration":"507.355701ms","start":"2026-03-08T13:19:18.476826Z","end":"2026-03-08T13:19:18.984181Z","steps":["trace[1635775291] 'agreement among raft nodes before linearized reading'  (duration: 507.228707ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:19:18.984269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:19:18.476801Z","time spent":"507.457184ms","remote":"127.0.0.1:34680","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-08T13:19:18.991606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.919175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:19:18.992518Z","caller":"traceutil/trace.go:171","msg":"trace[1860766873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:418; }","duration":"392.128727ms","start":"2026-03-08T13:19:18.600366Z","end":"2026-03-08T13:19:18.992495Z","steps":["trace[1860766873] 'agreement among raft nodes before linearized reading'  (duration: 383.883924ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:19:18.992591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:19:18.600323Z","time spent":"392.244361ms","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-08T13:19:18.992899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:19:18.267131Z","time spent":"716.960973ms","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/coredns\" mod_revision:389 > success:<request_put:<key:\"/registry/deployments/kube-system/coredns\" value_size:4131 >> failure:<request_range:<key:\"/registry/deployments/kube-system/coredns\" > >"}
{"level":"warn","ts":"2026-03-08T13:19:19.359343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.894737ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198175449472947 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/replicasets/kube-system/coredns-67659f764b\" mod_revision:0 > success:<request_put:<key:\"/registry/replicasets/kube-system/coredns-67659f764b\" value_size:3618 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-08T13:19:19.359881Z","caller":"traceutil/trace.go:171","msg":"trace[1124546206] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"357.770849ms","start":"2026-03-08T13:19:19.002072Z","end":"2026-03-08T13:19:19.359843Z","steps":["trace[1124546206] 'process raft request'  (duration: 169.146838ms)","trace[1124546206] 'compare'  (duration: 187.678701ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:19:19.359974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.363207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-08T13:19:19.360057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:19:19.002026Z","time spent":"357.936724ms","remote":"127.0.0.1:34904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3678,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/coredns-67659f764b\" mod_revision:0 > success:<request_put:<key:\"/registry/replicasets/kube-system/coredns-67659f764b\" value_size:3618 >> failure:<>"}
{"level":"info","ts":"2026-03-08T13:19:19.360078Z","caller":"traceutil/trace.go:171","msg":"trace[156608363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:420; }","duration":"241.522113ms","start":"2026-03-08T13:19:19.118527Z","end":"2026-03-08T13:19:19.360049Z","steps":["trace[156608363] 'agreement among raft nodes before linearized reading'  (duration: 241.314466ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:19:19.368984Z","caller":"traceutil/trace.go:171","msg":"trace[139497521] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"358.756549ms","start":"2026-03-08T13:19:19.010177Z","end":"2026-03-08T13:19:19.368934Z","steps":["trace[139497521] 'process raft request'  (duration: 349.306008ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:19:19.369213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:19:19.010142Z","time spent":"358.946825ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:412 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-08T13:19:19.370067Z","caller":"traceutil/trace.go:171","msg":"trace[1993782340] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:428; }","duration":"251.4683ms","start":"2026-03-08T13:19:19.118577Z","end":"2026-03-08T13:19:19.370046Z","steps":["trace[1993782340] 'read index received'  (duration: 52.636153ms)","trace[1993782340] 'applied index is now lower than readState.Index'  (duration: 198.829757ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:19:40.834276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.087231ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198175449473178 > lease_revoke:<id:7edf9ccd99e3dff5>","response":"size:27"}
{"level":"info","ts":"2026-03-08T13:19:40.834476Z","caller":"traceutil/trace.go:171","msg":"trace[337908165] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:548; }","duration":"545.215041ms","start":"2026-03-08T13:19:40.289191Z","end":"2026-03-08T13:19:40.834406Z","steps":["trace[337908165] 'read index received'  (duration: 64.982µs)","trace[337908165] 'applied index is now lower than readState.Index'  (duration: 545.148089ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:19:40.835351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.12314ms","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-08T13:19:40.83549Z","caller":"traceutil/trace.go:171","msg":"trace[533493412] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:534; }","duration":"546.324516ms","start":"2026-03-08T13:19:40.289137Z","end":"2026-03-08T13:19:40.835461Z","steps":["trace[533493412] 'agreement among raft nodes before linearized reading'  (duration: 545.324354ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:19:40.835549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:19:40.289113Z","time spent":"546.42536ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-08T13:19:42.718558Z","caller":"traceutil/trace.go:171","msg":"trace[1596884055] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"169.732927ms","start":"2026-03-08T13:19:42.548796Z","end":"2026-03-08T13:19:42.718529Z","steps":["trace[1596884055] 'process raft request'  (duration: 169.588712ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:19:57.911745Z","caller":"traceutil/trace.go:171","msg":"trace[2088782] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"125.72319ms","start":"2026-03-08T13:19:57.785992Z","end":"2026-03-08T13:19:57.911715Z","steps":["trace[2088782] 'process raft request'  (duration: 125.545514ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:19:57.920409Z","caller":"traceutil/trace.go:171","msg":"trace[1470017199] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"133.933722ms","start":"2026-03-08T13:19:57.786459Z","end":"2026-03-08T13:19:57.920393Z","steps":["trace[1470017199] 'process raft request'  (duration: 133.852569ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:00.747632Z","caller":"traceutil/trace.go:171","msg":"trace[1484680210] linearizableReadLoop","detail":"{readStateIndex:743; appliedIndex:742; }","duration":"148.797397ms","start":"2026-03-08T13:20:00.598803Z","end":"2026-03-08T13:20:00.7476Z","steps":["trace[1484680210] 'read index received'  (duration: 148.550779ms)","trace[1484680210] 'applied index is now lower than readState.Index'  (duration: 245.578µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:00.747754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.939891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:20:00.747788Z","caller":"traceutil/trace.go:171","msg":"trace[728294655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:722; }","duration":"149.020453ms","start":"2026-03-08T13:20:00.598755Z","end":"2026-03-08T13:20:00.747776Z","steps":["trace[728294655] 'agreement among raft nodes before linearized reading'  (duration: 148.953941ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:00.747807Z","caller":"traceutil/trace.go:171","msg":"trace[1642871225] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"193.079942ms","start":"2026-03-08T13:20:00.554647Z","end":"2026-03-08T13:20:00.747727Z","steps":["trace[1642871225] 'process raft request'  (duration: 192.769242ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:01.472996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.43502ms","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-08T13:20:01.473102Z","caller":"traceutil/trace.go:171","msg":"trace[1814799427] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:722; }","duration":"520.596034ms","start":"2026-03-08T13:20:00.952475Z","end":"2026-03-08T13:20:01.473071Z","steps":["trace[1814799427] 'range keys from in-memory index tree'  (duration: 520.175401ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:01.47315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:00.952452Z","time spent":"520.688787ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-08T13:20:01.829027Z","caller":"traceutil/trace.go:171","msg":"trace[1267040941] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"352.703877ms","start":"2026-03-08T13:20:01.4763Z","end":"2026-03-08T13:20:01.829004Z","steps":["trace[1267040941] 'process raft request'  (duration: 352.50375ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:01.82917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:01.476284Z","time spent":"352.802749ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:718 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-08T13:20:01.82915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.275828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:20:01.829232Z","caller":"traceutil/trace.go:171","msg":"trace[658864908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:723; }","duration":"228.374312ms","start":"2026-03-08T13:20:01.600844Z","end":"2026-03-08T13:20:01.829218Z","steps":["trace[658864908] 'agreement among raft nodes before linearized reading'  (duration: 228.245457ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:01.829048Z","caller":"traceutil/trace.go:171","msg":"trace[1678358510] linearizableReadLoop","detail":"{readStateIndex:744; appliedIndex:743; }","duration":"228.121843ms","start":"2026-03-08T13:20:01.600858Z","end":"2026-03-08T13:20:01.82898Z","steps":["trace[1678358510] 'read index received'  (duration: 228.005489ms)","trace[1678358510] 'applied index is now lower than readState.Index'  (duration: 114.944µs)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:20:01.911765Z","caller":"traceutil/trace.go:171","msg":"trace[1804153042] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"172.087642ms","start":"2026-03-08T13:20:01.739646Z","end":"2026-03-08T13:20:01.911734Z","steps":["trace[1804153042] 'process raft request'  (duration: 150.348277ms)","trace[1804153042] 'compare'  (duration: 21.550959ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:01.912047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.545207ms","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-08T13:20:01.91216Z","caller":"traceutil/trace.go:171","msg":"trace[785501444] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:724; }","duration":"116.704971ms","start":"2026-03-08T13:20:01.795427Z","end":"2026-03-08T13:20:01.912131Z","steps":["trace[785501444] 'agreement among raft nodes before linearized reading'  (duration: 116.34626ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:02.125484Z","caller":"traceutil/trace.go:171","msg":"trace[1433915184] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"187.544475ms","start":"2026-03-08T13:20:01.937902Z","end":"2026-03-08T13:20:02.125446Z","steps":["trace[1433915184] 'process raft request'  (duration: 120.226813ms)","trace[1433915184] 'compare'  (duration: 67.195078ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:20:02.859186Z","caller":"traceutil/trace.go:171","msg":"trace[759874682] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"100.482382ms","start":"2026-03-08T13:20:02.758677Z","end":"2026-03-08T13:20:02.859159Z","steps":["trace[759874682] 'process raft request'  (duration: 100.351738ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:03.739408Z","caller":"traceutil/trace.go:171","msg":"trace[1666471553] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:752; }","duration":"139.83218ms","start":"2026-03-08T13:20:03.599551Z","end":"2026-03-08T13:20:03.739383Z","steps":["trace[1666471553] 'read index received'  (duration: 139.689946ms)","trace[1666471553] 'applied index is now lower than readState.Index'  (duration: 141.244µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:03.739548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.973955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:20:03.739577Z","caller":"traceutil/trace.go:171","msg":"trace[2114874892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:732; }","duration":"140.042527ms","start":"2026-03-08T13:20:03.599525Z","end":"2026-03-08T13:20:03.739567Z","steps":["trace[2114874892] 'agreement among raft nodes before linearized reading'  (duration: 139.952594ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:03.73954Z","caller":"traceutil/trace.go:171","msg":"trace[1525721191] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"176.537104ms","start":"2026-03-08T13:20:03.562964Z","end":"2026-03-08T13:20:03.739502Z","steps":["trace[1525721191] 'process raft request'  (duration: 176.280756ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:26.529572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.70604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-08T13:20:26.529675Z","caller":"traceutil/trace.go:171","msg":"trace[664793673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"283.824524ms","start":"2026-03-08T13:20:26.245826Z","end":"2026-03-08T13:20:26.52965Z","steps":["trace[664793673] 'range keys from in-memory index tree'  (duration: 283.435302ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:26.529734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.622869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-08T13:20:26.529805Z","caller":"traceutil/trace.go:171","msg":"trace[884914296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:798; }","duration":"365.748413ms","start":"2026-03-08T13:20:26.164041Z","end":"2026-03-08T13:20:26.529789Z","steps":["trace[884914296] 'range keys from in-memory index tree'  (duration: 365.436933ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:26.529787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.895353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-08T13:20:26.529847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:26.164023Z","time spent":"365.817426ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-08T13:20:26.529863Z","caller":"traceutil/trace.go:171","msg":"trace[2761686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"328.028477ms","start":"2026-03-08T13:20:26.201816Z","end":"2026-03-08T13:20:26.529845Z","steps":["trace[2761686] 'range keys from in-memory index tree'  (duration: 327.711597ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:26.529904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:26.20179Z","time spent":"328.104499ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-08T13:20:26.673079Z","caller":"traceutil/trace.go:171","msg":"trace[591527843] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"136.509345ms","start":"2026-03-08T13:20:26.536538Z","end":"2026-03-08T13:20:26.673048Z","steps":["trace[591527843] 'process raft request'  (duration: 136.37474ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:26.673087Z","caller":"traceutil/trace.go:171","msg":"trace[1959401540] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"137.423934ms","start":"2026-03-08T13:20:26.535622Z","end":"2026-03-08T13:20:26.673046Z","steps":["trace[1959401540] 'process raft request'  (duration: 111.512615ms)","trace[1959401540] 'compare'  (duration: 25.63945ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:28.594146Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449473765,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-08T13:20:28.668258Z","caller":"traceutil/trace.go:171","msg":"trace[1750058013] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"574.791527ms","start":"2026-03-08T13:20:28.093449Z","end":"2026-03-08T13:20:28.66824Z","steps":["trace[1750058013] 'read index received'  (duration: 574.635092ms)","trace[1750058013] 'applied index is now lower than readState.Index'  (duration: 155.535µs)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:20:28.668475Z","caller":"traceutil/trace.go:171","msg":"trace[1850242938] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"720.32138ms","start":"2026-03-08T13:20:27.948141Z","end":"2026-03-08T13:20:28.668463Z","steps":["trace[1850242938] 'process raft request'  (duration: 719.965028ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:28.668692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:27.948112Z","time spent":"720.433894ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:775 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-08T13:20:28.669148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.674805ms","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-08T13:20:28.669238Z","caller":"traceutil/trace.go:171","msg":"trace[189325341] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:803; }","duration":"575.82528ms","start":"2026-03-08T13:20:28.093392Z","end":"2026-03-08T13:20:28.669217Z","steps":["trace[189325341] 'agreement among raft nodes before linearized reading'  (duration: 575.51717ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:28.669289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:28.09337Z","time spent":"575.909433ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-08T13:20:28.8938Z","caller":"traceutil/trace.go:171","msg":"trace[788403695] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"219.467116ms","start":"2026-03-08T13:20:28.674308Z","end":"2026-03-08T13:20:28.893775Z","steps":["trace[788403695] 'process raft request'  (duration: 219.310801ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:28.909794Z","caller":"traceutil/trace.go:171","msg":"trace[710989607] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:829; }","duration":"233.077952ms","start":"2026-03-08T13:20:28.676693Z","end":"2026-03-08T13:20:28.909771Z","steps":["trace[710989607] 'read index received'  (duration: 216.987127ms)","trace[710989607] 'applied index is now lower than readState.Index'  (duration: 16.089715ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:20:28.909831Z","caller":"traceutil/trace.go:171","msg":"trace[1842142348] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"235.21435ms","start":"2026-03-08T13:20:28.674594Z","end":"2026-03-08T13:20:28.909808Z","steps":["trace[1842142348] 'process raft request'  (duration: 235.058825ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:28.910132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.409902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"warn","ts":"2026-03-08T13:20:28.910147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.376312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-08T13:20:28.910218Z","caller":"traceutil/trace.go:171","msg":"trace[1469426816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:805; }","duration":"233.534286ms","start":"2026-03-08T13:20:28.67666Z","end":"2026-03-08T13:20:28.910194Z","steps":["trace[1469426816] 'agreement among raft nodes before linearized reading'  (duration: 233.271598ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:28.910212Z","caller":"traceutil/trace.go:171","msg":"trace[771642898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:805; }","duration":"233.475744ms","start":"2026-03-08T13:20:28.676722Z","end":"2026-03-08T13:20:28.910198Z","steps":["trace[771642898] 'agreement among raft nodes before linearized reading'  (duration: 233.291618ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:31.114717Z","caller":"traceutil/trace.go:171","msg":"trace[2070091438] linearizableReadLoop","detail":"{readStateIndex:836; appliedIndex:835; }","duration":"200.651305ms","start":"2026-03-08T13:20:30.914042Z","end":"2026-03-08T13:20:31.114694Z","steps":["trace[2070091438] 'read index received'  (duration: 200.414508ms)","trace[2070091438] 'applied index is now lower than readState.Index'  (duration: 235.517µs)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:20:31.11484Z","caller":"traceutil/trace.go:171","msg":"trace[848340177] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"207.06231ms","start":"2026-03-08T13:20:30.907756Z","end":"2026-03-08T13:20:31.114818Z","steps":["trace[848340177] 'process raft request'  (duration: 206.795702ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:31.11513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.973955ms","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-08T13:20:31.115486Z","caller":"traceutil/trace.go:171","msg":"trace[312990863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:809; }","duration":"109.372497ms","start":"2026-03-08T13:20:31.006103Z","end":"2026-03-08T13:20:31.115475Z","steps":["trace[312990863] 'agreement among raft nodes before linearized reading'  (duration: 108.879721ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:31.115144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.41329ms","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-08T13:20:31.115714Z","caller":"traceutil/trace.go:171","msg":"trace[502168649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:809; }","duration":"192.03421ms","start":"2026-03-08T13:20:30.923671Z","end":"2026-03-08T13:20:31.115706Z","steps":["trace[502168649] 'agreement among raft nodes before linearized reading'  (duration: 191.304346ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:31.115122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.065869ms","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-08T13:20:31.115881Z","caller":"traceutil/trace.go:171","msg":"trace[110282394] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"201.887165ms","start":"2026-03-08T13:20:30.913985Z","end":"2026-03-08T13:20:31.115873Z","steps":["trace[110282394] 'agreement among raft nodes before linearized reading'  (duration: 200.838531ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:39.137135Z","caller":"traceutil/trace.go:171","msg":"trace[1623447125] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"136.482273ms","start":"2026-03-08T13:20:39.000627Z","end":"2026-03-08T13:20:39.137109Z","steps":["trace[1623447125] 'process raft request'  (duration: 136.317058ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:45.876776Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449473989,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:20:46.377177Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449473989,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:20:46.877905Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449473989,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:20:47.378758Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449473989,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:20:47.601477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000399935s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-08T13:20:47.601638Z","caller":"traceutil/trace.go:171","msg":"trace[1013260624] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00059369s","start":"2026-03-08T13:20:45.60102Z","end":"2026-03-08T13:20:47.601613Z","steps":["trace[1013260624] 'agreement among raft nodes before linearized reading'  (duration: 2.000412484s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:47.601691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:45.601007Z","time spent":"2.000672473s","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/08 13:20:47 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-08T13:20:47.879858Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449473989,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:20:48.380904Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449473989,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:20:48.735179Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.365805818s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-08T13:20:48.735539Z","caller":"traceutil/trace.go:171","msg":"trace[1409494046] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:931; }","duration":"3.359237798s","start":"2026-03-08T13:20:45.37627Z","end":"2026-03-08T13:20:48.735507Z","steps":["trace[1409494046] 'read index received'  (duration: 3.359018151s)","trace[1409494046] 'applied index is now lower than readState.Index'  (duration: 218.277µs)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:20:48.73586Z","caller":"traceutil/trace.go:171","msg":"trace[487793477] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"3.366552082s","start":"2026-03-08T13:20:45.369292Z","end":"2026-03-08T13:20:48.735844Z","steps":["trace[487793477] 'process raft request'  (duration: 3.366049696s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:48.735994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:45.369276Z","time spent":"3.366634894s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:893 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-08T13:20:48.736363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.360088305s","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-08T13:20:48.736429Z","caller":"traceutil/trace.go:171","msg":"trace[1765667157] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:900; }","duration":"3.360195508s","start":"2026-03-08T13:20:45.376213Z","end":"2026-03-08T13:20:48.736408Z","steps":["trace[1765667157] 'agreement among raft nodes before linearized reading'  (duration: 3.359988082s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:20:48.736471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:45.376197Z","time spent":"3.360263601s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-08T13:20:48.801455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.251650967s","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-08T13:20:48.801531Z","caller":"traceutil/trace.go:171","msg":"trace[322827104] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:900; }","duration":"1.251788332s","start":"2026-03-08T13:20:47.54972Z","end":"2026-03-08T13:20:48.801508Z","steps":["trace[322827104] 'agreement among raft nodes before linearized reading'  (duration: 1.187049182s)","trace[322827104] 'count revisions from in-memory index tree'  (duration: 64.618466ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:48.801572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:47.5497Z","time spent":"1.251861974s","remote":"127.0.0.1:34922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-03-08T13:20:48.801626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.002474191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:20:48.801735Z","caller":"traceutil/trace.go:171","msg":"trace[332585786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:900; }","duration":"2.002641746s","start":"2026-03-08T13:20:46.799064Z","end":"2026-03-08T13:20:48.801705Z","steps":["trace[332585786] 'agreement among raft nodes before linearized reading'  (duration: 1.93771422s)","trace[332585786] 'range keys from in-memory index tree'  (duration: 64.770141ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:48.801794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:46.799043Z","time spent":"2.002740069s","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-08T13:20:48.80186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.424621789s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-08T13:20:48.801891Z","caller":"traceutil/trace.go:171","msg":"trace[1651195429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:900; }","duration":"3.42465934s","start":"2026-03-08T13:20:45.377222Z","end":"2026-03-08T13:20:48.801882Z","steps":["trace[1651195429] 'agreement among raft nodes before linearized reading'  (duration: 3.359424214s)","trace[1651195429] 'range keys from in-memory index tree'  (duration: 65.121972ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:48.801914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:45.377217Z","time spent":"3.42469032s","remote":"127.0.0.1:34680","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-08T13:20:48.801969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.554288063s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:20:48.802034Z","caller":"traceutil/trace.go:171","msg":"trace[501504180] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:900; }","duration":"2.554382846s","start":"2026-03-08T13:20:46.247639Z","end":"2026-03-08T13:20:48.802021Z","steps":["trace[501504180] 'agreement among raft nodes before linearized reading'  (duration: 2.48914782s)","trace[501504180] 'count revisions from in-memory index tree'  (duration: 65.156693ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:48.802057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.072608703s","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":"warn","ts":"2026-03-08T13:20:48.80207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:46.247589Z","time spent":"2.554471518s","remote":"127.0.0.1:34560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"info","ts":"2026-03-08T13:20:48.802089Z","caller":"traceutil/trace.go:171","msg":"trace[1119949590] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:900; }","duration":"1.072668555s","start":"2026-03-08T13:20:47.72941Z","end":"2026-03-08T13:20:48.802079Z","steps":["trace[1119949590] 'agreement among raft nodes before linearized reading'  (duration: 1.007338406s)","trace[1119949590] 'count revisions from in-memory index tree'  (duration: 65.288598ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:48.802122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:47.729393Z","time spent":"1.072719426s","remote":"127.0.0.1:34868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-03-08T13:20:48.802268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.200720329s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:20:48.802288Z","caller":"traceutil/trace.go:171","msg":"trace[1814684919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:900; }","duration":"1.200783821s","start":"2026-03-08T13:20:47.601498Z","end":"2026-03-08T13:20:48.802282Z","steps":["trace[1814684919] 'agreement among raft nodes before linearized reading'  (duration: 1.135262096s)","trace[1814684919] 'range keys from in-memory index tree'  (duration: 65.491594ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:48.80231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:47.601463Z","time spent":"1.200838753s","remote":"127.0.0.1:34416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-08T13:20:48.802558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.420662552s","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-08T13:20:48.802602Z","caller":"traceutil/trace.go:171","msg":"trace[882520867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:900; }","duration":"3.420728234s","start":"2026-03-08T13:20:45.381857Z","end":"2026-03-08T13:20:48.802585Z","steps":["trace[882520867] 'agreement among raft nodes before linearized reading'  (duration: 3.354938651s)","trace[882520867] 'range keys from in-memory index tree'  (duration: 65.651869ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:48.802635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:45.38184Z","time spent":"3.420787666s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-08T13:20:48.802753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.420934181s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-08T13:20:48.802783Z","caller":"traceutil/trace.go:171","msg":"trace[2079234967] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:900; }","duration":"3.420973192s","start":"2026-03-08T13:20:45.381801Z","end":"2026-03-08T13:20:48.802774Z","steps":["trace[2079234967] 'agreement among raft nodes before linearized reading'  (duration: 3.355003083s)","trace[2079234967] 'range keys from in-memory index tree'  (duration: 65.892167ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:48.802804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:20:45.381796Z","time spent":"3.421003983s","remote":"127.0.0.1:34680","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-08T13:20:59.012727Z","caller":"traceutil/trace.go:171","msg":"trace[1370463476] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:964; }","duration":"146.333368ms","start":"2026-03-08T13:20:58.866375Z","end":"2026-03-08T13:20:59.012709Z","steps":["trace[1370463476] 'read index received'  (duration: 142.837857ms)","trace[1370463476] 'applied index is now lower than readState.Index'  (duration: 3.494581ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:20:59.01289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.443562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-08T13:20:59.012891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.504504ms","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-08T13:20:59.012906Z","caller":"traceutil/trace.go:171","msg":"trace[1930496722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:931; }","duration":"146.483803ms","start":"2026-03-08T13:20:58.866417Z","end":"2026-03-08T13:20:59.012901Z","steps":["trace[1930496722] 'agreement among raft nodes before linearized reading'  (duration: 146.39214ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:59.012923Z","caller":"traceutil/trace.go:171","msg":"trace[730969397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:931; }","duration":"146.611047ms","start":"2026-03-08T13:20:58.866301Z","end":"2026-03-08T13:20:59.012913Z","steps":["trace[730969397] 'agreement among raft nodes before linearized reading'  (duration: 146.501843ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:20:59.012985Z","caller":"traceutil/trace.go:171","msg":"trace[1769543618] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"163.486927ms","start":"2026-03-08T13:20:58.849494Z","end":"2026-03-08T13:20:59.012981Z","steps":["trace[1769543618] 'process raft request'  (duration: 159.783669ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:03.283603Z","caller":"traceutil/trace.go:171","msg":"trace[726531707] linearizableReadLoop","detail":"{readStateIndex:976; appliedIndex:975; }","duration":"232.776802ms","start":"2026-03-08T13:21:03.050803Z","end":"2026-03-08T13:21:03.28358Z","steps":["trace[726531707] 'read index received'  (duration: 232.624757ms)","trace[726531707] 'applied index is now lower than readState.Index'  (duration: 150.895µs)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:03.28372Z","caller":"traceutil/trace.go:171","msg":"trace[1511792173] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"440.812994ms","start":"2026-03-08T13:21:02.842879Z","end":"2026-03-08T13:21:03.283692Z","steps":["trace[1511792173] 'process raft request'  (duration: 440.561386ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:03.283835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.01172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-08T13:21:03.283866Z","caller":"traceutil/trace.go:171","msg":"trace[1289213044] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:941; }","duration":"233.098592ms","start":"2026-03-08T13:21:03.050759Z","end":"2026-03-08T13:21:03.283857Z","steps":["trace[1289213044] 'agreement among raft nodes before linearized reading'  (duration: 232.951627ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:03.283863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.658612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-03-08T13:21:03.283922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.373562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-08T13:21:03.283968Z","caller":"traceutil/trace.go:171","msg":"trace[1363821149] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:941; }","duration":"229.796097ms","start":"2026-03-08T13:21:03.054154Z","end":"2026-03-08T13:21:03.28395Z","steps":["trace[1363821149] 'agreement among raft nodes before linearized reading'  (duration: 229.59157ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:03.283975Z","caller":"traceutil/trace.go:171","msg":"trace[1539312324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:941; }","duration":"228.447973ms","start":"2026-03-08T13:21:03.055512Z","end":"2026-03-08T13:21:03.28396Z","steps":["trace[1539312324] 'agreement among raft nodes before linearized reading'  (duration: 228.296978ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:03.283963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.714432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-08T13:21:03.284024Z","caller":"traceutil/trace.go:171","msg":"trace[1656227612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:941; }","duration":"228.813996ms","start":"2026-03-08T13:21:03.055192Z","end":"2026-03-08T13:21:03.284006Z","steps":["trace[1656227612] 'agreement among raft nodes before linearized reading'  (duration: 228.63952ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:03.284431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:02.842847Z","time spent":"440.943218ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:936 > 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-08T13:21:03.455709Z","caller":"traceutil/trace.go:171","msg":"trace[477721420] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"167.068781ms","start":"2026-03-08T13:21:03.288609Z","end":"2026-03-08T13:21:03.455678Z","steps":["trace[477721420] 'process raft request'  (duration: 74.082359ms)","trace[477721420] 'compare'  (duration: 92.812617ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:03.65334Z","caller":"traceutil/trace.go:171","msg":"trace[163519810] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"364.506503ms","start":"2026-03-08T13:21:03.288807Z","end":"2026-03-08T13:21:03.653313Z","steps":["trace[163519810] 'process raft request'  (duration: 342.331684ms)","trace[163519810] 'compare'  (duration: 22.017664ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:21:03.653504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:03.288787Z","time spent":"364.625627ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:939 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-08T13:21:03.653514Z","caller":"traceutil/trace.go:171","msg":"trace[751616837] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"364.348609ms","start":"2026-03-08T13:21:03.289136Z","end":"2026-03-08T13:21:03.653485Z","steps":["trace[751616837] 'process raft request'  (duration: 364.133412ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:03.653599Z","caller":"traceutil/trace.go:171","msg":"trace[1121765462] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"363.852952ms","start":"2026-03-08T13:21:03.289723Z","end":"2026-03-08T13:21:03.653576Z","steps":["trace[1121765462] 'process raft request'  (duration: 363.686797ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:03.653649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:03.289125Z","time spent":"364.447391ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:938 > 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-08T13:21:03.65375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:03.289714Z","time spent":"363.940435ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:940 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-08T13:21:05.716795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.414692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:21:05.716889Z","caller":"traceutil/trace.go:171","msg":"trace[1836109664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"116.563668ms","start":"2026-03-08T13:21:05.600303Z","end":"2026-03-08T13:21:05.716867Z","steps":["trace[1836109664] 'range keys from in-memory index tree'  (duration: 116.31334ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:05.717171Z","caller":"traceutil/trace.go:171","msg":"trace[1062880817] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"106.537576ms","start":"2026-03-08T13:21:05.610606Z","end":"2026-03-08T13:21:05.717144Z","steps":["trace[1062880817] 'process raft request'  (duration: 106.277988ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:09.80382Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449474180,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:21:10.304568Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449474180,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:21:10.476074Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.624959473s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-08T13:21:10.47663Z","caller":"traceutil/trace.go:171","msg":"trace[1046451690] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"1.625607583s","start":"2026-03-08T13:21:08.850987Z","end":"2026-03-08T13:21:10.476594Z","steps":["trace[1046451690] 'process raft request'  (duration: 1.625383016s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.476862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:08.850964Z","time spent":"1.625776639s","remote":"127.0.0.1:34592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5736,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:962 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5702 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-08T13:21:10.76743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.454587ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198175449474182 > lease_revoke:<id:7edf9ccd99e3e3f1>","response":"size:27"}
{"level":"info","ts":"2026-03-08T13:21:10.767716Z","caller":"traceutil/trace.go:171","msg":"trace[1333814241] linearizableReadLoop","detail":"{readStateIndex:1023; appliedIndex:1020; }","duration":"1.464370119s","start":"2026-03-08T13:21:09.303326Z","end":"2026-03-08T13:21:10.767696Z","steps":["trace[1333814241] 'read index received'  (duration: 1.172977063s)","trace[1333814241] 'applied index is now lower than readState.Index'  (duration: 291.391816ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:10.767957Z","caller":"traceutil/trace.go:171","msg":"trace[74382431] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"984.093174ms","start":"2026-03-08T13:21:09.783829Z","end":"2026-03-08T13:21:10.767922Z","steps":["trace[74382431] 'process raft request'  (duration: 983.708731ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.768112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:09.783807Z","time spent":"984.217168ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:935 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-08T13:21:10.768131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.464791403s","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-08T13:21:10.76817Z","caller":"traceutil/trace.go:171","msg":"trace[1306968422] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:986; }","duration":"1.464837414s","start":"2026-03-08T13:21:09.303319Z","end":"2026-03-08T13:21:10.768156Z","steps":["trace[1306968422] 'agreement among raft nodes before linearized reading'  (duration: 1.46470447s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.768211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:09.303259Z","time spent":"1.464943298s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-08T13:21:10.768551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033471882s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-08T13:21:10.768592Z","caller":"traceutil/trace.go:171","msg":"trace[1343829764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:986; }","duration":"1.033551875s","start":"2026-03-08T13:21:09.735029Z","end":"2026-03-08T13:21:10.768581Z","steps":["trace[1343829764] 'agreement among raft nodes before linearized reading'  (duration: 1.033435161s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.76856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.225509853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-08T13:21:10.768619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:09.735005Z","time spent":"1.033608237s","remote":"127.0.0.1:34680","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":"info","ts":"2026-03-08T13:21:10.768648Z","caller":"traceutil/trace.go:171","msg":"trace[1727396760] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:986; }","duration":"1.225660197s","start":"2026-03-08T13:21:09.542969Z","end":"2026-03-08T13:21:10.768629Z","steps":["trace[1727396760] 'agreement among raft nodes before linearized reading'  (duration: 1.225491842s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.768698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:09.542943Z","time spent":"1.22574334s","remote":"127.0.0.1:34844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"warn","ts":"2026-03-08T13:21:10.768722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.168021755s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-08T13:21:10.768779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.354516ms","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-08T13:21:10.768792Z","caller":"traceutil/trace.go:171","msg":"trace[1337588133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:986; }","duration":"1.168135208s","start":"2026-03-08T13:21:09.600641Z","end":"2026-03-08T13:21:10.768776Z","steps":["trace[1337588133] 'agreement among raft nodes before linearized reading'  (duration: 1.168028554s)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:10.76881Z","caller":"traceutil/trace.go:171","msg":"trace[451839167] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:986; }","duration":"225.426268ms","start":"2026-03-08T13:21:10.543375Z","end":"2026-03-08T13:21:10.768802Z","steps":["trace[451839167] 'agreement among raft nodes before linearized reading'  (duration: 225.377306ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.768834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:09.600619Z","time spent":"1.1682055s","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-08T13:21:10.769018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.584354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-08T13:21:10.769046Z","caller":"traceutil/trace.go:171","msg":"trace[1576998611] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:986; }","duration":"530.653196ms","start":"2026-03-08T13:21:10.238385Z","end":"2026-03-08T13:21:10.769038Z","steps":["trace[1576998611] 'agreement among raft nodes before linearized reading'  (duration: 530.603785ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.769073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:10.238364Z","time spent":"530.702128ms","remote":"127.0.0.1:34904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":29,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "}
{"level":"warn","ts":"2026-03-08T13:21:10.769113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210835283s","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-08T13:21:10.769149Z","caller":"traceutil/trace.go:171","msg":"trace[955366053] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:986; }","duration":"1.210918455s","start":"2026-03-08T13:21:09.55822Z","end":"2026-03-08T13:21:10.769138Z","steps":["trace[955366053] 'agreement among raft nodes before linearized reading'  (duration: 1.210767291s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.769178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:09.558198Z","time spent":"1.210973578s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-08T13:21:10.769248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032870814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-08T13:21:10.769277Z","caller":"traceutil/trace.go:171","msg":"trace[908458591] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:986; }","duration":"1.032927845s","start":"2026-03-08T13:21:09.736341Z","end":"2026-03-08T13:21:10.769268Z","steps":["trace[908458591] 'agreement among raft nodes before linearized reading'  (duration: 1.032845082s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.769302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:09.736329Z","time spent":"1.032967067s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-08T13:21:10.769659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.035557489s","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-08T13:21:10.769693Z","caller":"traceutil/trace.go:171","msg":"trace[1596978973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:986; }","duration":"1.03559208s","start":"2026-03-08T13:21:09.734092Z","end":"2026-03-08T13:21:10.769684Z","steps":["trace[1596978973] 'agreement among raft nodes before linearized reading'  (duration: 1.035505187s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:10.769722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:09.734036Z","time spent":"1.035676563s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-08T13:21:11.101135Z","caller":"traceutil/trace.go:171","msg":"trace[1085175730] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"327.863093ms","start":"2026-03-08T13:21:10.773235Z","end":"2026-03-08T13:21:11.101098Z","steps":["trace[1085175730] 'process raft request'  (duration: 286.417068ms)","trace[1085175730] 'compare'  (duration: 41.116514ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:11.101307Z","caller":"traceutil/trace.go:171","msg":"trace[682320907] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"326.909042ms","start":"2026-03-08T13:21:10.774385Z","end":"2026-03-08T13:21:11.101294Z","steps":["trace[682320907] 'process raft request'  (duration: 326.664074ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:11.101338Z","caller":"traceutil/trace.go:171","msg":"trace[199130686] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"327.547873ms","start":"2026-03-08T13:21:10.773763Z","end":"2026-03-08T13:21:11.101311Z","steps":["trace[199130686] 'process raft request'  (duration: 327.201731ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:11.101444Z","caller":"traceutil/trace.go:171","msg":"trace[1029803449] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"326.572271ms","start":"2026-03-08T13:21:10.774757Z","end":"2026-03-08T13:21:11.101329Z","steps":["trace[1029803449] 'process raft request'  (duration: 326.337784ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:11.10145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:10.774367Z","time spent":"327.000054ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:984 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-08T13:21:11.101162Z","caller":"traceutil/trace.go:171","msg":"trace[1991557981] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1023; }","duration":"320.435595ms","start":"2026-03-08T13:21:10.780699Z","end":"2026-03-08T13:21:11.101134Z","steps":["trace[1991557981] 'read index received'  (duration: 16.375864ms)","trace[1991557981] 'applied index is now lower than readState.Index'  (duration: 304.058791ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:21:11.101576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.858828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:21:11.101814Z","caller":"traceutil/trace.go:171","msg":"trace[1691648530] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:991; }","duration":"321.147147ms","start":"2026-03-08T13:21:10.780653Z","end":"2026-03-08T13:21:11.1018Z","steps":["trace[1691648530] 'agreement among raft nodes before linearized reading'  (duration: 320.864748ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:11.101904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:10.780633Z","time spent":"321.23818ms","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-08T13:21:11.101665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:10.773751Z","time spent":"327.654006ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:983 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-08T13:21:11.101709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:10.773224Z","time spent":"327.981856ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:981 > 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-08T13:21:11.101697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:10.77465Z","time spent":"326.988634ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:982 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-08T13:21:11.503087Z","caller":"traceutil/trace.go:171","msg":"trace[315061620] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"208.31081ms","start":"2026-03-08T13:21:11.294749Z","end":"2026-03-08T13:21:11.50306Z","steps":["trace[315061620] 'process raft request'  (duration: 208.125664ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:14.179872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.579036613s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-08T13:21:14.179914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074237895s","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-08T13:21:14.17997Z","caller":"traceutil/trace.go:171","msg":"trace[454959031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:993; }","duration":"1.579198079s","start":"2026-03-08T13:21:12.600752Z","end":"2026-03-08T13:21:14.17995Z","steps":["trace[454959031] 'range keys from in-memory index tree'  (duration: 1.57892628s)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:14.179991Z","caller":"traceutil/trace.go:171","msg":"trace[1986137050] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:993; }","duration":"1.074373509s","start":"2026-03-08T13:21:13.105599Z","end":"2026-03-08T13:21:14.179972Z","steps":["trace[1986137050] 'range keys from in-memory index tree'  (duration: 1.074050279s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:14.179937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.830443211s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-08T13:21:14.180042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:13.105577Z","time spent":"1.074454952s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-08T13:21:14.180084Z","caller":"traceutil/trace.go:171","msg":"trace[889234111] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:993; }","duration":"1.830609537s","start":"2026-03-08T13:21:12.349448Z","end":"2026-03-08T13:21:14.180058Z","steps":["trace[889234111] 'range keys from in-memory index tree'  (duration: 1.830420671s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:14.180464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.100145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-08T13:21:14.180507Z","caller":"traceutil/trace.go:171","msg":"trace[372412455] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:993; }","duration":"204.183057ms","start":"2026-03-08T13:21:13.97631Z","end":"2026-03-08T13:21:14.180493Z","steps":["trace[372412455] 'count revisions from in-memory index tree'  (duration: 204.018833ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:14.180543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.860936586s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-08T13:21:14.180536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075206165s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-08T13:21:14.180576Z","caller":"traceutil/trace.go:171","msg":"trace[455731406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:993; }","duration":"1.861007128s","start":"2026-03-08T13:21:12.31956Z","end":"2026-03-08T13:21:14.180567Z","steps":["trace[455731406] 'range keys from in-memory index tree'  (duration: 1.860855314s)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:14.180583Z","caller":"traceutil/trace.go:171","msg":"trace[1289682933] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:993; }","duration":"1.075288758s","start":"2026-03-08T13:21:13.105281Z","end":"2026-03-08T13:21:14.18057Z","steps":["trace[1289682933] 'range keys from in-memory index tree'  (duration: 1.075077602s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:14.180601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:12.319538Z","time spent":"1.86105698s","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-08T13:21:14.180613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:13.105254Z","time spent":"1.07535127s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-08T13:21:14.179953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074220704s","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-08T13:21:14.18076Z","caller":"traceutil/trace.go:171","msg":"trace[524829445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:993; }","duration":"1.075059881s","start":"2026-03-08T13:21:13.105691Z","end":"2026-03-08T13:21:14.180722Z","steps":["trace[524829445] 'range keys from in-memory index tree'  (duration: 1.07408875s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:14.180786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:13.105685Z","time spent":"1.075092442s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-08T13:21:14.180811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.38059886s","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-08T13:21:14.180861Z","caller":"traceutil/trace.go:171","msg":"trace[1840397630] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:993; }","duration":"1.380694803s","start":"2026-03-08T13:21:12.800153Z","end":"2026-03-08T13:21:14.180848Z","steps":["trace[1840397630] 'range keys from in-memory index tree'  (duration: 1.38029508s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:14.180898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:12.800119Z","time spent":"1.380769515s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-08T13:21:14.180931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075380941s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-08T13:21:14.180019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:12.600727Z","time spent":"1.579283281s","remote":"127.0.0.1:34416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-08T13:21:14.180971Z","caller":"traceutil/trace.go:171","msg":"trace[499620008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:993; }","duration":"1.075436502s","start":"2026-03-08T13:21:13.105524Z","end":"2026-03-08T13:21:14.18096Z","steps":["trace[499620008] 'range keys from in-memory index tree'  (duration: 1.075302409s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:14.181002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:13.105511Z","time spent":"1.075481975s","remote":"127.0.0.1:34680","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-08T13:21:14.688712Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449474204,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-08T13:21:14.880217Z","caller":"traceutil/trace.go:171","msg":"trace[1315609310] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"694.624549ms","start":"2026-03-08T13:21:14.185563Z","end":"2026-03-08T13:21:14.880187Z","steps":["trace[1315609310] 'process raft request'  (duration: 694.470434ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:14.88038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:14.185538Z","time spent":"694.768563ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:987 > 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-08T13:21:15.27755Z","caller":"traceutil/trace.go:171","msg":"trace[124205905] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"1.091672803s","start":"2026-03-08T13:21:14.185845Z","end":"2026-03-08T13:21:15.277518Z","steps":["trace[124205905] 'process raft request'  (duration: 1.091112055s)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:15.278327Z","caller":"traceutil/trace.go:171","msg":"trace[1566863766] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"1.091755566s","start":"2026-03-08T13:21:14.186558Z","end":"2026-03-08T13:21:15.278314Z","steps":["trace[1566863766] 'process raft request'  (duration: 1.090525546s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:15.278439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:14.186547Z","time spent":"1.091838049s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:990 > 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-08T13:21:15.278503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:14.185829Z","time spent":"1.092592603s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:989 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-08T13:21:15.278059Z","caller":"traceutil/trace.go:171","msg":"trace[1955051286] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1030; }","duration":"1.089668239s","start":"2026-03-08T13:21:14.188369Z","end":"2026-03-08T13:21:15.278037Z","steps":["trace[1955051286] 'read index received'  (duration: 691.664514ms)","trace[1955051286] 'applied index is now lower than readState.Index'  (duration: 397.917952ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:15.278812Z","caller":"traceutil/trace.go:171","msg":"trace[147025642] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"1.09188618s","start":"2026-03-08T13:21:14.186914Z","end":"2026-03-08T13:21:15.2788Z","steps":["trace[147025642] 'process raft request'  (duration: 1.090202186s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:15.278874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:14.186891Z","time spent":"1.091956853s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:988 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-08T13:21:15.278188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.089805694s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:21:15.278986Z","caller":"traceutil/trace.go:171","msg":"trace[631008139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"1.09062793s","start":"2026-03-08T13:21:14.188342Z","end":"2026-03-08T13:21:15.27897Z","steps":["trace[631008139] 'agreement among raft nodes before linearized reading'  (duration: 1.089772392s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:15.279023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:14.188332Z","time spent":"1.090676502s","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-08T13:21:15.279449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.428648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.244\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-08T13:21:15.279484Z","caller":"traceutil/trace.go:171","msg":"trace[1056366130] range","detail":"{range_begin:/registry/masterleases/199.204.45.244; range_end:; response_count:1; response_revision:998; }","duration":"859.48408ms","start":"2026-03-08T13:21:14.419982Z","end":"2026-03-08T13:21:15.279466Z","steps":["trace[1056366130] 'agreement among raft nodes before linearized reading'  (duration: 859.227562ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:15.279506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:14.419949Z","time spent":"859.551412ms","remote":"127.0.0.1:34448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.244\" "}
{"level":"warn","ts":"2026-03-08T13:21:15.279595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.604542ms","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-08T13:21:15.279654Z","caller":"traceutil/trace.go:171","msg":"trace[1405977187] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:998; }","duration":"685.676584ms","start":"2026-03-08T13:21:14.593944Z","end":"2026-03-08T13:21:15.279621Z","steps":["trace[1405977187] 'agreement among raft nodes before linearized reading'  (duration: 685.606931ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:15.279684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:14.593926Z","time spent":"685.747865ms","remote":"127.0.0.1:34928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-03-08T13:21:15.279914Z","caller":"traceutil/trace.go:171","msg":"trace[1657996245] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"1.092402977s","start":"2026-03-08T13:21:14.187496Z","end":"2026-03-08T13:21:15.279899Z","steps":["trace[1657996245] 'process raft request'  (duration: 1.090387742s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:15.279965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:14.187487Z","time spent":"1.092446879s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:991 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-08T13:21:15.506515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.078639ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198175449474214 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:7edf9ccd99e3e4a5>","response":"size:39"}
{"level":"info","ts":"2026-03-08T13:21:15.50672Z","caller":"traceutil/trace.go:171","msg":"trace[1599008437] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1035; }","duration":"219.170507ms","start":"2026-03-08T13:21:15.287537Z","end":"2026-03-08T13:21:15.506707Z","steps":["trace[1599008437] 'read index received'  (duration: 88.999075ms)","trace[1599008437] 'applied index is now lower than readState.Index'  (duration: 130.170852ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:15.506963Z","caller":"traceutil/trace.go:171","msg":"trace[2041980134] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"221.353937ms","start":"2026-03-08T13:21:15.285579Z","end":"2026-03-08T13:21:15.506933Z","steps":["trace[2041980134] 'process raft request'  (duration: 221.044037ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:15.506988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.427836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:21:15.50708Z","caller":"traceutil/trace.go:171","msg":"trace[1595281303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:999; }","duration":"219.55673ms","start":"2026-03-08T13:21:15.287497Z","end":"2026-03-08T13:21:15.507054Z","steps":["trace[1595281303] 'agreement among raft nodes before linearized reading'  (duration: 219.337173ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:16.094495Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449474219,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:21:16.765918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.006428ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198175449474220 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-08T13:21:16.766011Z","caller":"traceutil/trace.go:171","msg":"trace[1121585696] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"1.172756223s","start":"2026-03-08T13:21:15.59324Z","end":"2026-03-08T13:21:16.765996Z","steps":["trace[1121585696] 'process raft request'  (duration: 808.615281ms)","trace[1121585696] 'compare'  (duration: 363.74903ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:21:16.766085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:15.593225Z","time spent":"1.172841037s","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<>"}
{"level":"info","ts":"2026-03-08T13:21:16.769474Z","caller":"traceutil/trace.go:171","msg":"trace[489730267] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1038; }","duration":"1.175953736s","start":"2026-03-08T13:21:15.593505Z","end":"2026-03-08T13:21:16.769459Z","steps":["trace[489730267] 'read index received'  (duration: 808.338983ms)","trace[489730267] 'applied index is now lower than readState.Index'  (duration: 367.614003ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:16.769541Z","caller":"traceutil/trace.go:171","msg":"trace[968018465] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"1.134344176s","start":"2026-03-08T13:21:15.635189Z","end":"2026-03-08T13:21:16.769533Z","steps":["trace[968018465] 'process raft request'  (duration: 1.13417995s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:16.769585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:15.635162Z","time spent":"1.134393277s","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-66p5k.189ae058df5b2f87\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-66p5k.189ae058df5b2f87\" value_size:675 lease:9142198175449473926 >> failure:<>"}
{"level":"warn","ts":"2026-03-08T13:21:16.769788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176278016s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-03-08T13:21:16.769834Z","caller":"traceutil/trace.go:171","msg":"trace[2048553769] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1003; }","duration":"1.176360359s","start":"2026-03-08T13:21:15.593461Z","end":"2026-03-08T13:21:16.769822Z","steps":["trace[2048553769] 'agreement among raft nodes before linearized reading'  (duration: 1.176232495s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:16.769855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:15.593445Z","time spent":"1.176405881s","remote":"127.0.0.1:34590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"warn","ts":"2026-03-08T13:21:16.769869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.996633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:21:16.769895Z","caller":"traceutil/trace.go:171","msg":"trace[572068557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1003; }","duration":"169.047315ms","start":"2026-03-08T13:21:16.60084Z","end":"2026-03-08T13:21:16.769887Z","steps":["trace[572068557] 'agreement among raft nodes before linearized reading'  (duration: 169.007324ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:16.769996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.223654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:21:16.770014Z","caller":"traceutil/trace.go:171","msg":"trace[484695057] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1003; }","duration":"587.282156ms","start":"2026-03-08T13:21:16.182726Z","end":"2026-03-08T13:21:16.770008Z","steps":["trace[484695057] 'agreement among raft nodes before linearized reading'  (duration: 587.250935ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:16.770021Z","caller":"traceutil/trace.go:171","msg":"trace[36386976] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"939.039811ms","start":"2026-03-08T13:21:15.830974Z","end":"2026-03-08T13:21:16.770014Z","steps":["trace[36386976] 'process raft request'  (duration: 938.450562ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:16.770034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:16.182705Z","time spent":"587.323718ms","remote":"127.0.0.1:34632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-03-08T13:21:16.770078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:15.830951Z","time spent":"939.086083ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:965 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-03-08T13:21:17.154161Z","caller":"traceutil/trace.go:171","msg":"trace[1440172492] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"380.767284ms","start":"2026-03-08T13:21:16.773363Z","end":"2026-03-08T13:21:17.15413Z","steps":["trace[1440172492] 'process raft request'  (duration: 333.549304ms)","trace[1440172492] 'compare'  (duration: 46.971542ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:21:17.154302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:16.773351Z","time spent":"380.883997ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":842,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-66p5k.189ae058df68f940\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-66p5k.189ae058df68f940\" value_size:738 lease:9142198175449473926 >> failure:<>"}
{"level":"info","ts":"2026-03-08T13:21:17.222461Z","caller":"traceutil/trace.go:171","msg":"trace[31082975] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1041; }","duration":"338.344678ms","start":"2026-03-08T13:21:16.884094Z","end":"2026-03-08T13:21:17.222439Z","steps":["trace[31082975] 'read index received'  (duration: 222.864866ms)","trace[31082975] 'applied index is now lower than readState.Index'  (duration: 115.478822ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:17.222585Z","caller":"traceutil/trace.go:171","msg":"trace[2133049465] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"446.759064ms","start":"2026-03-08T13:21:16.775769Z","end":"2026-03-08T13:21:17.222528Z","steps":["trace[2133049465] 'process raft request'  (duration: 446.496005ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:17.222619Z","caller":"traceutil/trace.go:171","msg":"trace[423905979] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"446.114774ms","start":"2026-03-08T13:21:16.776439Z","end":"2026-03-08T13:21:17.222553Z","steps":["trace[423905979] 'process raft request'  (duration: 445.959779ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:17.222669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.552864ms","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-08T13:21:17.222701Z","caller":"traceutil/trace.go:171","msg":"trace[1857277445] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1006; }","duration":"338.640467ms","start":"2026-03-08T13:21:16.884051Z","end":"2026-03-08T13:21:17.222692Z","steps":["trace[1857277445] 'agreement among raft nodes before linearized reading'  (duration: 338.499203ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:17.222758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:16.88403Z","time spent":"338.71869ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-08T13:21:17.222745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:16.776431Z","time spent":"446.245998ms","remote":"127.0.0.1:34502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":869,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/external-resizer-rbd-csi-ceph-com.189ae05923080fc5\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/external-resizer-rbd-csi-ceph-com.189ae05923080fc5\" value_size:772 lease:9142198175449473926 >> failure:<>"}
{"level":"warn","ts":"2026-03-08T13:21:17.222755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:16.775758Z","time spent":"446.907378ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:1001 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:424 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-08T13:21:17.222976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.629147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"}
{"level":"info","ts":"2026-03-08T13:21:17.223083Z","caller":"traceutil/trace.go:171","msg":"trace[251347131] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1006; }","duration":"206.799872ms","start":"2026-03-08T13:21:17.016226Z","end":"2026-03-08T13:21:17.223026Z","steps":["trace[251347131] 'agreement among raft nodes before linearized reading'  (duration: 206.448331ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:17.833895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.938679ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198175449474234 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:994 > 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-08T13:21:17.834056Z","caller":"traceutil/trace.go:171","msg":"trace[2023490576] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1044; }","duration":"546.133521ms","start":"2026-03-08T13:21:17.287906Z","end":"2026-03-08T13:21:17.834039Z","steps":["trace[2023490576] 'read index received'  (duration: 394.653558ms)","trace[2023490576] 'applied index is now lower than readState.Index'  (duration: 151.479023ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:17.834179Z","caller":"traceutil/trace.go:171","msg":"trace[1963422096] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"607.104561ms","start":"2026-03-08T13:21:17.227036Z","end":"2026-03-08T13:21:17.834141Z","steps":["trace[1963422096] 'process raft request'  (duration: 58.780809ms)","trace[1963422096] 'compare'  (duration: 547.838526ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:21:17.83419Z","caller":"traceutil/trace.go:171","msg":"trace[2043609926] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"605.694256ms","start":"2026-03-08T13:21:17.228462Z","end":"2026-03-08T13:21:17.834157Z","steps":["trace[2043609926] 'process raft request'  (duration: 605.520451ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:17.834246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.335308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-08T13:21:17.834284Z","caller":"traceutil/trace.go:171","msg":"trace[934151970] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1008; }","duration":"546.40693ms","start":"2026-03-08T13:21:17.287866Z","end":"2026-03-08T13:21:17.834273Z","steps":["trace[934151970] 'agreement among raft nodes before linearized reading'  (duration: 546.270966ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:17.834321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:17.287847Z","time spent":"546.461162ms","remote":"127.0.0.1:34680","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-08T13:21:17.834367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:17.228436Z","time spent":"605.84214ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:993 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-08T13:21:17.834302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.832992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"warn","ts":"2026-03-08T13:21:17.834441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.674097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-08T13:21:17.834455Z","caller":"traceutil/trace.go:171","msg":"trace[1147140126] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1008; }","duration":"546.020908ms","start":"2026-03-08T13:21:17.288421Z","end":"2026-03-08T13:21:17.834442Z","steps":["trace[1147140126] 'agreement among raft nodes before linearized reading'  (duration: 545.75125ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:17.834499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:17.288412Z","time spent":"546.07553ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-08T13:21:17.834463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:17.22701Z","time spent":"607.251605ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:994 > 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-08T13:21:17.834502Z","caller":"traceutil/trace.go:171","msg":"trace[594286740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1008; }","duration":"545.74999ms","start":"2026-03-08T13:21:17.288731Z","end":"2026-03-08T13:21:17.834481Z","steps":["trace[594286740] 'agreement among raft nodes before linearized reading'  (duration: 545.618135ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:17.834589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.107431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-03-08T13:21:17.834602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:17.288714Z","time spent":"545.877283ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-08T13:21:17.834617Z","caller":"traceutil/trace.go:171","msg":"trace[305022374] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1008; }","duration":"546.149322ms","start":"2026-03-08T13:21:17.28846Z","end":"2026-03-08T13:21:17.834609Z","steps":["trace[305022374] 'agreement among raft nodes before linearized reading'  (duration: 546.069189ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:17.83465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:17.288455Z","time spent":"546.186974ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-08T13:21:17.971107Z","caller":"traceutil/trace.go:171","msg":"trace[1874262245] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"131.505795ms","start":"2026-03-08T13:21:17.839575Z","end":"2026-03-08T13:21:17.971081Z","steps":["trace[1874262245] 'process raft request'  (duration: 131.463143ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:17.971153Z","caller":"traceutil/trace.go:171","msg":"trace[1944968991] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"131.582327ms","start":"2026-03-08T13:21:17.839538Z","end":"2026-03-08T13:21:17.97112Z","steps":["trace[1944968991] 'process raft request'  (duration: 129.533432ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:17.971174Z","caller":"traceutil/trace.go:171","msg":"trace[1159079683] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"131.601217ms","start":"2026-03-08T13:21:17.839552Z","end":"2026-03-08T13:21:17.971153Z","steps":["trace[1159079683] 'process raft request'  (duration: 131.444002ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:19.336774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.685201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:21:19.336889Z","caller":"traceutil/trace.go:171","msg":"trace[1580123938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"735.828215ms","start":"2026-03-08T13:21:18.601021Z","end":"2026-03-08T13:21:19.336849Z","steps":["trace[1580123938] 'range keys from in-memory index tree'  (duration: 735.574507ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:19.336909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.186590216s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-08T13:21:19.336945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:18.600999Z","time spent":"735.930728ms","remote":"127.0.0.1:34402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-08T13:21:19.33698Z","caller":"traceutil/trace.go:171","msg":"trace[1125591341] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1012; }","duration":"1.186727101s","start":"2026-03-08T13:21:18.150235Z","end":"2026-03-08T13:21:19.336962Z","steps":["trace[1125591341] 'count revisions from in-memory index tree'  (duration: 1.186513534s)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:19.337023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:18.150215Z","time spent":"1.186797623s","remote":"127.0.0.1:34802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "}
{"level":"warn","ts":"2026-03-08T13:21:20.339973Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198175449474244,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-08T13:21:20.719792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.421644ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198175449474245 > lease_revoke:<id:7edf9ccd99e3e449>","response":"size:27"}
{"level":"info","ts":"2026-03-08T13:21:20.72021Z","caller":"traceutil/trace.go:171","msg":"trace[1542107505] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1050; }","duration":"880.789132ms","start":"2026-03-08T13:21:19.839395Z","end":"2026-03-08T13:21:20.720184Z","steps":["trace[1542107505] 'read index received'  (duration: 615.889452ms)","trace[1542107505] 'applied index is now lower than readState.Index'  (duration: 264.896359ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:21:20.7206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.195694ms","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-08T13:21:20.720658Z","caller":"traceutil/trace.go:171","msg":"trace[2061122410] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1012; }","duration":"881.264836ms","start":"2026-03-08T13:21:19.839379Z","end":"2026-03-08T13:21:20.720644Z","steps":["trace[2061122410] 'agreement among raft nodes before linearized reading'  (duration: 881.016968ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:20.720706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:19.839325Z","time spent":"881.36799ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-08T13:21:20.720719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.151783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-08T13:21:20.720737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.219418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:21:20.720777Z","caller":"traceutil/trace.go:171","msg":"trace[579928400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1012; }","duration":"744.251386ms","start":"2026-03-08T13:21:19.976509Z","end":"2026-03-08T13:21:20.72076Z","steps":["trace[579928400] 'agreement among raft nodes before linearized reading'  (duration: 744.092061ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:20.720793Z","caller":"traceutil/trace.go:171","msg":"trace[839018633] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1012; }","duration":"122.324481ms","start":"2026-03-08T13:21:20.598451Z","end":"2026-03-08T13:21:20.720776Z","steps":["trace[839018633] 'agreement among raft nodes before linearized reading'  (duration: 122.224118ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:20.72079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.867436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-08T13:21:20.720819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:19.97649Z","time spent":"744.318198ms","remote":"127.0.0.1:34680","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":"info","ts":"2026-03-08T13:21:20.720842Z","caller":"traceutil/trace.go:171","msg":"trace[2002002517] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1012; }","duration":"744.950218ms","start":"2026-03-08T13:21:19.975878Z","end":"2026-03-08T13:21:20.720828Z","steps":["trace[2002002517] 'agreement among raft nodes before linearized reading'  (duration: 744.806303ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:20.720883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:19.975861Z","time spent":"745.00915ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-08T13:21:20.72091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.741982ms","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-08T13:21:20.721285Z","caller":"traceutil/trace.go:171","msg":"trace[1020516917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1012; }","duration":"744.869066ms","start":"2026-03-08T13:21:19.976122Z","end":"2026-03-08T13:21:20.720991Z","steps":["trace[1020516917] 'agreement among raft nodes before linearized reading'  (duration: 744.517135ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:20.721436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:19.976117Z","time spent":"745.256289ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-08T13:21:20.721458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.901924ms","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-08T13:21:20.721514Z","caller":"traceutil/trace.go:171","msg":"trace[967848833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1012; }","duration":"859.989897ms","start":"2026-03-08T13:21:19.861509Z","end":"2026-03-08T13:21:20.721499Z","steps":["trace[967848833] 'agreement among raft nodes before linearized reading'  (duration: 859.054087ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:20.721558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:19.861491Z","time spent":"860.054088ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-08T13:21:22.236798Z","caller":"traceutil/trace.go:171","msg":"trace[701994316] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"352.019435ms","start":"2026-03-08T13:21:21.884754Z","end":"2026-03-08T13:21:22.236773Z","steps":["trace[701994316] 'process raft request'  (duration: 351.83968ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:21:22.236925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:21:21.884726Z","time spent":"352.141299ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:439 >> failure:<>"}
{"level":"info","ts":"2026-03-08T13:21:22.984173Z","caller":"traceutil/trace.go:171","msg":"trace[1023984210] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"139.107137ms","start":"2026-03-08T13:21:22.845033Z","end":"2026-03-08T13:21:22.98414Z","steps":["trace[1023984210] 'process raft request'  (duration: 137.351411ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:24.868328Z","caller":"traceutil/trace.go:171","msg":"trace[391391410] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"100.864635ms","start":"2026-03-08T13:21:24.767439Z","end":"2026-03-08T13:21:24.868304Z","steps":["trace[391391410] 'process raft request'  (duration: 100.671899ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:24.868917Z","caller":"traceutil/trace.go:171","msg":"trace[913215355] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"101.222156ms","start":"2026-03-08T13:21:24.767676Z","end":"2026-03-08T13:21:24.868898Z","steps":["trace[913215355] 'process raft request'  (duration: 100.581306ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:21:24.869894Z","caller":"traceutil/trace.go:171","msg":"trace[650944733] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"101.718842ms","start":"2026-03-08T13:21:24.768152Z","end":"2026-03-08T13:21:24.869871Z","steps":["trace[650944733] 'process raft request'  (duration: 101.615079ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:22:03.177902Z","caller":"traceutil/trace.go:171","msg":"trace[1746578630] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"106.903148ms","start":"2026-03-08T13:22:03.070978Z","end":"2026-03-08T13:22:03.177882Z","steps":["trace[1746578630] 'process raft request'  (duration: 106.723032ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:22:14.158195Z","caller":"traceutil/trace.go:171","msg":"trace[1031041051] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"207.176974ms","start":"2026-03-08T13:22:13.950992Z","end":"2026-03-08T13:22:14.158169Z","steps":["trace[1031041051] 'process raft request'  (duration: 207.03877ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:22:32.864584Z","caller":"traceutil/trace.go:171","msg":"trace[1759596194] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"230.999366ms","start":"2026-03-08T13:22:32.633499Z","end":"2026-03-08T13:22:32.864498Z","steps":["trace[1759596194] 'process raft request'  (duration: 230.699848ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:22:46.867085Z","caller":"traceutil/trace.go:171","msg":"trace[959825410] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"190.216735ms","start":"2026-03-08T13:22:46.676834Z","end":"2026-03-08T13:22:46.867051Z","steps":["trace[959825410] 'process raft request'  (duration: 190.023639ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:22:47.461709Z","caller":"traceutil/trace.go:171","msg":"trace[1831042623] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"107.514419ms","start":"2026-03-08T13:22:47.354172Z","end":"2026-03-08T13:22:47.461686Z","steps":["trace[1831042623] 'process raft request'  (duration: 107.367515ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:22:47.813699Z","caller":"traceutil/trace.go:171","msg":"trace[2027491039] linearizableReadLoop","detail":"{readStateIndex:1445; appliedIndex:1444; }","duration":"317.513259ms","start":"2026-03-08T13:22:47.496162Z","end":"2026-03-08T13:22:47.813675Z","steps":["trace[2027491039] 'read index received'  (duration: 227.055827ms)","trace[2027491039] 'applied index is now lower than readState.Index'  (duration: 90.456382ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:22:47.81405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.740178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-08T13:22:47.814108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.016568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-08T13:22:47.814133Z","caller":"traceutil/trace.go:171","msg":"trace[563998844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1389; }","duration":"231.879241ms","start":"2026-03-08T13:22:47.582235Z","end":"2026-03-08T13:22:47.814114Z","steps":["trace[563998844] 'agreement among raft nodes before linearized reading'  (duration: 231.619034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:22:47.814108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.855331ms","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-08T13:22:47.814154Z","caller":"traceutil/trace.go:171","msg":"trace[1903113832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1389; }","duration":"206.10447ms","start":"2026-03-08T13:22:47.608037Z","end":"2026-03-08T13:22:47.814141Z","steps":["trace[1903113832] 'agreement among raft nodes before linearized reading'  (duration: 205.975926ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:22:47.814193Z","caller":"traceutil/trace.go:171","msg":"trace[2143121548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1389; }","duration":"206.980654ms","start":"2026-03-08T13:22:47.607195Z","end":"2026-03-08T13:22:47.814176Z","steps":["trace[2143121548] 'agreement among raft nodes before linearized reading'  (duration: 206.820739ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:22:47.814101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.038756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-08T13:22:47.814178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.998142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-03-08T13:22:47.814381Z","caller":"traceutil/trace.go:171","msg":"trace[2109393494] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1389; }","duration":"318.222408ms","start":"2026-03-08T13:22:47.496144Z","end":"2026-03-08T13:22:47.814366Z","steps":["trace[2109393494] 'agreement among raft nodes before linearized reading'  (duration: 317.845398ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:22:47.814426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:22:47.496063Z","time spent":"318.350382ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-08T13:22:47.814398Z","caller":"traceutil/trace.go:171","msg":"trace[1911340232] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1389; }","duration":"187.372935ms","start":"2026-03-08T13:22:47.62698Z","end":"2026-03-08T13:22:47.814353Z","steps":["trace[1911340232] 'agreement among raft nodes before linearized reading'  (duration: 186.995034ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:22:47.813824Z","caller":"traceutil/trace.go:171","msg":"trace[199748660] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"347.427496ms","start":"2026-03-08T13:22:47.466382Z","end":"2026-03-08T13:22:47.813809Z","steps":["trace[199748660] 'process raft request'  (duration: 257.093407ms)","trace[199748660] 'compare'  (duration: 90.066511ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:22:47.814793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:22:47.466348Z","time spent":"348.270039ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1369 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:439 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-08T13:23:28.168628Z","caller":"traceutil/trace.go:171","msg":"trace[980607720] transaction","detail":"{read_only:false; response_revision:1554; number_of_response:1; }","duration":"114.311701ms","start":"2026-03-08T13:23:28.054285Z","end":"2026-03-08T13:23:28.168597Z","steps":["trace[980607720] 'process raft request'  (duration: 56.052215ms)","trace[980607720] 'compare'  (duration: 58.106391ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:23:30.508572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.492479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-08T13:23:30.508667Z","caller":"traceutil/trace.go:171","msg":"trace[1556662104] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1563; }","duration":"110.631564ms","start":"2026-03-08T13:23:30.398017Z","end":"2026-03-08T13:23:30.508649Z","steps":["trace[1556662104] 'range keys from in-memory index tree'  (duration: 110.280003ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:23:30.508979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.011768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-08T13:23:30.509017Z","caller":"traceutil/trace.go:171","msg":"trace[1448607468] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1563; }","duration":"204.058729ms","start":"2026-03-08T13:23:30.30495Z","end":"2026-03-08T13:23:30.509008Z","steps":["trace[1448607468] 'range keys from in-memory index tree'  (duration: 203.911534ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:23:30.509181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.328303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-08T13:23:30.509215Z","caller":"traceutil/trace.go:171","msg":"trace[854873149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1563; }","duration":"169.394405ms","start":"2026-03-08T13:23:30.339813Z","end":"2026-03-08T13:23:30.509207Z","steps":["trace[854873149] 'range keys from in-memory index tree'  (duration: 169.21876ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:23:30.509406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.627188ms","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-08T13:23:30.509439Z","caller":"traceutil/trace.go:171","msg":"trace[1773729972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1563; }","duration":"129.68551ms","start":"2026-03-08T13:23:30.379745Z","end":"2026-03-08T13:23:30.50943Z","steps":["trace[1773729972] 'range keys from in-memory index tree'  (duration: 129.496224ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:24:24.35879Z","caller":"traceutil/trace.go:171","msg":"trace[590263160] linearizableReadLoop","detail":"{readStateIndex:1880; appliedIndex:1879; }","duration":"171.44821ms","start":"2026-03-08T13:24:24.187314Z","end":"2026-03-08T13:24:24.358762Z","steps":["trace[590263160] 'read index received'  (duration: 171.159541ms)","trace[590263160] 'applied index is now lower than readState.Index'  (duration: 287.839µs)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:24:24.358841Z","caller":"traceutil/trace.go:171","msg":"trace[247708768] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"179.26793ms","start":"2026-03-08T13:24:24.179545Z","end":"2026-03-08T13:24:24.358813Z","steps":["trace[247708768] 'process raft request'  (duration: 178.990671ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:24:24.358994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.659657ms","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-08T13:24:24.359034Z","caller":"traceutil/trace.go:171","msg":"trace[1307881474] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1804; }","duration":"171.753531ms","start":"2026-03-08T13:24:24.18727Z","end":"2026-03-08T13:24:24.359023Z","steps":["trace[1307881474] 'agreement among raft nodes before linearized reading'  (duration: 171.605186ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:24:24.753916Z","caller":"traceutil/trace.go:171","msg":"trace[124124737] linearizableReadLoop","detail":"{readStateIndex:1884; appliedIndex:1882; }","duration":"217.437985ms","start":"2026-03-08T13:24:24.536446Z","end":"2026-03-08T13:24:24.753884Z","steps":["trace[124124737] 'read index received'  (duration: 29.625643ms)","trace[124124737] 'applied index is now lower than readState.Index'  (duration: 187.811102ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:24:24.75394Z","caller":"traceutil/trace.go:171","msg":"trace[1968000342] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"235.665355ms","start":"2026-03-08T13:24:24.518236Z","end":"2026-03-08T13:24:24.753901Z","steps":["trace[1968000342] 'process raft request'  (duration: 169.828419ms)","trace[1968000342] 'compare'  (duration: 65.63438ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:24:24.754133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.896937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-08T13:24:24.754176Z","caller":"traceutil/trace.go:171","msg":"trace[535955019] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1807; }","duration":"178.00387ms","start":"2026-03-08T13:24:24.576161Z","end":"2026-03-08T13:24:24.754165Z","steps":["trace[535955019] 'agreement among raft nodes before linearized reading'  (duration: 177.905027ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:24:24.754335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.583572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"}
{"level":"info","ts":"2026-03-08T13:24:24.754401Z","caller":"traceutil/trace.go:171","msg":"trace[1185968664] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1807; }","duration":"121.696956ms","start":"2026-03-08T13:24:24.632689Z","end":"2026-03-08T13:24:24.754386Z","steps":["trace[1185968664] 'agreement among raft nodes before linearized reading'  (duration: 121.469999ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:24:24.754839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.365865ms","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-08T13:24:24.75494Z","caller":"traceutil/trace.go:171","msg":"trace[946063653] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1807; }","duration":"218.50659ms","start":"2026-03-08T13:24:24.536403Z","end":"2026-03-08T13:24:24.75491Z","steps":["trace[946063653] 'agreement among raft nodes before linearized reading'  (duration: 217.602011ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:24:24.965725Z","caller":"traceutil/trace.go:171","msg":"trace[1361782666] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"125.315122ms","start":"2026-03-08T13:24:24.840373Z","end":"2026-03-08T13:24:24.965688Z","steps":["trace[1361782666] 'process raft request'  (duration: 30.645147ms)","trace[1361782666] 'compare'  (duration: 94.412887ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:24:24.965855Z","caller":"traceutil/trace.go:171","msg":"trace[611583370] linearizableReadLoop","detail":"{readStateIndex:1887; appliedIndex:1886; }","duration":"123.136562ms","start":"2026-03-08T13:24:24.842705Z","end":"2026-03-08T13:24:24.965841Z","steps":["trace[611583370] 'read index received'  (duration: 28.327912ms)","trace[611583370] 'applied index is now lower than readState.Index'  (duration: 94.80734ms)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:24:24.965777Z","caller":"traceutil/trace.go:171","msg":"trace[1225740280] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"122.44912ms","start":"2026-03-08T13:24:24.843296Z","end":"2026-03-08T13:24:24.965745Z","steps":["trace[1225740280] 'process raft request'  (duration: 122.339526ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:24:24.966215Z","caller":"traceutil/trace.go:171","msg":"trace[2102846244] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"121.782898ms","start":"2026-03-08T13:24:24.844402Z","end":"2026-03-08T13:24:24.966185Z","steps":["trace[2102846244] 'process raft request'  (duration: 121.300533ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:24:24.966447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.72178ms","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-08T13:24:24.966558Z","caller":"traceutil/trace.go:171","msg":"trace[653399619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1811; }","duration":"123.914897ms","start":"2026-03-08T13:24:24.842621Z","end":"2026-03-08T13:24:24.966536Z","steps":["trace[653399619] 'agreement among raft nodes before linearized reading'  (duration: 123.307987ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:24:27.883463Z","caller":"traceutil/trace.go:171","msg":"trace[2106020210] linearizableReadLoop","detail":"{readStateIndex:1900; appliedIndex:1899; }","duration":"284.46656ms","start":"2026-03-08T13:24:27.598967Z","end":"2026-03-08T13:24:27.883434Z","steps":["trace[2106020210] 'read index received'  (duration: 284.15992ms)","trace[2106020210] 'applied index is now lower than readState.Index'  (duration: 305.68µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-08T13:24:27.883692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.694627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-08T13:24:27.883726Z","caller":"traceutil/trace.go:171","msg":"trace[1521945838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1823; }","duration":"284.79632ms","start":"2026-03-08T13:24:27.59892Z","end":"2026-03-08T13:24:27.883717Z","steps":["trace[1521945838] 'agreement among raft nodes before linearized reading'  (duration: 284.657055ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:24:27.88393Z","caller":"traceutil/trace.go:171","msg":"trace[1193939735] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"301.269825ms","start":"2026-03-08T13:24:27.582634Z","end":"2026-03-08T13:24:27.883904Z","steps":["trace[1193939735] 'process raft request'  (duration: 300.616034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:24:27.884095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-08T13:24:27.582618Z","time spent":"301.373989ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:1814 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >"}
{"level":"warn","ts":"2026-03-08T13:24:29.687067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.18703ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198175449476305 > lease_revoke:<id:7edf9ccd99e3ebfa>","response":"size:27"}
{"level":"info","ts":"2026-03-08T13:25:02.046628Z","caller":"traceutil/trace.go:171","msg":"trace[1288181064] linearizableReadLoop","detail":"{readStateIndex:2059; appliedIndex:2058; }","duration":"136.278366ms","start":"2026-03-08T13:25:01.910325Z","end":"2026-03-08T13:25:02.046604Z","steps":["trace[1288181064] 'read index received'  (duration: 136.132851ms)","trace[1288181064] 'applied index is now lower than readState.Index'  (duration: 144.505µs)"],"step_count":2}
{"level":"info","ts":"2026-03-08T13:25:02.046756Z","caller":"traceutil/trace.go:171","msg":"trace[1766220903] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"156.000434ms","start":"2026-03-08T13:25:01.890742Z","end":"2026-03-08T13:25:02.046743Z","steps":["trace[1766220903] 'process raft request'  (duration: 155.665324ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-08T13:25:02.048132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.68741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:135 size:103847"}
{"level":"warn","ts":"2026-03-08T13:25:02.04808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.931007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:135 size:103847"}
{"level":"info","ts":"2026-03-08T13:25:02.048235Z","caller":"traceutil/trace.go:171","msg":"trace[1415836249] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:135; response_revision:1975; }","duration":"130.105101ms","start":"2026-03-08T13:25:01.918108Z","end":"2026-03-08T13:25:02.048214Z","steps":["trace[1415836249] 'agreement among raft nodes before linearized reading'  (duration: 128.766879ms)"],"step_count":1}
{"level":"info","ts":"2026-03-08T13:25:02.048177Z","caller":"traceutil/trace.go:171","msg":"trace[145781315] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:135; response_revision:1975; }","duration":"137.871906ms","start":"2026-03-08T13:25:01.910292Z","end":"2026-03-08T13:25:02.048164Z","steps":["trace[145781315] 'agreement among raft nodes before linearized reading'  (duration: 136.657748ms)"],"step_count":1}