{"level":"warn","ts":"2026-03-05T04:56:46.544283Z","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-05T04:56:46.544351Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-05T04:56:46.544405Z","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-05T04:56:46.544414Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-03-05T04:56:46.544434Z","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-05T04:56:46.545312Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]}
{"level":"info","ts":"2026-03-05T04:56:46.545404Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-05T04:56:46.548924Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.281414ms"}
{"level":"info","ts":"2026-03-05T04:56:46.564395Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"}
{"level":"info","ts":"2026-03-05T04:56:46.564484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-05T04:56:46.566165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"}
{"level":"info","ts":"2026-03-05T04:56:46.566194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-05T04:56:46.566204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"}
{"level":"info","ts":"2026-03-05T04:56:46.566292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"warn","ts":"2026-03-05T04:56:46.57474Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-05T04:56:46.576753Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-05T04:56:46.583882Z","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-05T04:56:46.586101Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-05T04:56:46.588936Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-05T04:56:46.589008Z","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-05T04:56:46.589078Z","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-05T04:56:46.589092Z","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-05T04:56:46.591581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"}
{"level":"info","ts":"2026-03-05T04:56:46.591725Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]}
{"level":"info","ts":"2026-03-05T04:56:46.591776Z","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-05T04:56:46.591858Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-03-05T04:56:46.591873Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"}
{"level":"info","ts":"2026-03-05T04:56:46.592127Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-05T04:56:46.592152Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-05T04:56:47.566917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-05T04:56:47.566986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-05T04:56:47.56702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"}
{"level":"info","ts":"2026-03-05T04:56:47.567039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"}
{"level":"info","ts":"2026-03-05T04:56:47.56705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-03-05T04:56:47.567079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"}
{"level":"info","ts":"2026-03-05T04:56:47.567106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"}
{"level":"info","ts":"2026-03-05T04:56:47.572543Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-05T04:56:47.572656Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-05T04:56:47.572614Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-05T04:56:47.572815Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T04:56:47.573074Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-05T04:56:47.573162Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-05T04:56:47.575234Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T04:56:47.575317Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T04:56:47.57535Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-05T04:56:47.576624Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"}
{"level":"info","ts":"2026-03-05T04:56:47.576896Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-03-05T04:56:57.224005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.107644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-05T04:56:57.224107Z","caller":"traceutil/trace.go:171","msg":"trace[2078496856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:344; }","duration":"115.277148ms","start":"2026-03-05T04:56:57.108813Z","end":"2026-03-05T04:56:57.22409Z","steps":["trace[2078496856] 'range keys from in-memory index tree'  (duration: 114.970811ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:56:57.224069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.026624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-03-05T04:56:57.224206Z","caller":"traceutil/trace.go:171","msg":"trace[896981173] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:344; }","duration":"124.168317ms","start":"2026-03-05T04:56:57.100001Z","end":"2026-03-05T04:56:57.22417Z","steps":["trace[896981173] 'range keys from in-memory index tree'  (duration: 123.88983ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:56:57.341735Z","caller":"traceutil/trace.go:171","msg":"trace[1946553723] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"109.977453ms","start":"2026-03-05T04:56:57.231733Z","end":"2026-03-05T04:56:57.34171Z","steps":["trace[1946553723] 'process raft request'  (duration: 109.497811ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:03.760847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.328143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-05T04:57:03.760947Z","caller":"traceutil/trace.go:171","msg":"trace[1872889616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:408; }","duration":"503.492897ms","start":"2026-03-05T04:57:03.257435Z","end":"2026-03-05T04:57:03.760927Z","steps":["trace[1872889616] 'range keys from in-memory index tree'  (duration: 503.155838ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:03.760992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:03.257409Z","time spent":"503.574539ms","remote":"127.0.0.1:56630","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-05T04:57:03.761289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.010406ms","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-05T04:57:03.761367Z","caller":"traceutil/trace.go:171","msg":"trace[961834292] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:408; }","duration":"696.116618ms","start":"2026-03-05T04:57:03.065229Z","end":"2026-03-05T04:57:03.761346Z","steps":["trace[961834292] 'range keys from in-memory index tree'  (duration: 695.898213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:03.761405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:03.065217Z","time spent":"696.17996ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-05T04:57:03.761567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096248383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:57:03.761593Z","caller":"traceutil/trace.go:171","msg":"trace[239239540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:408; }","duration":"1.096306225s","start":"2026-03-05T04:57:02.665278Z","end":"2026-03-05T04:57:03.761584Z","steps":["trace[239239540] 'range keys from in-memory index tree'  (duration: 1.096185901s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:03.761617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:02.665259Z","time spent":"1.096352446s","remote":"127.0.0.1:56342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T04:57:03.761747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.327203ms","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-05T04:57:03.761824Z","caller":"traceutil/trace.go:171","msg":"trace[1650019961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:408; }","duration":"741.414794ms","start":"2026-03-05T04:57:03.020369Z","end":"2026-03-05T04:57:03.761784Z","steps":["trace[1650019961] 'range keys from in-memory index tree'  (duration: 741.185838ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:03.761859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:03.020348Z","time spent":"741.501407ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-05T04:57:04.271132Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812301362194846,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-05T04:57:04.746069Z","caller":"traceutil/trace.go:171","msg":"trace[951272230] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"979.874235ms","start":"2026-03-05T04:57:03.766169Z","end":"2026-03-05T04:57:04.746043Z","steps":["trace[951272230] 'process raft request'  (duration: 979.736252ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:04.746639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:03.76615Z","time spent":"980.01713ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:404 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-05T04:57:05.063524Z","caller":"traceutil/trace.go:171","msg":"trace[1550709487] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:422; }","duration":"1.293193975s","start":"2026-03-05T04:57:03.770304Z","end":"2026-03-05T04:57:05.063498Z","steps":["trace[1550709487] 'read index received'  (duration: 975.604836ms)","trace[1550709487] 'applied index is now lower than readState.Index'  (duration: 317.588139ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:57:05.06365Z","caller":"traceutil/trace.go:171","msg":"trace[1555333016] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"1.296641453s","start":"2026-03-05T04:57:03.76698Z","end":"2026-03-05T04:57:05.063621Z","steps":["trace[1555333016] 'process raft request'  (duration: 1.296456389s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:05.06375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.918245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"}
{"level":"warn","ts":"2026-03-05T04:57:05.063763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.926393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T04:57:05.0638Z","caller":"traceutil/trace.go:171","msg":"trace[354234494] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:411; }","duration":"857.995507ms","start":"2026-03-05T04:57:04.205789Z","end":"2026-03-05T04:57:05.063785Z","steps":["trace[354234494] 'agreement among raft nodes before linearized reading'  (duration: 857.933955ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:05.063829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:03.766957Z","time spent":"1.296785408s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:402 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-05T04:57:05.063853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:04.205771Z","time spent":"858.070509ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4080,"request content":"key:\"/registry/deployments/kube-system/coredns\" "}
{"level":"warn","ts":"2026-03-05T04:57:05.063854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.240426ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:57:05.063808Z","caller":"traceutil/trace.go:171","msg":"trace[550890152] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"569.002144ms","start":"2026-03-05T04:57:04.494791Z","end":"2026-03-05T04:57:05.063794Z","steps":["trace[550890152] 'agreement among raft nodes before linearized reading'  (duration: 568.930672ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:05.063931Z","caller":"traceutil/trace.go:171","msg":"trace[1684248110] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:411; }","duration":"742.319948ms","start":"2026-03-05T04:57:04.321604Z","end":"2026-03-05T04:57:05.063924Z","steps":["trace[1684248110] 'agreement among raft nodes before linearized reading'  (duration: 742.233406ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:05.063688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.29336732s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T04:57:05.063969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:04.494772Z","time spent":"569.171219ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-05T04:57:05.064057Z","caller":"traceutil/trace.go:171","msg":"trace[1065589213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:411; }","duration":"1.293808431s","start":"2026-03-05T04:57:03.770183Z","end":"2026-03-05T04:57:05.063992Z","steps":["trace[1065589213] 'agreement among raft nodes before linearized reading'  (duration: 1.293457502s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:05.064134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:03.770133Z","time spent":"1.293983395s","remote":"127.0.0.1:56342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-05T04:57:05.063569Z","caller":"traceutil/trace.go:171","msg":"trace[884590713] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"1.297232219s","start":"2026-03-05T04:57:03.766294Z","end":"2026-03-05T04:57:05.063526Z","steps":["trace[884590713] 'process raft request'  (duration: 1.297007893s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:05.064431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:03.766278Z","time spent":"1.29805135s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:403 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-05T04:57:05.250318Z","caller":"traceutil/trace.go:171","msg":"trace[452509880] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"170.420249ms","start":"2026-03-05T04:57:05.079869Z","end":"2026-03-05T04:57:05.250289Z","steps":["trace[452509880] 'process raft request'  (duration: 170.346727ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:05.250385Z","caller":"traceutil/trace.go:171","msg":"trace[1661415449] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"175.304464ms","start":"2026-03-05T04:57:05.075047Z","end":"2026-03-05T04:57:05.250352Z","steps":["trace[1661415449] 'process raft request'  (duration: 174.998837ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:11.399097Z","caller":"traceutil/trace.go:171","msg":"trace[745396865] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"239.18617ms","start":"2026-03-05T04:57:11.159882Z","end":"2026-03-05T04:57:11.399068Z","steps":["trace[745396865] 'process raft request'  (duration: 239.010236ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:19.873148Z","caller":"traceutil/trace.go:171","msg":"trace[309067135] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"208.551491ms","start":"2026-03-05T04:57:19.66457Z","end":"2026-03-05T04:57:19.873121Z","steps":["trace[309067135] 'read index received'  (duration: 129.196808ms)","trace[309067135] 'applied index is now lower than readState.Index'  (duration: 79.353443ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:57:19.873507Z","caller":"traceutil/trace.go:171","msg":"trace[1064783082] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"236.48329ms","start":"2026-03-05T04:57:19.636986Z","end":"2026-03-05T04:57:19.873469Z","steps":["trace[1064783082] 'process raft request'  (duration: 156.847929ms)","trace[1064783082] 'compare'  (duration: 79.148838ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:57:19.873557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.976852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:57:19.873599Z","caller":"traceutil/trace.go:171","msg":"trace[1346649231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"209.064574ms","start":"2026-03-05T04:57:19.664523Z","end":"2026-03-05T04:57:19.873587Z","steps":["trace[1346649231] 'agreement among raft nodes before linearized reading'  (duration: 208.981052ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:20.177266Z","caller":"traceutil/trace.go:171","msg":"trace[405877599] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"294.085913ms","start":"2026-03-05T04:57:19.883113Z","end":"2026-03-05T04:57:20.177198Z","steps":["trace[405877599] 'process raft request'  (duration: 251.952619ms)","trace[405877599] 'compare'  (duration: 41.9748ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:57:21.817528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.770811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:57:21.817619Z","caller":"traceutil/trace.go:171","msg":"trace[1562573666] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:516; }","duration":"152.923545ms","start":"2026-03-05T04:57:21.664672Z","end":"2026-03-05T04:57:21.817595Z","steps":["trace[1562573666] 'range keys from in-memory index tree'  (duration: 152.68524ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:27.09834Z","caller":"traceutil/trace.go:171","msg":"trace[2144521309] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:549; }","duration":"432.75476ms","start":"2026-03-05T04:57:26.665564Z","end":"2026-03-05T04:57:27.098319Z","steps":["trace[2144521309] 'read index received'  (duration: 432.550675ms)","trace[2144521309] 'applied index is now lower than readState.Index'  (duration: 203.225µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:57:27.09841Z","caller":"traceutil/trace.go:171","msg":"trace[136097179] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"708.583143ms","start":"2026-03-05T04:57:26.389789Z","end":"2026-03-05T04:57:27.098372Z","steps":["trace[136097179] 'process raft request'  (duration: 708.388468ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:27.098513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.920715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T04:57:27.098581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.788185ms","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-05T04:57:27.098591Z","caller":"traceutil/trace.go:171","msg":"trace[1514076676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"433.051498ms","start":"2026-03-05T04:57:26.665521Z","end":"2026-03-05T04:57:27.098572Z","steps":["trace[1514076676] 'agreement among raft nodes before linearized reading'  (duration: 432.920915ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:27.098594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:26.389766Z","time spent":"708.726927ms","remote":"127.0.0.1:56540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-nxh72\" mod_revision:500 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-nxh72\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-nxh72\" > >"}
{"level":"info","ts":"2026-03-05T04:57:27.098622Z","caller":"traceutil/trace.go:171","msg":"trace[589893751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:529; }","duration":"240.872998ms","start":"2026-03-05T04:57:26.857732Z","end":"2026-03-05T04:57:27.098605Z","steps":["trace[589893751] 'agreement among raft nodes before linearized reading'  (duration: 240.736914ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:27.09864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:26.665498Z","time spent":"433.13413ms","remote":"127.0.0.1:56342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T04:57:27.477825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.981333ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:57:27.477946Z","caller":"traceutil/trace.go:171","msg":"trace[555272138] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:531; }","duration":"129.126056ms","start":"2026-03-05T04:57:27.348803Z","end":"2026-03-05T04:57:27.477929Z","steps":["trace[555272138] 'range keys from in-memory index tree'  (duration: 128.962312ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:28.023556Z","caller":"traceutil/trace.go:171","msg":"trace[793086848] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:552; }","duration":"497.749995ms","start":"2026-03-05T04:57:27.52578Z","end":"2026-03-05T04:57:28.02353Z","steps":["trace[793086848] 'read index received'  (duration: 497.603991ms)","trace[793086848] 'applied index is now lower than readState.Index'  (duration: 144.994µs)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:57:28.02361Z","caller":"traceutil/trace.go:171","msg":"trace[414981749] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"821.562125ms","start":"2026-03-05T04:57:27.202028Z","end":"2026-03-05T04:57:28.02359Z","steps":["trace[414981749] 'process raft request'  (duration: 821.351579ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:28.023724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:27.202006Z","time spent":"821.650437ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:523 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-05T04:57:28.023794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.001641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T04:57:28.02385Z","caller":"traceutil/trace.go:171","msg":"trace[747171434] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:532; }","duration":"498.102014ms","start":"2026-03-05T04:57:27.525733Z","end":"2026-03-05T04:57:28.023835Z","steps":["trace[747171434] 'agreement among raft nodes before linearized reading'  (duration: 497.932179ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:28.023864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.210821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:57:28.023896Z","caller":"traceutil/trace.go:171","msg":"trace[1578288373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"358.276973ms","start":"2026-03-05T04:57:27.665609Z","end":"2026-03-05T04:57:28.023886Z","steps":["trace[1578288373] 'agreement among raft nodes before linearized reading'  (duration: 358.227632ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:28.023899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:27.52571Z","time spent":"498.177346ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-05T04:57:28.023921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:27.665588Z","time spent":"358.327155ms","remote":"127.0.0.1:56342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-05T04:57:28.757525Z","caller":"traceutil/trace.go:171","msg":"trace[422591421] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"729.711174ms","start":"2026-03-05T04:57:28.027716Z","end":"2026-03-05T04:57:28.757427Z","steps":["trace[422591421] 'process raft request'  (duration: 721.248217ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:28.757711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:28.027696Z","time spent":"729.912868ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:525 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-05T04:57:48.350838Z","caller":"traceutil/trace.go:171","msg":"trace[855448024] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"195.116996ms","start":"2026-03-05T04:57:48.1557Z","end":"2026-03-05T04:57:48.350817Z","steps":["trace[855448024] 'process raft request'  (duration: 195.012563ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:49.143376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.502343ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362195463 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:716 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T04:57:49.143484Z","caller":"traceutil/trace.go:171","msg":"trace[1775510862] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:748; }","duration":"305.682565ms","start":"2026-03-05T04:57:48.837786Z","end":"2026-03-05T04:57:49.143468Z","steps":["trace[1775510862] 'read index received'  (duration: 20.440303ms)","trace[1775510862] 'applied index is now lower than readState.Index'  (duration: 285.240712ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:57:49.14357Z","caller":"traceutil/trace.go:171","msg":"trace[1833170267] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"771.76781ms","start":"2026-03-05T04:57:48.371792Z","end":"2026-03-05T04:57:49.14356Z","steps":["trace[1833170267] 'process raft request'  (duration: 486.431645ms)","trace[1833170267] 'compare'  (duration: 284.311469ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:57:49.14363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:48.371779Z","time spent":"771.817891ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:716 > 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-05T04:57:49.143847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.044305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T04:57:49.143943Z","caller":"traceutil/trace.go:171","msg":"trace[169191535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:721; }","duration":"306.177338ms","start":"2026-03-05T04:57:48.83774Z","end":"2026-03-05T04:57:49.143917Z","steps":["trace[169191535] 'agreement among raft nodes before linearized reading'  (duration: 305.897091ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:49.144016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:48.837716Z","time spent":"306.285121ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-05T04:57:49.580018Z","caller":"traceutil/trace.go:171","msg":"trace[1813037095] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:749; }","duration":"261.452004ms","start":"2026-03-05T04:57:49.318538Z","end":"2026-03-05T04:57:49.57999Z","steps":["trace[1813037095] 'read index received'  (duration: 256.474367ms)","trace[1813037095] 'applied index is now lower than readState.Index'  (duration: 4.976547ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:57:49.580159Z","caller":"traceutil/trace.go:171","msg":"trace[1890128173] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"433.246653ms","start":"2026-03-05T04:57:49.146888Z","end":"2026-03-05T04:57:49.580134Z","steps":["trace[1890128173] 'process raft request'  (duration: 428.180123ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:49.580271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:49.146872Z","time spent":"433.321985ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:717 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-05T04:57:49.58028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.042032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-05T04:57:49.580353Z","caller":"traceutil/trace.go:171","msg":"trace[1333482676] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:722; }","duration":"216.159295ms","start":"2026-03-05T04:57:49.364174Z","end":"2026-03-05T04:57:49.580333Z","steps":["trace[1333482676] 'agreement among raft nodes before linearized reading'  (duration: 215.97943ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:49.58091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.351338ms","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-05T04:57:49.581125Z","caller":"traceutil/trace.go:171","msg":"trace[1682490932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:722; }","duration":"262.601764ms","start":"2026-03-05T04:57:49.318502Z","end":"2026-03-05T04:57:49.581104Z","steps":["trace[1682490932] 'agreement among raft nodes before linearized reading'  (duration: 261.868225ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:50.045029Z","caller":"traceutil/trace.go:171","msg":"trace[1970468698] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"461.408405ms","start":"2026-03-05T04:57:49.583594Z","end":"2026-03-05T04:57:50.045002Z","steps":["trace[1970468698] 'process raft request'  (duration: 393.742382ms)","trace[1970468698] 'compare'  (duration: 67.281703ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:57:50.045167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:49.583573Z","time spent":"461.521587ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:719 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-05T04:57:50.138414Z","caller":"traceutil/trace.go:171","msg":"trace[616668025] linearizableReadLoop","detail":"{readStateIndex:752; appliedIndex:750; }","duration":"540.570981ms","start":"2026-03-05T04:57:49.59782Z","end":"2026-03-05T04:57:50.138391Z","steps":["trace[616668025] 'read index received'  (duration: 379.530288ms)","trace[616668025] 'applied index is now lower than readState.Index'  (duration: 161.039483ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:57:50.138502Z","caller":"traceutil/trace.go:171","msg":"trace[89519009] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"553.209165ms","start":"2026-03-05T04:57:49.58524Z","end":"2026-03-05T04:57:50.138449Z","steps":["trace[89519009] 'process raft request'  (duration: 553.032291ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:50.138553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.717994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:57:50.138593Z","caller":"traceutil/trace.go:171","msg":"trace[170225557] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:724; }","duration":"540.804767ms","start":"2026-03-05T04:57:49.597776Z","end":"2026-03-05T04:57:50.138581Z","steps":["trace[170225557] 'agreement among raft nodes before linearized reading'  (duration: 540.724045ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:50.138628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:49.597758Z","time spent":"540.860669ms","remote":"127.0.0.1:56798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"warn","ts":"2026-03-05T04:57:50.138685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:49.585233Z","time spent":"553.353539ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:718 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-05T04:57:50.138795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.532205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:57:50.138891Z","caller":"traceutil/trace.go:171","msg":"trace[1163359842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:724; }","duration":"475.648709ms","start":"2026-03-05T04:57:49.663215Z","end":"2026-03-05T04:57:50.138863Z","steps":["trace[1163359842] 'agreement among raft nodes before linearized reading'  (duration: 475.506075ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:50.13894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:49.663202Z","time spent":"475.727011ms","remote":"127.0.0.1:56342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T04:57:50.855426Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812301362195473,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-05T04:57:50.873777Z","caller":"traceutil/trace.go:171","msg":"trace[1946394865] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"538.264282ms","start":"2026-03-05T04:57:50.335496Z","end":"2026-03-05T04:57:50.87376Z","steps":["trace[1946394865] 'process raft request'  (duration: 538.163599ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:50.873892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:50.335472Z","time spent":"538.360854ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:644 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-05T04:57:51.391578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.000293ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362195476 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:41f79cbc5b00ec13>","response":"size:42"}
{"level":"info","ts":"2026-03-05T04:57:51.39167Z","caller":"traceutil/trace.go:171","msg":"trace[1070560746] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:752; }","duration":"1.037124105s","start":"2026-03-05T04:57:50.354529Z","end":"2026-03-05T04:57:51.391653Z","steps":["trace[1070560746] 'read index received'  (duration: 519.177123ms)","trace[1070560746] 'applied index is now lower than readState.Index'  (duration: 517.945372ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:57:51.391758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:50.718727Z","time spent":"673.029472ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-05T04:57:51.391996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.73975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-03-05T04:57:51.391996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.943166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-05T04:57:51.392072Z","caller":"traceutil/trace.go:171","msg":"trace[245727391] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:725; }","duration":"928.848613ms","start":"2026-03-05T04:57:50.463207Z","end":"2026-03-05T04:57:51.392055Z","steps":["trace[245727391] 'agreement among raft nodes before linearized reading'  (duration: 928.630137ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:51.392075Z","caller":"traceutil/trace.go:171","msg":"trace[1062103972] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:725; }","duration":"244.075019ms","start":"2026-03-05T04:57:51.147987Z","end":"2026-03-05T04:57:51.392062Z","steps":["trace[1062103972] 'agreement among raft nodes before linearized reading'  (duration: 243.894584ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:51.392095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037553085s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-05T04:57:51.392102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.140927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T04:57:51.392118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:50.463193Z","time spent":"928.917314ms","remote":"127.0.0.1:56380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.204\" "}
{"level":"info","ts":"2026-03-05T04:57:51.392129Z","caller":"traceutil/trace.go:171","msg":"trace[259244068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:725; }","duration":"1.037615047s","start":"2026-03-05T04:57:50.354503Z","end":"2026-03-05T04:57:51.392118Z","steps":["trace[259244068] 'agreement among raft nodes before linearized reading'  (duration: 1.037480284s)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:57:51.392151Z","caller":"traceutil/trace.go:171","msg":"trace[1973250332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:725; }","duration":"725.229349ms","start":"2026-03-05T04:57:50.666911Z","end":"2026-03-05T04:57:51.39214Z","steps":["trace[1973250332] 'agreement among raft nodes before linearized reading'  (duration: 725.139277ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:57:51.392163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:50.354492Z","time spent":"1.037664078s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-05T04:57:51.392178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:57:50.666896Z","time spent":"725.27739ms","remote":"127.0.0.1:56342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T04:58:11.68312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.639356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-05T04:58:11.683138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.511298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-05T04:58:11.683211Z","caller":"traceutil/trace.go:171","msg":"trace[1815913873] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:790; }","duration":"131.642141ms","start":"2026-03-05T04:58:11.551556Z","end":"2026-03-05T04:58:11.683198Z","steps":["trace[1815913873] 'range keys from in-memory index tree'  (duration: 131.348984ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:11.683207Z","caller":"traceutil/trace.go:171","msg":"trace[1527300471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:790; }","duration":"116.78686ms","start":"2026-03-05T04:58:11.566403Z","end":"2026-03-05T04:58:11.68319Z","steps":["trace[1527300471] 'range keys from in-memory index tree'  (duration: 116.448372ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:12.043615Z","caller":"traceutil/trace.go:171","msg":"trace[1791632469] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"356.293073ms","start":"2026-03-05T04:58:11.687299Z","end":"2026-03-05T04:58:12.043592Z","steps":["trace[1791632469] 'process raft request'  (duration: 356.114558ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:12.043766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:11.687275Z","time spent":"356.411186ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:785 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-05T04:58:12.806777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.508805ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362195675 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:784 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T04:58:12.806881Z","caller":"traceutil/trace.go:171","msg":"trace[1244445273] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:825; }","duration":"1.071353581s","start":"2026-03-05T04:58:11.735511Z","end":"2026-03-05T04:58:12.806864Z","steps":["trace[1244445273] 'read index received'  (duration: 307.939574ms)","trace[1244445273] 'applied index is now lower than readState.Index'  (duration: 763.412707ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:58:12.807045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.130729ms","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-05T04:58:12.80705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.071542486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T04:58:12.807071Z","caller":"traceutil/trace.go:171","msg":"trace[1497762095] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"663.196591ms","start":"2026-03-05T04:58:12.143865Z","end":"2026-03-05T04:58:12.807062Z","steps":["trace[1497762095] 'agreement among raft nodes before linearized reading'  (duration: 663.087238ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:12.807095Z","caller":"traceutil/trace.go:171","msg":"trace[1095575507] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:792; }","duration":"1.071646598s","start":"2026-03-05T04:58:11.735437Z","end":"2026-03-05T04:58:12.807083Z","steps":["trace[1095575507] 'agreement among raft nodes before linearized reading'  (duration: 1.071509635s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:12.807109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:12.143845Z","time spent":"663.257173ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-05T04:58:12.807138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:11.735418Z","time spent":"1.07170136s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-05T04:58:12.80722Z","caller":"traceutil/trace.go:171","msg":"trace[1857463035] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"1.119095054s","start":"2026-03-05T04:58:11.688114Z","end":"2026-03-05T04:58:12.807209Z","steps":["trace[1857463035] 'process raft request'  (duration: 593.068415ms)","trace[1857463035] 'compare'  (duration: 525.239238ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:58:12.807281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:11.688088Z","time spent":"1.119156425s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:784 > 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-05T04:58:12.807293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.35684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:58:12.807318Z","caller":"traceutil/trace.go:171","msg":"trace[809423883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:792; }","duration":"141.426961ms","start":"2026-03-05T04:58:12.665884Z","end":"2026-03-05T04:58:12.80731Z","steps":["trace[809423883] 'agreement among raft nodes before linearized reading'  (duration: 141.38993ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:12.807604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.125292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-05T04:58:12.807702Z","caller":"traceutil/trace.go:171","msg":"trace[420614801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"576.284396ms","start":"2026-03-05T04:58:12.231397Z","end":"2026-03-05T04:58:12.807681Z","steps":["trace[420614801] 'agreement among raft nodes before linearized reading'  (duration: 575.979388ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:12.807756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:12.231373Z","time spent":"576.368807ms","remote":"127.0.0.1:56630","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-05T04:58:12.995978Z","caller":"traceutil/trace.go:171","msg":"trace[822415497] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"185.054058ms","start":"2026-03-05T04:58:12.810896Z","end":"2026-03-05T04:58:12.99595Z","steps":["trace[822415497] 'process raft request'  (duration: 184.961236ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:12.99598Z","caller":"traceutil/trace.go:171","msg":"trace[178079901] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"185.211612ms","start":"2026-03-05T04:58:12.810738Z","end":"2026-03-05T04:58:12.99595Z","steps":["trace[178079901] 'process raft request'  (duration: 105.094791ms)","trace[178079901] 'compare'  (duration: 79.777883ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:58:12.996134Z","caller":"traceutil/trace.go:171","msg":"trace[671877889] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"184.077774ms","start":"2026-03-05T04:58:12.812017Z","end":"2026-03-05T04:58:12.996095Z","steps":["trace[671877889] 'process raft request'  (duration: 183.899819ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:14.041255Z","caller":"traceutil/trace.go:171","msg":"trace[1962784677] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"105.162942ms","start":"2026-03-05T04:58:13.936069Z","end":"2026-03-05T04:58:14.041232Z","steps":["trace[1962784677] 'process raft request'  (duration: 104.947026ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:14.611153Z","caller":"traceutil/trace.go:171","msg":"trace[2139065608] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"560.748707ms","start":"2026-03-05T04:58:14.050381Z","end":"2026-03-05T04:58:14.61113Z","steps":["trace[2139065608] 'process raft request'  (duration: 560.616124ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:14.611312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:14.050357Z","time spent":"560.867271ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:791 > 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-05T04:58:15.27655Z","caller":"traceutil/trace.go:171","msg":"trace[558919008] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:833; }","duration":"276.618933ms","start":"2026-03-05T04:58:14.999893Z","end":"2026-03-05T04:58:15.276512Z","steps":["trace[558919008] 'read index received'  (duration: 276.605083ms)","trace[558919008] 'applied index is now lower than readState.Index'  (duration: 10.54µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:58:15.276839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.920701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-05T04:58:15.276938Z","caller":"traceutil/trace.go:171","msg":"trace[1680548257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"277.050304ms","start":"2026-03-05T04:58:14.999858Z","end":"2026-03-05T04:58:15.276908Z","steps":["trace[1680548257] 'agreement among raft nodes before linearized reading'  (duration: 276.777357ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:15.276963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.518601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T04:58:15.277037Z","caller":"traceutil/trace.go:171","msg":"trace[435188875] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"276.617203ms","start":"2026-03-05T04:58:15.000377Z","end":"2026-03-05T04:58:15.276995Z","steps":["trace[435188875] 'agreement among raft nodes before linearized reading'  (duration: 276.347026ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:15.277062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.175181ms","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-05T04:58:15.277147Z","caller":"traceutil/trace.go:171","msg":"trace[685545137] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:798; }","duration":"276.290914ms","start":"2026-03-05T04:58:15.000838Z","end":"2026-03-05T04:58:15.277129Z","steps":["trace[685545137] 'agreement among raft nodes before linearized reading'  (duration: 275.975936ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:15.276475Z","caller":"traceutil/trace.go:171","msg":"trace[521249645] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"459.699211ms","start":"2026-03-05T04:58:14.816752Z","end":"2026-03-05T04:58:15.276451Z","steps":["trace[521249645] 'process raft request'  (duration: 459.532856ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:15.2776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:14.816729Z","time spent":"460.703746ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:792 > 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-05T04:58:15.54281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.981025ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362195691 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:795 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T04:58:15.543049Z","caller":"traceutil/trace.go:171","msg":"trace[1397603786] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"260.287984ms","start":"2026-03-05T04:58:15.282743Z","end":"2026-03-05T04:58:15.543031Z","steps":["trace[1397603786] 'process raft request'  (duration: 260.247043ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:15.543026Z","caller":"traceutil/trace.go:171","msg":"trace[727830003] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"261.073325ms","start":"2026-03-05T04:58:15.281928Z","end":"2026-03-05T04:58:15.543001Z","steps":["trace[727830003] 'process raft request'  (duration: 77.792352ms)","trace[727830003] 'compare'  (duration: 182.77999ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:58:15.543352Z","caller":"traceutil/trace.go:171","msg":"trace[1183977752] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"261.406063ms","start":"2026-03-05T04:58:15.281934Z","end":"2026-03-05T04:58:15.54334Z","steps":["trace[1183977752] 'process raft request'  (duration: 260.978932ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:26.997855Z","caller":"traceutil/trace.go:171","msg":"trace[1918646446] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"339.296615ms","start":"2026-03-05T04:58:26.658534Z","end":"2026-03-05T04:58:26.997831Z","steps":["trace[1918646446] 'process raft request'  (duration: 339.12895ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:26.99801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:26.658523Z","time spent":"339.411727ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:876 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-05T04:58:31.847095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812301362195909,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-05T04:58:31.950322Z","caller":"traceutil/trace.go:171","msg":"trace[423536849] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"934.402054ms","start":"2026-03-05T04:58:31.015897Z","end":"2026-03-05T04:58:31.950299Z","steps":["trace[423536849] 'process raft request'  (duration: 934.26684ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:31.95046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:31.015878Z","time spent":"934.512426ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:886 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-05T04:58:32.850719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.15911ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362195911 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:818 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T04:58:32.850845Z","caller":"traceutil/trace.go:171","msg":"trace[439172016] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:931; }","duration":"1.504100252s","start":"2026-03-05T04:58:31.346725Z","end":"2026-03-05T04:58:32.850825Z","steps":["trace[439172016] 'read index received'  (duration: 603.433241ms)","trace[439172016] 'applied index is now lower than readState.Index'  (duration: 900.665541ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:58:32.850862Z","caller":"traceutil/trace.go:171","msg":"trace[1854342031] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"1.066886881s","start":"2026-03-05T04:58:31.783948Z","end":"2026-03-05T04:58:32.850835Z","steps":["trace[1854342031] 'process raft request'  (duration: 634.277739ms)","trace[1854342031] 'compare'  (duration: 431.807841ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:58:32.851024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23080838s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-05T04:58:32.85107Z","caller":"traceutil/trace.go:171","msg":"trace[1524229049] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:893; }","duration":"1.230932183s","start":"2026-03-05T04:58:31.620127Z","end":"2026-03-05T04:58:32.851059Z","steps":["trace[1524229049] 'agreement among raft nodes before linearized reading'  (duration: 1.23080355s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:32.85112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:31.620107Z","time spent":"1.231005876s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-05T04:58:32.851118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.216925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-05T04:58:32.851017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:31.783925Z","time spent":"1.067007933s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:818 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-05T04:58:32.85117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.115849122s","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-05T04:58:32.851193Z","caller":"traceutil/trace.go:171","msg":"trace[1505999787] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:893; }","duration":"927.39837ms","start":"2026-03-05T04:58:31.923776Z","end":"2026-03-05T04:58:32.851175Z","steps":["trace[1505999787] 'agreement among raft nodes before linearized reading'  (duration: 927.180614ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:32.851221Z","caller":"traceutil/trace.go:171","msg":"trace[782394770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:893; }","duration":"1.115941964s","start":"2026-03-05T04:58:31.735269Z","end":"2026-03-05T04:58:32.851211Z","steps":["trace[782394770] 'agreement among raft nodes before linearized reading'  (duration: 1.11578888s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:32.851247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:31.923755Z","time spent":"927.476882ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":105,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-03-05T04:58:32.851259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:31.735216Z","time spent":"1.116035697s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-05T04:58:32.851263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.618792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-05T04:58:32.851271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174846956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T04:58:32.851308Z","caller":"traceutil/trace.go:171","msg":"trace[1687952738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:893; }","duration":"184.802177ms","start":"2026-03-05T04:58:32.666495Z","end":"2026-03-05T04:58:32.851297Z","steps":["trace[1687952738] 'agreement among raft nodes before linearized reading'  (duration: 184.627812ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:32.851352Z","caller":"traceutil/trace.go:171","msg":"trace[1126669720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:893; }","duration":"1.174959158s","start":"2026-03-05T04:58:31.676367Z","end":"2026-03-05T04:58:32.851326Z","steps":["trace[1126669720] 'agreement among raft nodes before linearized reading'  (duration: 1.174793464s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:32.851383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:31.676345Z","time spent":"1.175032401s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-05T04:58:32.851597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.504874543s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-05T04:58:32.851647Z","caller":"traceutil/trace.go:171","msg":"trace[2030169255] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:893; }","duration":"1.504977756s","start":"2026-03-05T04:58:31.346657Z","end":"2026-03-05T04:58:32.851635Z","steps":["trace[2030169255] 'agreement among raft nodes before linearized reading'  (duration: 1.504230006s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:32.851684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:31.346628Z","time spent":"1.505048468s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-05T04:58:45.117148Z","caller":"traceutil/trace.go:171","msg":"trace[1015361602] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"115.898743ms","start":"2026-03-05T04:58:45.00122Z","end":"2026-03-05T04:58:45.117119Z","steps":["trace[1015361602] 'process raft request'  (duration: 104.463804ms)","trace[1015361602] 'compare'  (duration: 11.122541ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:58:45.11727Z","caller":"traceutil/trace.go:171","msg":"trace[697286213] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"115.934744ms","start":"2026-03-05T04:58:45.001297Z","end":"2026-03-05T04:58:45.117232Z","steps":["trace[697286213] 'process raft request'  (duration: 115.740329ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:50.312076Z","caller":"traceutil/trace.go:171","msg":"trace[511787655] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"129.457368ms","start":"2026-03-05T04:58:50.182593Z","end":"2026-03-05T04:58:50.312051Z","steps":["trace[511787655] 'process raft request'  (duration: 129.283524ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:50.687174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.91462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-05T04:58:50.687246Z","caller":"traceutil/trace.go:171","msg":"trace[1247241216] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:962; }","duration":"221.030793ms","start":"2026-03-05T04:58:50.466197Z","end":"2026-03-05T04:58:50.687228Z","steps":["trace[1247241216] 'range keys from in-memory index tree'  (duration: 220.768336ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:50.902458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.079495ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362196076 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.204\" mod_revision:915 > success:<request_put:<key:\"/registry/masterleases/162.253.55.204\" value_size:67 lease:4753440264507420265 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.204\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T04:58:50.902567Z","caller":"traceutil/trace.go:171","msg":"trace[1403496825] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"136.921063ms","start":"2026-03-05T04:58:50.765628Z","end":"2026-03-05T04:58:50.902549Z","steps":["trace[1403496825] 'process raft request'  (duration: 35.667683ms)","trace[1403496825] 'compare'  (duration: 100.912261ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:58:52.093002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075730643s","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-05T04:58:52.093077Z","caller":"traceutil/trace.go:171","msg":"trace[1793765127] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:963; }","duration":"1.075823036s","start":"2026-03-05T04:58:51.017236Z","end":"2026-03-05T04:58:52.093059Z","steps":["trace[1793765127] 'range keys from in-memory index tree'  (duration: 1.075505968s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.093052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060340141s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-03-05T04:58:52.093102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.323404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"warn","ts":"2026-03-05T04:58:52.093123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:51.017223Z","time spent":"1.075891587s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-05T04:58:52.093134Z","caller":"traceutil/trace.go:171","msg":"trace[1245441661] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:963; }","duration":"955.398456ms","start":"2026-03-05T04:58:51.137728Z","end":"2026-03-05T04:58:52.093126Z","steps":["trace[1245441661] 'range keys from in-memory index tree'  (duration: 955.19759ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:52.093137Z","caller":"traceutil/trace.go:171","msg":"trace[166159044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:963; }","duration":"1.060457055s","start":"2026-03-05T04:58:51.032663Z","end":"2026-03-05T04:58:52.09312Z","steps":["trace[166159044] 'range keys from in-memory index tree'  (duration: 1.060196917s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.093158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:51.137706Z","time spent":"955.446536ms","remote":"127.0.0.1:56630","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-05T04:58:52.093171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:51.032652Z","time spent":"1.060511626s","remote":"127.0.0.1:56630","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-05T04:58:52.093288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.531114ms","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-05T04:58:52.093363Z","caller":"traceutil/trace.go:171","msg":"trace[1431798922] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:963; }","duration":"951.635546ms","start":"2026-03-05T04:58:51.14171Z","end":"2026-03-05T04:58:52.093346Z","steps":["trace[1431798922] 'range keys from in-memory index tree'  (duration: 951.391191ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.093408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:51.141701Z","time spent":"951.699189ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-05T04:58:52.092779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.969975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:58:52.093821Z","caller":"traceutil/trace.go:171","msg":"trace[1918059821] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:963; }","duration":"427.675713ms","start":"2026-03-05T04:58:51.665768Z","end":"2026-03-05T04:58:52.093444Z","steps":["trace[1918059821] 'range keys from in-memory index tree'  (duration: 426.863341ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.093928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:51.665706Z","time spent":"428.208936ms","remote":"127.0.0.1:56342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-05T04:58:52.596464Z","caller":"traceutil/trace.go:171","msg":"trace[1602402556] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"500.338584ms","start":"2026-03-05T04:58:52.096103Z","end":"2026-03-05T04:58:52.596441Z","steps":["trace[1602402556] 'process raft request'  (duration: 500.19786ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.596611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:52.096088Z","time spent":"500.447467ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:956 > 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-05T04:58:52.618168Z","caller":"traceutil/trace.go:171","msg":"trace[1340521335] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1007; }","duration":"425.519475ms","start":"2026-03-05T04:58:52.192625Z","end":"2026-03-05T04:58:52.618144Z","steps":["trace[1340521335] 'read index received'  (duration: 403.756406ms)","trace[1340521335] 'applied index is now lower than readState.Index'  (duration: 21.761839ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:58:52.61848Z","caller":"traceutil/trace.go:171","msg":"trace[168230175] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"521.413505ms","start":"2026-03-05T04:58:52.097056Z","end":"2026-03-05T04:58:52.618469Z","steps":["trace[168230175] 'process raft request'  (duration: 520.86659ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.618586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:52.097048Z","time spent":"521.467397ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:957 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-05T04:58:52.618755Z","caller":"traceutil/trace.go:171","msg":"trace[1996430605] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"521.701183ms","start":"2026-03-05T04:58:52.097042Z","end":"2026-03-05T04:58:52.618744Z","steps":["trace[1996430605] 'process raft request'  (duration: 520.996835ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.618803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:52.097022Z","time spent":"521.754304ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:959 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-05T04:58:52.618928Z","caller":"traceutil/trace.go:171","msg":"trace[1074449295] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"521.545609ms","start":"2026-03-05T04:58:52.097374Z","end":"2026-03-05T04:58:52.61892Z","steps":["trace[1074449295] 'process raft request'  (duration: 520.728917ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.618975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:52.097369Z","time spent":"521.580249ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:958 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-05T04:58:52.619108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.482631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-05T04:58:52.61914Z","caller":"traceutil/trace.go:171","msg":"trace[190132549] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:967; }","duration":"426.554643ms","start":"2026-03-05T04:58:52.192575Z","end":"2026-03-05T04:58:52.61913Z","steps":["trace[190132549] 'agreement among raft nodes before linearized reading'  (duration: 426.497912ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.619174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:52.192539Z","time spent":"426.625035ms","remote":"127.0.0.1:56788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":31,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"warn","ts":"2026-03-05T04:58:52.619386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.917714ms","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-05T04:58:52.619413Z","caller":"traceutil/trace.go:171","msg":"trace[1180815576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:967; }","duration":"303.985705ms","start":"2026-03-05T04:58:52.315419Z","end":"2026-03-05T04:58:52.619405Z","steps":["trace[1180815576] 'agreement among raft nodes before linearized reading'  (duration: 303.883293ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:52.619437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:52.315398Z","time spent":"304.033827ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-05T04:58:54.991766Z","caller":"traceutil/trace.go:171","msg":"trace[529341405] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"365.036255ms","start":"2026-03-05T04:58:54.626709Z","end":"2026-03-05T04:58:54.991745Z","steps":["trace[529341405] 'read index received'  (duration: 364.951902ms)","trace[529341405] 'applied index is now lower than readState.Index'  (duration: 83.573µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:58:54.991983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.262761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-03-05T04:58:54.992018Z","caller":"traceutil/trace.go:171","msg":"trace[96168166] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:970; }","duration":"365.346014ms","start":"2026-03-05T04:58:54.626665Z","end":"2026-03-05T04:58:54.992011Z","steps":["trace[96168166] 'agreement among raft nodes before linearized reading'  (duration: 365.171689ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:54.992045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:54.626647Z","time spent":"365.391864ms","remote":"127.0.0.1:56630","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-05T04:58:54.991797Z","caller":"traceutil/trace.go:171","msg":"trace[1684223850] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"387.455322ms","start":"2026-03-05T04:58:54.604326Z","end":"2026-03-05T04:58:54.991782Z","steps":["trace[1684223850] 'process raft request'  (duration: 387.295107ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:54.992381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:54.6043Z","time spent":"388.038637ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:964 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-05T04:58:55.492346Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812301362196103,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-05T04:58:55.690511Z","caller":"traceutil/trace.go:171","msg":"trace[528163959] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"947.94279ms","start":"2026-03-05T04:58:54.742544Z","end":"2026-03-05T04:58:55.690486Z","steps":["trace[528163959] 'process raft request'  (duration: 947.887678ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:55.690534Z","caller":"traceutil/trace.go:171","msg":"trace[270949388] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"1.009126431s","start":"2026-03-05T04:58:54.681381Z","end":"2026-03-05T04:58:55.690507Z","steps":["trace[270949388] 'process raft request'  (duration: 1.008862174s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:55.690675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:54.681351Z","time spent":"1.009250725s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:927 > 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-05T04:58:55.690677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:54.742525Z","time spent":"948.068792ms","remote":"127.0.0.1:56524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5736,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:960 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5702 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-05T04:58:56.493583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.201644ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362196104 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:967 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T04:58:56.493657Z","caller":"traceutil/trace.go:171","msg":"trace[1265033740] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1014; }","duration":"1.501816685s","start":"2026-03-05T04:58:54.991828Z","end":"2026-03-05T04:58:56.493645Z","steps":["trace[1265033740] 'read index received'  (duration: 698.441299ms)","trace[1265033740] 'applied index is now lower than readState.Index'  (duration: 803.374576ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:58:56.493704Z","caller":"traceutil/trace.go:171","msg":"trace[1002716765] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"1.496933547s","start":"2026-03-05T04:58:54.996763Z","end":"2026-03-05T04:58:56.493697Z","steps":["trace[1002716765] 'process raft request'  (duration: 1.292670031s)","trace[1002716765] 'compare'  (duration: 204.000809ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:58:56.493741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:54.996743Z","time spent":"1.496978139s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:967 > 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-05T04:58:56.493878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.866383148s","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-05T04:58:56.493902Z","caller":"traceutil/trace.go:171","msg":"trace[1756830891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:973; }","duration":"1.866426329s","start":"2026-03-05T04:58:54.627467Z","end":"2026-03-05T04:58:56.493894Z","steps":["trace[1756830891] 'agreement among raft nodes before linearized reading'  (duration: 1.866346967s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:56.49392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:54.627454Z","time spent":"1.86646238s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-05T04:58:56.494105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.82218369s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-05T04:58:56.494068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.866360387s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-05T04:58:56.494218Z","caller":"traceutil/trace.go:171","msg":"trace[837529306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:973; }","duration":"1.822355105s","start":"2026-03-05T04:58:54.671844Z","end":"2026-03-05T04:58:56.494199Z","steps":["trace[837529306] 'agreement among raft nodes before linearized reading'  (duration: 1.822102409s)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:56.494233Z","caller":"traceutil/trace.go:171","msg":"trace[942741464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:973; }","duration":"1.866558193s","start":"2026-03-05T04:58:54.627653Z","end":"2026-03-05T04:58:56.494212Z","steps":["trace[942741464] 'agreement among raft nodes before linearized reading'  (duration: 1.866166742s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:56.494271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:54.671834Z","time spent":"1.822415187s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-05T04:58:56.494278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:54.627642Z","time spent":"1.866625124s","remote":"127.0.0.1:56630","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-05T04:58:56.994009Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812301362196106,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-05T04:58:57.271406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.752302ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362196105 > lease_revoke:<id:41f79cbc5b00ee00>","response":"size:29"}
{"level":"info","ts":"2026-03-05T04:58:57.272078Z","caller":"traceutil/trace.go:171","msg":"trace[1073097632] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"773.458852ms","start":"2026-03-05T04:58:56.498573Z","end":"2026-03-05T04:58:57.272032Z","steps":["trace[1073097632] 'process raft request'  (duration: 773.38154ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:57.272689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:56.498559Z","time spent":"774.068638ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:968 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-05T04:58:57.272097Z","caller":"traceutil/trace.go:171","msg":"trace[193854090] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"773.806862ms","start":"2026-03-05T04:58:56.49825Z","end":"2026-03-05T04:58:57.272057Z","steps":["trace[193854090] 'process raft request'  (duration: 773.241827ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:57.272854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:56.498226Z","time spent":"774.550971ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:965 > 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-05T04:58:57.272201Z","caller":"traceutil/trace.go:171","msg":"trace[1990046596] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1017; }","duration":"778.514475ms","start":"2026-03-05T04:58:56.493674Z","end":"2026-03-05T04:58:57.272188Z","steps":["trace[1990046596] 'read index received'  (duration: 537.075216ms)","trace[1990046596] 'applied index is now lower than readState.Index'  (duration: 241.438279ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:58:57.272244Z","caller":"traceutil/trace.go:171","msg":"trace[667387437] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"773.474693ms","start":"2026-03-05T04:58:56.498742Z","end":"2026-03-05T04:58:57.272217Z","steps":["trace[667387437] 'process raft request'  (duration: 773.259368ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:57.273087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:56.498734Z","time spent":"774.322965ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:966 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-05T04:58:57.273267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.702731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-05T04:58:57.273307Z","caller":"traceutil/trace.go:171","msg":"trace[1491326942] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:976; }","duration":"276.774113ms","start":"2026-03-05T04:58:56.996521Z","end":"2026-03-05T04:58:57.273295Z","steps":["trace[1491326942] 'agreement among raft nodes before linearized reading'  (duration: 276.65651ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:57.272449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"912.990554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-05T04:58:57.273408Z","caller":"traceutil/trace.go:171","msg":"trace[829039285] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:976; }","duration":"914.011771ms","start":"2026-03-05T04:58:56.359385Z","end":"2026-03-05T04:58:57.273397Z","steps":["trace[829039285] 'agreement among raft nodes before linearized reading'  (duration: 912.83566ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:57.273442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:56.359363Z","time spent":"914.067903ms","remote":"127.0.0.1:44636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "}
{"level":"warn","ts":"2026-03-05T04:58:57.273716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.51608ms","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-05T04:58:57.273958Z","caller":"traceutil/trace.go:171","msg":"trace[340300557] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:976; }","duration":"270.591032ms","start":"2026-03-05T04:58:57.003163Z","end":"2026-03-05T04:58:57.273754Z","steps":["trace[340300557] 'agreement among raft nodes before linearized reading'  (duration: 270.50051ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:57.272519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.60818937s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:58:57.274793Z","caller":"traceutil/trace.go:171","msg":"trace[269970174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:976; }","duration":"1.610332485s","start":"2026-03-05T04:58:55.664285Z","end":"2026-03-05T04:58:57.274617Z","steps":["trace[269970174] 'agreement among raft nodes before linearized reading'  (duration: 1.607974693s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:57.27488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:55.664271Z","time spent":"1.610568212s","remote":"127.0.0.1:56342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-05T04:58:57.532523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.508061ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362196113 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:970 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-05T04:58:57.532816Z","caller":"traceutil/trace.go:171","msg":"trace[1320085954] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"254.833768ms","start":"2026-03-05T04:58:57.27797Z","end":"2026-03-05T04:58:57.532804Z","steps":["trace[1320085954] 'process raft request'  (duration: 122.991839ms)","trace[1320085954] 'compare'  (duration: 131.424528ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:58:57.532878Z","caller":"traceutil/trace.go:171","msg":"trace[1700642627] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1021; }","duration":"251.027939ms","start":"2026-03-05T04:58:57.281844Z","end":"2026-03-05T04:58:57.532872Z","steps":["trace[1700642627] 'read index received'  (duration: 119.131528ms)","trace[1700642627] 'applied index is now lower than readState.Index'  (duration: 131.895871ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:58:57.532966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.124091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:58:57.532989Z","caller":"traceutil/trace.go:171","msg":"trace[1147674881] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:977; }","duration":"251.163163ms","start":"2026-03-05T04:58:57.281821Z","end":"2026-03-05T04:58:57.532984Z","steps":["trace[1147674881] 'agreement among raft nodes before linearized reading'  (duration: 251.123922ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:57.533094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.436902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-05T04:58:57.533121Z","caller":"traceutil/trace.go:171","msg":"trace[2108819984] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:977; }","duration":"172.485863ms","start":"2026-03-05T04:58:57.360628Z","end":"2026-03-05T04:58:57.533114Z","steps":["trace[2108819984] 'agreement among raft nodes before linearized reading'  (duration: 172.441412ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:59.165588Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812301362196122,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-05T04:58:59.167691Z","caller":"traceutil/trace.go:171","msg":"trace[212136852] linearizableReadLoop","detail":"{readStateIndex:1025; appliedIndex:1024; }","duration":"502.767756ms","start":"2026-03-05T04:58:58.664896Z","end":"2026-03-05T04:58:59.167663Z","steps":["trace[212136852] 'read index received'  (duration: 502.400276ms)","trace[212136852] 'applied index is now lower than readState.Index'  (duration: 366.28µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:58:59.167814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.89434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-05T04:58:59.167862Z","caller":"traceutil/trace.go:171","msg":"trace[352814829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:979; }","duration":"502.983071ms","start":"2026-03-05T04:58:58.664859Z","end":"2026-03-05T04:58:59.167843Z","steps":["trace[352814829] 'agreement among raft nodes before linearized reading'  (duration: 502.905949ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:59.167905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:58.664847Z","time spent":"503.050034ms","remote":"127.0.0.1:56352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-05T04:58:59.168088Z","caller":"traceutil/trace.go:171","msg":"trace[1833121244] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"666.964903ms","start":"2026-03-05T04:58:58.501096Z","end":"2026-03-05T04:58:59.168061Z","steps":["trace[1833121244] 'process raft request'  (duration: 666.335857ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:59.168246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:58.501079Z","time spent":"667.077525ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:973 > 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-05T04:58:59.555524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.347699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-05T04:58:59.555616Z","caller":"traceutil/trace.go:171","msg":"trace[126234643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:979; }","duration":"277.541994ms","start":"2026-03-05T04:58:59.278055Z","end":"2026-03-05T04:58:59.555597Z","steps":["trace[126234643] 'range keys from in-memory index tree'  (duration: 277.175075ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:59.555898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.891927ms","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-05T04:58:59.555962Z","caller":"traceutil/trace.go:171","msg":"trace[171772267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:979; }","duration":"276.99476ms","start":"2026-03-05T04:58:59.278953Z","end":"2026-03-05T04:58:59.555948Z","steps":["trace[171772267] 'range keys from in-memory index tree'  (duration: 276.63734ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:59.556104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.321702ms","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-05T04:58:59.556137Z","caller":"traceutil/trace.go:171","msg":"trace[1623072974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:979; }","duration":"276.370843ms","start":"2026-03-05T04:58:59.279758Z","end":"2026-03-05T04:58:59.556128Z","steps":["trace[1623072974] 'range keys from in-memory index tree'  (duration: 275.702395ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:59.731689Z","caller":"traceutil/trace.go:171","msg":"trace[1057129281] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"172.009122ms","start":"2026-03-05T04:58:59.559662Z","end":"2026-03-05T04:58:59.731672Z","steps":["trace[1057129281] 'process raft request'  (duration: 171.56048ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:59.731811Z","caller":"traceutil/trace.go:171","msg":"trace[1467302836] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"171.706853ms","start":"2026-03-05T04:58:59.560098Z","end":"2026-03-05T04:58:59.731805Z","steps":["trace[1467302836] 'process raft request'  (duration: 171.231451ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:58:59.731915Z","caller":"traceutil/trace.go:171","msg":"trace[755719730] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"171.808336ms","start":"2026-03-05T04:58:59.560101Z","end":"2026-03-05T04:58:59.73191Z","steps":["trace[755719730] 'process raft request'  (duration: 171.252161ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:58:59.934071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.441649ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13976812301362196139 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-05T04:58:59.934223Z","caller":"traceutil/trace.go:171","msg":"trace[2104960452] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"190.566827ms","start":"2026-03-05T04:58:59.743628Z","end":"2026-03-05T04:58:59.934195Z","steps":["trace[2104960452] 'process raft request'  (duration: 76.938383ms)","trace[2104960452] 'compare'  (duration: 113.313256ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:59:00.443865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812301362196138,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-05T04:59:00.944682Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976812301362196138,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-05T04:59:01.031755Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.166430237s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-05T04:59:01.118296Z","caller":"traceutil/trace.go:171","msg":"trace[2000492183] linearizableReadLoop","detail":"{readStateIndex:1033; appliedIndex:1031; }","duration":"1.175436073s","start":"2026-03-05T04:58:59.942833Z","end":"2026-03-05T04:59:01.118269Z","steps":["trace[2000492183] 'read index received'  (duration: 1.089157395s)","trace[2000492183] 'applied index is now lower than readState.Index'  (duration: 86.277388ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:59:01.118438Z","caller":"traceutil/trace.go:171","msg":"trace[1216813063] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"1.253193667s","start":"2026-03-05T04:58:59.865231Z","end":"2026-03-05T04:59:01.118425Z","steps":["trace[1216813063] 'process raft request'  (duration: 1.166762655s)","trace[1216813063] 'compare'  (duration: 86.039552ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T04:59:01.118533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:59.865208Z","time spent":"1.25325833s","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-bpgz8.1899d932a381b4cb\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-bpgz8.1899d932a381b4cb\" value_size:683 lease:4753440264507420306 >> failure:<>"}
{"level":"warn","ts":"2026-03-05T04:59:01.118799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.175942936s","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":"warn","ts":"2026-03-05T04:59:01.118851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.46954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-05T04:59:01.11888Z","caller":"traceutil/trace.go:171","msg":"trace[2040880542] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:987; }","duration":"1.1760559s","start":"2026-03-05T04:58:59.942799Z","end":"2026-03-05T04:59:01.118855Z","steps":["trace[2040880542] 'agreement among raft nodes before linearized reading'  (duration: 1.175810853s)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:59:01.118894Z","caller":"traceutil/trace.go:171","msg":"trace[293373498] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:987; }","duration":"651.582263ms","start":"2026-03-05T04:59:00.467299Z","end":"2026-03-05T04:59:01.118881Z","steps":["trace[293373498] 'agreement among raft nodes before linearized reading'  (duration: 651.433009ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:59:01.118928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:59:00.46717Z","time spent":"651.751417ms","remote":"127.0.0.1:56380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.204\" "}
{"level":"warn","ts":"2026-03-05T04:59:01.118921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:59.94278Z","time spent":"1.176132311s","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-05T04:59:01.119126Z","caller":"traceutil/trace.go:171","msg":"trace[502182016] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"1.175372201s","start":"2026-03-05T04:58:59.943741Z","end":"2026-03-05T04:59:01.119113Z","steps":["trace[502182016] 'process raft request'  (duration: 1.174458238s)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:59:01.1192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:58:59.943723Z","time spent":"1.175431292s","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.1899d932a83f37d2\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.1899d932a83f37d2\" value_size:692 lease:4753440264507420306 >> failure:<>"}
{"level":"warn","ts":"2026-03-05T04:59:01.652655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:59:01.120154Z","time spent":"532.496125ms","remote":"127.0.0.1:56380","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-05T04:59:01.656254Z","caller":"traceutil/trace.go:171","msg":"trace[51312303] linearizableReadLoop","detail":"{readStateIndex:1036; appliedIndex:1033; }","duration":"484.13436ms","start":"2026-03-05T04:59:01.1721Z","end":"2026-03-05T04:59:01.656235Z","steps":["trace[51312303] 'read index received'  (duration: 415.567195ms)","trace[51312303] 'applied index is now lower than readState.Index'  (duration: 68.565975ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:59:01.656347Z","caller":"traceutil/trace.go:171","msg":"trace[495712700] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"531.756946ms","start":"2026-03-05T04:59:01.124581Z","end":"2026-03-05T04:59:01.656337Z","steps":["trace[495712700] 'process raft request'  (duration: 531.599742ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:59:01.656443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:59:01.124565Z","time spent":"531.808487ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:985 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-05T04:59:01.656544Z","caller":"traceutil/trace.go:171","msg":"trace[1323760974] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"533.814639ms","start":"2026-03-05T04:59:01.122681Z","end":"2026-03-05T04:59:01.656496Z","steps":["trace[1323760974] 'process raft request'  (duration: 533.374598ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:59:01.656699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.606013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-05T04:59:01.656741Z","caller":"traceutil/trace.go:171","msg":"trace[866312249] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:989; }","duration":"484.679755ms","start":"2026-03-05T04:59:01.17205Z","end":"2026-03-05T04:59:01.65673Z","steps":["trace[866312249] 'agreement among raft nodes before linearized reading'  (duration: 484.563782ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:59:01.65677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:59:01.172035Z","time spent":"484.729075ms","remote":"127.0.0.1:56630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-05T04:59:01.656699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-05T04:59:01.122659Z","time spent":"533.966204ms","remote":"127.0.0.1:56414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":835,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-bpgz8.1899d932a394caf0\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-bpgz8.1899d932a394caf0\" value_size:731 lease:4753440264507420306 >> failure:<>"}
{"level":"info","ts":"2026-03-05T04:59:15.975099Z","caller":"traceutil/trace.go:171","msg":"trace[1330670705] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"139.356047ms","start":"2026-03-05T04:59:15.835711Z","end":"2026-03-05T04:59:15.975067Z","steps":["trace[1330670705] 'process raft request'  (duration: 139.177992ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:59:15.988641Z","caller":"traceutil/trace.go:171","msg":"trace[1847073155] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"152.280726ms","start":"2026-03-05T04:59:15.836332Z","end":"2026-03-05T04:59:15.988613Z","steps":["trace[1847073155] 'process raft request'  (duration: 152.121661ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:59:15.988747Z","caller":"traceutil/trace.go:171","msg":"trace[2147088093] linearizableReadLoop","detail":"{readStateIndex:1124; appliedIndex:1120; }","duration":"149.74774ms","start":"2026-03-05T04:59:15.83898Z","end":"2026-03-05T04:59:15.988728Z","steps":["trace[2147088093] 'read index received'  (duration: 135.961279ms)","trace[2147088093] 'applied index is now lower than readState.Index'  (duration: 13.785481ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:59:15.988915Z","caller":"traceutil/trace.go:171","msg":"trace[1612714120] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"152.569193ms","start":"2026-03-05T04:59:15.836332Z","end":"2026-03-05T04:59:15.988901Z","steps":["trace[1612714120] 'process raft request'  (duration: 151.996408ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:59:15.98904Z","caller":"traceutil/trace.go:171","msg":"trace[309693044] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"150.610482ms","start":"2026-03-05T04:59:15.838391Z","end":"2026-03-05T04:59:15.989002Z","steps":["trace[309693044] 'process raft request'  (duration: 150.184701ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-05T04:59:15.989388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.357186ms","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-05T04:59:15.989445Z","caller":"traceutil/trace.go:171","msg":"trace[185145523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1076; }","duration":"150.460868ms","start":"2026-03-05T04:59:15.838967Z","end":"2026-03-05T04:59:15.989428Z","steps":["trace[185145523] 'agreement among raft nodes before linearized reading'  (duration: 150.15898ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:59:24.223951Z","caller":"traceutil/trace.go:171","msg":"trace[2037144960] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"157.923333ms","start":"2026-03-05T04:59:24.066005Z","end":"2026-03-05T04:59:24.223928Z","steps":["trace[2037144960] 'process raft request'  (duration: 157.849991ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:59:24.224214Z","caller":"traceutil/trace.go:171","msg":"trace[901090757] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"158.533549ms","start":"2026-03-05T04:59:24.065665Z","end":"2026-03-05T04:59:24.224199Z","steps":["trace[901090757] 'process raft request'  (duration: 103.470878ms)","trace[901090757] 'compare'  (duration: 54.61976ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T04:59:24.224452Z","caller":"traceutil/trace.go:171","msg":"trace[1212647096] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"157.893732ms","start":"2026-03-05T04:59:24.066219Z","end":"2026-03-05T04:59:24.224112Z","steps":["trace[1212647096] 'process raft request'  (duration: 157.678036ms)"],"step_count":1}
{"level":"info","ts":"2026-03-05T04:59:48.431437Z","caller":"traceutil/trace.go:171","msg":"trace[189196784] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"132.45071ms","start":"2026-03-05T04:59:48.298961Z","end":"2026-03-05T04:59:48.431412Z","steps":["trace[189196784] 'process raft request'  (duration: 40.023726ms)","trace[189196784] 'compare'  (duration: 92.27656ms)"],"step_count":2}
{"level":"info","ts":"2026-03-05T05:00:26.792562Z","caller":"traceutil/trace.go:171","msg":"trace[1549961558] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"101.964984ms","start":"2026-03-05T05:00:26.690566Z","end":"2026-03-05T05:00:26.792531Z","steps":["trace[1549961558] 'process raft request'  (duration: 84.892018ms)","trace[1549961558] 'compare'  (duration: 16.915412ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-05T05:02:12.423485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.450522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"}
{"level":"info","ts":"2026-03-05T05:02:12.423587Z","caller":"traceutil/trace.go:171","msg":"trace[1362897130] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1826; }","duration":"116.620726ms","start":"2026-03-05T05:02:12.306941Z","end":"2026-03-05T05:02:12.423562Z","steps":["trace[1362897130] 'range keys from in-memory index tree'  (duration: 116.225065ms)"],"step_count":1}