{"level":"warn","ts":"2026-03-09T22:27:19.058048Z","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-09T22:27:19.058124Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140: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.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140: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-09T22:27:19.058191Z","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-09T22:27:19.058203Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]}
{"level":"info","ts":"2026-03-09T22:27:19.058218Z","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-09T22:27:19.058813Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]}
{"level":"info","ts":"2026-03-09T22:27:19.058908Z","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.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140: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-09T22:27:19.067173Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.074286ms"}
{"level":"info","ts":"2026-03-09T22:27:19.088955Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"}
{"level":"info","ts":"2026-03-09T22:27:19.089081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-09T22:27:19.089115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"}
{"level":"info","ts":"2026-03-09T22:27:19.089137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-09T22:27:19.089153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"}
{"level":"info","ts":"2026-03-09T22:27:19.0892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"}
{"level":"warn","ts":"2026-03-09T22:27:19.112958Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-09T22:27:19.122163Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-09T22:27:19.123975Z","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-09T22:27:19.126237Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-09T22:27:19.126481Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-09T22:27:19.126815Z","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-09T22:27:19.126902Z","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-09T22:27:19.126911Z","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-09T22:27:19.127619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"}
{"level":"info","ts":"2026-03-09T22:27:19.127803Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]}
{"level":"info","ts":"2026-03-09T22:27:19.131588Z","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-09T22:27:19.131852Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"}
{"level":"info","ts":"2026-03-09T22:27:19.131879Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"}
{"level":"info","ts":"2026-03-09T22:27:19.132576Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-09T22:27:19.132615Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-09T22:27:19.890017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-09T22:27:19.890076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-09T22:27:19.890113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"}
{"level":"info","ts":"2026-03-09T22:27:19.890155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"}
{"level":"info","ts":"2026-03-09T22:27:19.890172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"}
{"level":"info","ts":"2026-03-09T22:27:19.890191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"}
{"level":"info","ts":"2026-03-09T22:27:19.890209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"}
{"level":"info","ts":"2026-03-09T22:27:19.891428Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T22:27:19.892477Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-09T22:27:19.892469Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-09T22:27:19.892529Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-09T22:27:19.893029Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T22:27:19.893134Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T22:27:19.893168Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T22:27:19.892925Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-09T22:27:19.893216Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-09T22:27:19.895167Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"}
{"level":"info","ts":"2026-03-09T22:27:19.895499Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-09T22:27:47.88106Z","caller":"traceutil/trace.go:171","msg":"trace[1512067527] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"110.327922ms","start":"2026-03-09T22:27:47.77071Z","end":"2026-03-09T22:27:47.881038Z","steps":["trace[1512067527] 'process raft request'  (duration: 102.118774ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:27:49.222843Z","caller":"traceutil/trace.go:171","msg":"trace[2085689794] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:522; }","duration":"110.939486ms","start":"2026-03-09T22:27:49.111888Z","end":"2026-03-09T22:27:49.222827Z","steps":["trace[2085689794] 'read index received'  (duration: 110.804693ms)","trace[2085689794] 'applied index is now lower than readState.Index'  (duration: 134.263µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:27:49.222932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.024308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:27:49.222975Z","caller":"traceutil/trace.go:171","msg":"trace[489508081] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:505; }","duration":"111.09696ms","start":"2026-03-09T22:27:49.111872Z","end":"2026-03-09T22:27:49.222969Z","steps":["trace[489508081] 'agreement among raft nodes before linearized reading'  (duration: 111.025288ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:27:49.223139Z","caller":"traceutil/trace.go:171","msg":"trace[363435137] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"116.743593ms","start":"2026-03-09T22:27:49.106367Z","end":"2026-03-09T22:27:49.22311Z","steps":["trace[363435137] 'process raft request'  (duration: 116.365044ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:27:49.541013Z","caller":"traceutil/trace.go:171","msg":"trace[2145383399] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"142.452562ms","start":"2026-03-09T22:27:49.398534Z","end":"2026-03-09T22:27:49.540986Z","steps":["trace[2145383399] 'process raft request'  (duration: 142.319329ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:27:50.157897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.245588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4375"}
{"level":"info","ts":"2026-03-09T22:27:50.157979Z","caller":"traceutil/trace.go:171","msg":"trace[1702883971] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:506; }","duration":"418.369131ms","start":"2026-03-09T22:27:49.739588Z","end":"2026-03-09T22:27:50.157957Z","steps":["trace[1702883971] 'range keys from in-memory index tree'  (duration: 418.155407ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:27:50.158028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:27:49.739569Z","time spent":"418.446833ms","remote":"127.0.0.1:47466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4398,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-03-09T22:27:51.820613Z","caller":"traceutil/trace.go:171","msg":"trace[326740071] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:527; }","duration":"275.171422ms","start":"2026-03-09T22:27:51.545424Z","end":"2026-03-09T22:27:51.820595Z","steps":["trace[326740071] 'read index received'  (duration: 275.053239ms)","trace[326740071] 'applied index is now lower than readState.Index'  (duration: 117.313µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:27:51.820747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.305816ms","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-09T22:27:51.820725Z","caller":"traceutil/trace.go:171","msg":"trace[1293679534] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"591.515532ms","start":"2026-03-09T22:27:51.229176Z","end":"2026-03-09T22:27:51.820692Z","steps":["trace[1293679534] 'process raft request'  (duration: 591.303537ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:27:51.820776Z","caller":"traceutil/trace.go:171","msg":"trace[1847921235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:510; }","duration":"275.389717ms","start":"2026-03-09T22:27:51.54538Z","end":"2026-03-09T22:27:51.820769Z","steps":["trace[1847921235] 'agreement among raft nodes before linearized reading'  (duration: 275.288264ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:27:51.821993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:27:51.229161Z","time spent":"591.636254ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:505 > 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-09T22:27:52.063981Z","caller":"traceutil/trace.go:171","msg":"trace[8012723] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"238.395691ms","start":"2026-03-09T22:27:51.824735Z","end":"2026-03-09T22:27:52.06313Z","steps":["trace[8012723] 'process raft request'  (duration: 161.091128ms)","trace[8012723] 'compare'  (duration: 77.042447ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:27:56.213281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.29085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:27:56.213365Z","caller":"traceutil/trace.go:171","msg":"trace[630815596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:525; }","duration":"103.404402ms","start":"2026-03-09T22:27:56.109944Z","end":"2026-03-09T22:27:56.213349Z","steps":["trace[630815596] 'range keys from in-memory index tree'  (duration: 103.237189ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:27:56.741647Z","caller":"traceutil/trace.go:171","msg":"trace[2044875097] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:544; }","duration":"213.197473ms","start":"2026-03-09T22:27:56.528426Z","end":"2026-03-09T22:27:56.741623Z","steps":["trace[2044875097] 'read index received'  (duration: 212.971698ms)","trace[2044875097] 'applied index is now lower than readState.Index'  (duration: 224.795µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:27:56.741742Z","caller":"traceutil/trace.go:171","msg":"trace[1116778870] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"513.927722ms","start":"2026-03-09T22:27:56.227786Z","end":"2026-03-09T22:27:56.741714Z","steps":["trace[1116778870] 'process raft request'  (duration: 513.675626ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:27:56.741863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.430108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-09T22:27:56.741883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:27:56.227765Z","time spent":"514.043515ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-wpn94\" mod_revision:498 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-wpn94\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-wpn94\" > >"}
{"level":"info","ts":"2026-03-09T22:27:56.741906Z","caller":"traceutil/trace.go:171","msg":"trace[914088126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:526; }","duration":"213.48626ms","start":"2026-03-09T22:27:56.528408Z","end":"2026-03-09T22:27:56.741894Z","steps":["trace[914088126] 'agreement among raft nodes before linearized reading'  (duration: 213.338935ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:27:58.293804Z","caller":"traceutil/trace.go:171","msg":"trace[1591512447] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:547; }","duration":"192.83468ms","start":"2026-03-09T22:27:58.100954Z","end":"2026-03-09T22:27:58.293789Z","steps":["trace[1591512447] 'read index received'  (duration: 192.728197ms)","trace[1591512447] 'applied index is now lower than readState.Index'  (duration: 105.753µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:27:58.293861Z","caller":"traceutil/trace.go:171","msg":"trace[2056952179] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"443.681433ms","start":"2026-03-09T22:27:57.850152Z","end":"2026-03-09T22:27:58.293833Z","steps":["trace[2056952179] 'process raft request'  (duration: 443.532319ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:27:58.293929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.380773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:27:58.293958Z","caller":"traceutil/trace.go:171","msg":"trace[1487018534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"182.448195ms","start":"2026-03-09T22:27:58.111501Z","end":"2026-03-09T22:27:58.29395Z","steps":["trace[1487018534] 'agreement among raft nodes before linearized reading'  (duration: 182.401254ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:27:58.293978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:27:57.850126Z","time spent":"443.784555ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:523 > 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-09T22:27:58.294248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.096086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-09T22:27:58.294405Z","caller":"traceutil/trace.go:171","msg":"trace[454765229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:529; }","duration":"193.446543ms","start":"2026-03-09T22:27:58.100939Z","end":"2026-03-09T22:27:58.294386Z","steps":["trace[454765229] 'agreement among raft nodes before linearized reading'  (duration: 192.945492ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:27:58.839031Z","caller":"traceutil/trace.go:171","msg":"trace[189857999] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"541.074423ms","start":"2026-03-09T22:27:58.297933Z","end":"2026-03-09T22:27:58.839007Z","steps":["trace[189857999] 'process raft request'  (duration: 454.681562ms)","trace[189857999] 'compare'  (duration: 85.653035ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:27:58.839178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:27:58.297918Z","time spent":"541.194975ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:525 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-09T22:28:00.655867Z","caller":"traceutil/trace.go:171","msg":"trace[868693989] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"353.429406ms","start":"2026-03-09T22:28:00.30241Z","end":"2026-03-09T22:28:00.65584Z","steps":["trace[868693989] 'process raft request'  (duration: 351.042774ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:00.656548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:00.302395Z","time spent":"353.646142ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:529 > 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-09T22:28:00.660889Z","caller":"traceutil/trace.go:171","msg":"trace[534878572] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:578; }","duration":"142.80893ms","start":"2026-03-09T22:28:00.518046Z","end":"2026-03-09T22:28:00.660855Z","steps":["trace[534878572] 'read index received'  (duration: 135.393939ms)","trace[534878572] 'applied index is now lower than readState.Index'  (duration: 7.413731ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:28:00.661055Z","caller":"traceutil/trace.go:171","msg":"trace[1176189736] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"336.235272ms","start":"2026-03-09T22:28:00.324794Z","end":"2026-03-09T22:28:00.661029Z","steps":["trace[1176189736] 'process raft request'  (duration: 335.971156ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:00.661179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:00.324771Z","time spent":"336.353075ms","remote":"127.0.0.1:47362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" value_size:4482 >> failure:<>"}
{"level":"warn","ts":"2026-03-09T22:28:00.661149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.059057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:00.66125Z","caller":"traceutil/trace.go:171","msg":"trace[1093865724] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:560; }","duration":"143.23838ms","start":"2026-03-09T22:28:00.517991Z","end":"2026-03-09T22:28:00.66123Z","steps":["trace[1093865724] 'agreement among raft nodes before linearized reading'  (duration: 142.963914ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:03.452249Z","caller":"traceutil/trace.go:171","msg":"trace[874861922] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"108.088054ms","start":"2026-03-09T22:28:03.344134Z","end":"2026-03-09T22:28:03.452222Z","steps":["trace[874861922] 'process raft request'  (duration: 107.936421ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:16.408742Z","caller":"traceutil/trace.go:171","msg":"trace[2016405930] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"109.190587ms","start":"2026-03-09T22:28:16.299488Z","end":"2026-03-09T22:28:16.408679Z","steps":["trace[2016405930] 'process raft request'  (duration: 108.792799ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:16.574796Z","caller":"traceutil/trace.go:171","msg":"trace[1173891139] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"150.576119ms","start":"2026-03-09T22:28:16.424189Z","end":"2026-03-09T22:28:16.574765Z","steps":["trace[1173891139] 'process raft request'  (duration: 150.407236ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:16.701634Z","caller":"traceutil/trace.go:171","msg":"trace[903974486] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"108.003803ms","start":"2026-03-09T22:28:16.593607Z","end":"2026-03-09T22:28:16.701611Z","steps":["trace[903974486] 'process raft request'  (duration: 107.866839ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:28.847263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.148924ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388883923777358 > lease_revoke:<id:2c819cd4b63db6ce>","response":"size:28"}
{"level":"info","ts":"2026-03-09T22:28:28.954248Z","caller":"traceutil/trace.go:171","msg":"trace[928456070] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"103.398346ms","start":"2026-03-09T22:28:28.850832Z","end":"2026-03-09T22:28:28.95423Z","steps":["trace[928456070] 'process raft request'  (duration: 103.289843ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:29.274146Z","caller":"traceutil/trace.go:171","msg":"trace[133787172] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"137.868525ms","start":"2026-03-09T22:28:29.136256Z","end":"2026-03-09T22:28:29.274124Z","steps":["trace[133787172] 'process raft request'  (duration: 137.560258ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:29.404991Z","caller":"traceutil/trace.go:171","msg":"trace[1722876896] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"126.377708ms","start":"2026-03-09T22:28:29.278514Z","end":"2026-03-09T22:28:29.404892Z","steps":["trace[1722876896] 'process raft request'  (duration: 50.764692ms)","trace[1722876896] 'compare'  (duration: 75.405481ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:28:29.405204Z","caller":"traceutil/trace.go:171","msg":"trace[313499540] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"126.504411ms","start":"2026-03-09T22:28:29.278683Z","end":"2026-03-09T22:28:29.405188Z","steps":["trace[313499540] 'process raft request'  (duration: 126.165864ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:39.646668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.192748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-09T22:28:39.646738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.258864ms","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-09T22:28:39.646781Z","caller":"traceutil/trace.go:171","msg":"trace[2102335781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:779; }","duration":"115.357772ms","start":"2026-03-09T22:28:39.531404Z","end":"2026-03-09T22:28:39.646762Z","steps":["trace[2102335781] 'range keys from in-memory index tree'  (duration: 115.049825ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:39.646795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.817997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:39.646861Z","caller":"traceutil/trace.go:171","msg":"trace[720981923] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:779; }","duration":"195.93099ms","start":"2026-03-09T22:28:39.450912Z","end":"2026-03-09T22:28:39.646843Z","steps":["trace[720981923] 'count revisions from in-memory index tree'  (duration: 195.734845ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:39.646813Z","caller":"traceutil/trace.go:171","msg":"trace[587956899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:779; }","duration":"308.348106ms","start":"2026-03-09T22:28:39.338444Z","end":"2026-03-09T22:28:39.646792Z","steps":["trace[587956899] 'range keys from in-memory index tree'  (duration: 308.08584ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:39.646999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.117577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-09T22:28:39.647033Z","caller":"traceutil/trace.go:171","msg":"trace[1114590016] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:779; }","duration":"328.187659ms","start":"2026-03-09T22:28:39.318835Z","end":"2026-03-09T22:28:39.647022Z","steps":["trace[1114590016] 'count revisions from in-memory index tree'  (duration: 328.053486ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:39.647066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:39.318814Z","time spent":"328.24319ms","remote":"127.0.0.1:47414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":12,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:28:39.647092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.086659ms","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-09T22:28:39.647127Z","caller":"traceutil/trace.go:171","msg":"trace[2024257449] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:779; }","duration":"125.162871ms","start":"2026-03-09T22:28:39.521954Z","end":"2026-03-09T22:28:39.647117Z","steps":["trace[2024257449] 'range keys from in-memory index tree'  (duration: 124.963296ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:39.647001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:39.338411Z","time spent":"308.582571ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-09T22:28:43.827116Z","caller":"traceutil/trace.go:171","msg":"trace[1698075605] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"127.492983ms","start":"2026-03-09T22:28:43.699596Z","end":"2026-03-09T22:28:43.827089Z","steps":["trace[1698075605] 'process raft request'  (duration: 74.319557ms)","trace[1698075605] 'compare'  (duration: 53.058203ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:28:43.864105Z","caller":"traceutil/trace.go:171","msg":"trace[1101434305] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"164.414777ms","start":"2026-03-09T22:28:43.699671Z","end":"2026-03-09T22:28:43.864086Z","steps":["trace[1101434305] 'process raft request'  (duration: 164.332705ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:47.333436Z","caller":"traceutil/trace.go:171","msg":"trace[203254643] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"224.227951ms","start":"2026-03-09T22:28:47.109185Z","end":"2026-03-09T22:28:47.333413Z","steps":["trace[203254643] 'read index received'  (duration: 224.023466ms)","trace[203254643] 'applied index is now lower than readState.Index'  (duration: 203.665µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:28:47.333477Z","caller":"traceutil/trace.go:171","msg":"trace[1450539422] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"782.161583ms","start":"2026-03-09T22:28:46.551297Z","end":"2026-03-09T22:28:47.333458Z","steps":["trace[1450539422] 'process raft request'  (duration: 781.978519ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:47.333566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.380124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-09T22:28:47.333571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:46.551272Z","time spent":"782.241184ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:795 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-09T22:28:47.333601Z","caller":"traceutil/trace.go:171","msg":"trace[102812215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"224.461626ms","start":"2026-03-09T22:28:47.109128Z","end":"2026-03-09T22:28:47.333589Z","steps":["trace[102812215] 'agreement among raft nodes before linearized reading'  (duration: 224.400834ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:47.333726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.933159ms","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-09T22:28:47.333829Z","caller":"traceutil/trace.go:171","msg":"trace[163442234] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:800; }","duration":"187.095323ms","start":"2026-03-09T22:28:47.146718Z","end":"2026-03-09T22:28:47.333813Z","steps":["trace[163442234] 'agreement among raft nodes before linearized reading'  (duration: 186.843547ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:47.696535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.728385ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388883923777519 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:796 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-09T22:28:47.696719Z","caller":"traceutil/trace.go:171","msg":"trace[1886862198] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"356.536231ms","start":"2026-03-09T22:28:47.340166Z","end":"2026-03-09T22:28:47.696702Z","steps":["trace[1886862198] 'process raft request'  (duration: 356.477879ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:47.696808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:47.340157Z","time spent":"356.618053ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:773 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-09T22:28:47.697114Z","caller":"traceutil/trace.go:171","msg":"trace[1157011006] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"360.050169ms","start":"2026-03-09T22:28:47.337051Z","end":"2026-03-09T22:28:47.697101Z","steps":["trace[1157011006] 'process raft request'  (duration: 189.67283ms)","trace[1157011006] 'compare'  (duration: 169.594452ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:28:47.697182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:47.337035Z","time spent":"360.115101ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:796 > 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-09T22:28:48.362039Z","caller":"traceutil/trace.go:171","msg":"trace[391019566] linearizableReadLoop","detail":"{readStateIndex:836; appliedIndex:835; }","duration":"469.228454ms","start":"2026-03-09T22:28:47.892786Z","end":"2026-03-09T22:28:48.362015Z","steps":["trace[391019566] 'read index received'  (duration: 469.086821ms)","trace[391019566] 'applied index is now lower than readState.Index'  (duration: 140.253µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:28:48.362133Z","caller":"traceutil/trace.go:171","msg":"trace[683329225] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"514.588415ms","start":"2026-03-09T22:28:47.847518Z","end":"2026-03-09T22:28:48.362106Z","steps":["trace[683329225] 'process raft request'  (duration: 514.35788ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:48.36227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.469639ms","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-09T22:28:48.362573Z","caller":"traceutil/trace.go:171","msg":"trace[1281098603] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:804; }","duration":"469.813096ms","start":"2026-03-09T22:28:47.892748Z","end":"2026-03-09T22:28:48.362561Z","steps":["trace[1281098603] 'agreement among raft nodes before linearized reading'  (duration: 469.382486ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:48.362542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:47.847506Z","time spent":"514.919922ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:798 > 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-09T22:28:48.36264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:47.892732Z","time spent":"469.896508ms","remote":"127.0.0.1:47566","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-09T22:28:48.863074Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388883923777526,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-09T22:28:50.111585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.9999486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-09T22:28:50.111714Z","caller":"traceutil/trace.go:171","msg":"trace[1293841051] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000125424s","start":"2026-03-09T22:28:48.111564Z","end":"2026-03-09T22:28:50.111689Z","steps":["trace[1293841051] 'agreement among raft nodes before linearized reading'  (duration: 1.999980411s)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.111777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:48.111544Z","time spent":"2.000219005s","remote":"127.0.0.1:47288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/09 22:28:50 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-03-09T22:28:50.281755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.213152614s","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388883923777525 > lease_revoke:<id:2c819cd4b63db77b>","response":"size:28"}
{"level":"info","ts":"2026-03-09T22:28:50.288188Z","caller":"traceutil/trace.go:171","msg":"trace[821606669] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:836; }","duration":"1.925816027s","start":"2026-03-09T22:28:48.362338Z","end":"2026-03-09T22:28:50.288155Z","steps":["trace[821606669] 'read index received'  (duration: 706.104527ms)","trace[821606669] 'applied index is now lower than readState.Index'  (duration: 1.21971075s)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:28:50.288405Z","caller":"traceutil/trace.go:171","msg":"trace[966289408] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"1.921702765s","start":"2026-03-09T22:28:48.366674Z","end":"2026-03-09T22:28:50.288377Z","steps":["trace[966289408] 'process raft request'  (duration: 1.921364278s)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.28848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:48.366642Z","time spent":"1.921782817s","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:799 > 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-09T22:28:50.28856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.445790132s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-09T22:28:50.288595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.658776ms","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-09T22:28:50.288615Z","caller":"traceutil/trace.go:171","msg":"trace[1384711211] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:805; }","duration":"1.445888644s","start":"2026-03-09T22:28:48.84271Z","end":"2026-03-09T22:28:50.288599Z","steps":["trace[1384711211] 'agreement among raft nodes before linearized reading'  (duration: 1.445750751s)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:50.288629Z","caller":"traceutil/trace.go:171","msg":"trace[1113418590] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:805; }","duration":"587.732058ms","start":"2026-03-09T22:28:49.700887Z","end":"2026-03-09T22:28:50.288619Z","steps":["trace[1113418590] 'agreement among raft nodes before linearized reading'  (duration: 587.604995ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.288631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.918366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-03-09T22:28:50.288654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:49.700866Z","time spent":"587.781488ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-09T22:28:50.288669Z","caller":"traceutil/trace.go:171","msg":"trace[894925534] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:805; }","duration":"950.998317ms","start":"2026-03-09T22:28:49.337662Z","end":"2026-03-09T22:28:50.28866Z","steps":["trace[894925534] 'agreement among raft nodes before linearized reading'  (duration: 950.837504ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.288693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:49.337642Z","time spent":"951.045298ms","remote":"127.0.0.1:47566","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-09T22:28:50.288692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020071448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-09T22:28:50.28871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.860725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:50.288724Z","caller":"traceutil/trace.go:171","msg":"trace[1065484394] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:805; }","duration":"1.02014665s","start":"2026-03-09T22:28:49.268569Z","end":"2026-03-09T22:28:50.288715Z","steps":["trace[1065484394] 'agreement among raft nodes before linearized reading'  (duration: 1.020102909s)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:50.288737Z","caller":"traceutil/trace.go:171","msg":"trace[1352169260] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:805; }","duration":"646.922737ms","start":"2026-03-09T22:28:49.641806Z","end":"2026-03-09T22:28:50.288729Z","steps":["trace[1352169260] 'agreement among raft nodes before linearized reading'  (duration: 646.880936ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.28875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:49.268544Z","time spent":"1.02019832s","remote":"127.0.0.1:47814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:28:50.288758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:49.641788Z","time spent":"646.965638ms","remote":"127.0.0.1:47696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:28:50.288758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.943626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:50.28878Z","caller":"traceutil/trace.go:171","msg":"trace[1581841848] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:805; }","duration":"950.982947ms","start":"2026-03-09T22:28:49.33779Z","end":"2026-03-09T22:28:50.288773Z","steps":["trace[1581841848] 'agreement among raft nodes before linearized reading'  (duration: 950.949536ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.288799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:49.337784Z","time spent":"951.010417ms","remote":"127.0.0.1:47826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:28:50.288828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.798183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:50.288861Z","caller":"traceutil/trace.go:171","msg":"trace[2126002574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:805; }","duration":"176.870445ms","start":"2026-03-09T22:28:50.111981Z","end":"2026-03-09T22:28:50.288851Z","steps":["trace[2126002574] 'agreement among raft nodes before linearized reading'  (duration: 176.823204ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.288898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.379081554s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:50.288925Z","caller":"traceutil/trace.go:171","msg":"trace[1603183210] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:805; }","duration":"1.379132495s","start":"2026-03-09T22:28:48.909784Z","end":"2026-03-09T22:28:50.288917Z","steps":["trace[1603183210] 'agreement among raft nodes before linearized reading'  (duration: 1.379089144s)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.28895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:48.909774Z","time spent":"1.379168087s","remote":"127.0.0.1:47676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:28:50.288964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.071912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-09T22:28:50.288984Z","caller":"traceutil/trace.go:171","msg":"trace[563854865] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:805; }","duration":"552.128302ms","start":"2026-03-09T22:28:49.73685Z","end":"2026-03-09T22:28:50.288978Z","steps":["trace[563854865] 'agreement among raft nodes before linearized reading'  (duration: 552.061121ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.288654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:48.842691Z","time spent":"1.445951775s","remote":"127.0.0.1:47642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":66,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:28:50.289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:49.736831Z","time spent":"552.165454ms","remote":"127.0.0.1:47566","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-09T22:28:50.289084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.267309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:50.2891Z","caller":"traceutil/trace.go:171","msg":"trace[1799779793] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:805; }","duration":"423.32214ms","start":"2026-03-09T22:28:49.865773Z","end":"2026-03-09T22:28:50.289095Z","steps":["trace[1799779793] 'agreement among raft nodes before linearized reading'  (duration: 423.298239ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.289118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:49.865753Z","time spent":"423.36014ms","remote":"127.0.0.1:47606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:28:50.289234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.036951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-09T22:28:50.289266Z","caller":"traceutil/trace.go:171","msg":"trace[724814151] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:805; }","duration":"465.103302ms","start":"2026-03-09T22:28:49.824153Z","end":"2026-03-09T22:28:50.289257Z","steps":["trace[724814151] 'agreement among raft nodes before linearized reading'  (duration: 465.0201ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:50.289304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:49.824117Z","time spent":"465.178003ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:28:52.798489Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388883923777543,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-09T22:28:53.299269Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388883923777543,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-09T22:28:53.799813Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388883923777543,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-09T22:28:53.876999Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.58024744s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-09T22:28:53.877425Z","caller":"traceutil/trace.go:171","msg":"trace[435429922] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"1.580737831s","start":"2026-03-09T22:28:52.296663Z","end":"2026-03-09T22:28:53.877401Z","steps":["trace[435429922] 'process raft request'  (duration: 1.580608408s)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:53.877616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:52.296631Z","time spent":"1.580910944s","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:805 > 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-09T22:28:55.043552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.310801ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388883923777545 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:791 > 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-09T22:28:55.043648Z","caller":"traceutil/trace.go:171","msg":"trace[1102104614] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:845; }","duration":"2.745770692s","start":"2026-03-09T22:28:52.29786Z","end":"2026-03-09T22:28:55.043631Z","steps":["trace[1102104614] 'read index received'  (duration: 1.580243631s)","trace[1102104614] 'applied index is now lower than readState.Index'  (duration: 1.165526081s)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:28:55.04391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.746025268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-09T22:28:55.04398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.74607631s","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-09T22:28:55.043986Z","caller":"traceutil/trace.go:171","msg":"trace[39353506] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:812; }","duration":"2.746118591s","start":"2026-03-09T22:28:52.297849Z","end":"2026-03-09T22:28:55.043967Z","steps":["trace[39353506] 'agreement among raft nodes before linearized reading'  (duration: 2.745900275s)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:55.044014Z","caller":"traceutil/trace.go:171","msg":"trace[1093759976] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:812; }","duration":"2.74611706s","start":"2026-03-09T22:28:52.297886Z","end":"2026-03-09T22:28:55.044003Z","steps":["trace[1093759976] 'agreement among raft nodes before linearized reading'  (duration: 2.745981997s)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:55.044026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:52.297843Z","time spent":"2.746175302s","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-09T22:28:55.044048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:52.297883Z","time spent":"2.746157121s","remote":"127.0.0.1:47566","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-09T22:28:55.044079Z","caller":"traceutil/trace.go:171","msg":"trace[1977338351] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"1.502457796s","start":"2026-03-09T22:28:53.541582Z","end":"2026-03-09T22:28:55.04404Z","steps":["trace[1977338351] 'process raft request'  (duration: 964.560041ms)","trace[1977338351] 'compare'  (duration: 537.013335ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:28:55.044152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.837689371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-03-09T22:28:55.044175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.669631633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:55.044213Z","caller":"traceutil/trace.go:171","msg":"trace[148696312] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:812; }","duration":"1.669709445s","start":"2026-03-09T22:28:53.374495Z","end":"2026-03-09T22:28:55.044204Z","steps":["trace[148696312] 'agreement among raft nodes before linearized reading'  (duration: 1.669654734s)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:55.04422Z","caller":"traceutil/trace.go:171","msg":"trace[766447741] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:812; }","duration":"1.837798114s","start":"2026-03-09T22:28:53.206404Z","end":"2026-03-09T22:28:55.044202Z","steps":["trace[766447741] 'agreement among raft nodes before linearized reading'  (duration: 1.837556539s)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:55.044239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:53.374473Z","time spent":"1.669759046s","remote":"127.0.0.1:47594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:28:55.044233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:53.541561Z","time spent":"1.502589149s","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:791 > 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-09T22:28:55.04422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.668724804s","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-09T22:28:55.044231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.934597543s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-09T22:28:55.044269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:53.206391Z","time spent":"1.837869715s","remote":"127.0.0.1:47334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.140\" "}
{"level":"warn","ts":"2026-03-09T22:28:55.044283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.746046259s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-09T22:28:55.044299Z","caller":"traceutil/trace.go:171","msg":"trace[1419169033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:812; }","duration":"2.668857347s","start":"2026-03-09T22:28:52.375424Z","end":"2026-03-09T22:28:55.044281Z","steps":["trace[1419169033] 'agreement among raft nodes before linearized reading'  (duration: 2.668610451s)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:55.044356Z","caller":"traceutil/trace.go:171","msg":"trace[1560264951] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:812; }","duration":"1.934720676s","start":"2026-03-09T22:28:53.109568Z","end":"2026-03-09T22:28:55.044289Z","steps":["trace[1560264951] 'agreement among raft nodes before linearized reading'  (duration: 1.934579803s)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:55.044373Z","caller":"traceutil/trace.go:171","msg":"trace[353906362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:812; }","duration":"2.746189322s","start":"2026-03-09T22:28:52.298165Z","end":"2026-03-09T22:28:55.044354Z","steps":["trace[353906362] 'agreement among raft nodes before linearized reading'  (duration: 2.745880985s)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:55.044409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:52.375411Z","time spent":"2.668957579s","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-09T22:28:55.044435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:53.109548Z","time spent":"1.934876999s","remote":"127.0.0.1:47288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-09T22:28:55.04444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:52.298146Z","time spent":"2.746286204s","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-09T22:28:55.493305Z","caller":"traceutil/trace.go:171","msg":"trace[175405040] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"444.763258ms","start":"2026-03-09T22:28:55.04852Z","end":"2026-03-09T22:28:55.493283Z","steps":["trace[175405040] 'process raft request'  (duration: 444.585224ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:55.493452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:55.048502Z","time spent":"444.876311ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:806 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-09T22:28:55.493574Z","caller":"traceutil/trace.go:171","msg":"trace[1921664024] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"444.964103ms","start":"2026-03-09T22:28:55.048582Z","end":"2026-03-09T22:28:55.493546Z","steps":["trace[1921664024] 'process raft request'  (duration: 444.665997ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:55.493724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:55.048559Z","time spent":"445.088276ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:808 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-09T22:28:55.494117Z","caller":"traceutil/trace.go:171","msg":"trace[712008288] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"445.397533ms","start":"2026-03-09T22:28:55.048692Z","end":"2026-03-09T22:28:55.49409Z","steps":["trace[712008288] 'process raft request'  (duration: 445.303761ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:55.494217Z","caller":"traceutil/trace.go:171","msg":"trace[646862239] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"445.520615ms","start":"2026-03-09T22:28:55.04867Z","end":"2026-03-09T22:28:55.49419Z","steps":["trace[646862239] 'process raft request'  (duration: 445.005924ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:55.494352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:55.048662Z","time spent":"445.621557ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:807 > 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-09T22:28:55.494786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:55.048671Z","time spent":"445.927074ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:810 > 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-09T22:28:55.521511Z","caller":"traceutil/trace.go:171","msg":"trace[1903447402] linearizableReadLoop","detail":"{readStateIndex:852; appliedIndex:847; }","duration":"418.035453ms","start":"2026-03-09T22:28:55.103457Z","end":"2026-03-09T22:28:55.521493Z","steps":["trace[1903447402] 'read index received'  (duration: 389.629509ms)","trace[1903447402] 'applied index is now lower than readState.Index'  (duration: 28.404754ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:28:55.521524Z","caller":"traceutil/trace.go:171","msg":"trace[2107584224] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"432.169468ms","start":"2026-03-09T22:28:55.089337Z","end":"2026-03-09T22:28:55.521506Z","steps":["trace[2107584224] 'process raft request'  (duration: 432.043615ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:55.521631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:55.089317Z","time spent":"432.26551ms","remote":"127.0.0.1:47334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.140\" mod_revision:790 > success:<request_put:<key:\"/registry/masterleases/162.253.55.140\" value_size:67 lease:3207016847069001740 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.140\" > >"}
{"level":"warn","ts":"2026-03-09T22:28:55.52173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.270407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:55.521774Z","caller":"traceutil/trace.go:171","msg":"trace[545220505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:817; }","duration":"418.318948ms","start":"2026-03-09T22:28:55.103443Z","end":"2026-03-09T22:28:55.521762Z","steps":["trace[545220505] 'agreement among raft nodes before linearized reading'  (duration: 418.150625ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:28:55.521806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:28:55.103394Z","time spent":"418.40469ms","remote":"127.0.0.1:47288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-09T22:28:55.521817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.470995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:28:55.521882Z","caller":"traceutil/trace.go:171","msg":"trace[1027893475] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:817; }","duration":"167.580858ms","start":"2026-03-09T22:28:55.35428Z","end":"2026-03-09T22:28:55.52186Z","steps":["trace[1027893475] 'agreement among raft nodes before linearized reading'  (duration: 167.471195ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:59.620849Z","caller":"traceutil/trace.go:171","msg":"trace[681614120] transaction","detail":"{read_only:false; response_revision:828; number_of_response:1; }","duration":"108.689703ms","start":"2026-03-09T22:28:59.512132Z","end":"2026-03-09T22:28:59.620822Z","steps":["trace[681614120] 'process raft request'  (duration: 108.645032ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:28:59.620904Z","caller":"traceutil/trace.go:171","msg":"trace[403670846] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"108.814117ms","start":"2026-03-09T22:28:59.512062Z","end":"2026-03-09T22:28:59.620876Z","steps":["trace[403670846] 'process raft request'  (duration: 49.946404ms)","trace[403670846] 'compare'  (duration: 58.593467ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:28:59.620971Z","caller":"traceutil/trace.go:171","msg":"trace[699914728] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"108.810206ms","start":"2026-03-09T22:28:59.512125Z","end":"2026-03-09T22:28:59.620935Z","steps":["trace[699914728] 'process raft request'  (duration: 108.612802ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:05.834392Z","caller":"traceutil/trace.go:171","msg":"trace[937681053] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"142.213621ms","start":"2026-03-09T22:29:05.692158Z","end":"2026-03-09T22:29:05.834371Z","steps":["trace[937681053] 'process raft request'  (duration: 67.166788ms)","trace[937681053] 'compare'  (duration: 74.968431ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:29:07.798195Z","caller":"traceutil/trace.go:171","msg":"trace[505701143] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"106.982086ms","start":"2026-03-09T22:29:07.691188Z","end":"2026-03-09T22:29:07.79817Z","steps":["trace[505701143] 'read index received'  (duration: 106.762501ms)","trace[505701143] 'applied index is now lower than readState.Index'  (duration: 218.445µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:29:07.798411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.211411ms","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-09T22:29:07.798386Z","caller":"traceutil/trace.go:171","msg":"trace[1475628587] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"224.350113ms","start":"2026-03-09T22:29:07.573935Z","end":"2026-03-09T22:29:07.798285Z","steps":["trace[1475628587] 'process raft request'  (duration: 224.101478ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:07.798446Z","caller":"traceutil/trace.go:171","msg":"trace[1686573772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:898; }","duration":"107.302213ms","start":"2026-03-09T22:29:07.691133Z","end":"2026-03-09T22:29:07.798435Z","steps":["trace[1686573772] 'agreement among raft nodes before linearized reading'  (duration: 107.15777ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:10.199665Z","caller":"traceutil/trace.go:171","msg":"trace[1328007348] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:941; }","duration":"390.951719ms","start":"2026-03-09T22:29:09.808688Z","end":"2026-03-09T22:29:10.199639Z","steps":["trace[1328007348] 'read index received'  (duration: 390.808025ms)","trace[1328007348] 'applied index is now lower than readState.Index'  (duration: 142.604µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:29:10.199839Z","caller":"traceutil/trace.go:171","msg":"trace[1164970939] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"394.199811ms","start":"2026-03-09T22:29:09.805626Z","end":"2026-03-09T22:29:10.199826Z","steps":["trace[1164970939] 'process raft request'  (duration: 393.843533ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:10.199971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:09.805611Z","time spent":"394.270553ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:898 > 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-09T22:29:10.200073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.934757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-09T22:29:10.200154Z","caller":"traceutil/trace.go:171","msg":"trace[1619397299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:904; }","duration":"386.030889ms","start":"2026-03-09T22:29:09.814103Z","end":"2026-03-09T22:29:10.200133Z","steps":["trace[1619397299] 'agreement among raft nodes before linearized reading'  (duration: 385.835815ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:10.200203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:09.814097Z","time spent":"386.097871ms","remote":"127.0.0.1:47566","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-09T22:29:10.20033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.555583ms","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-09T22:29:10.200366Z","caller":"traceutil/trace.go:171","msg":"trace[287525960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:904; }","duration":"139.629024ms","start":"2026-03-09T22:29:10.060726Z","end":"2026-03-09T22:29:10.200355Z","steps":["trace[287525960] 'agreement among raft nodes before linearized reading'  (duration: 139.498771ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:10.200537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.058852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-03-09T22:29:10.200604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.865509ms","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-09T22:29:10.200642Z","caller":"traceutil/trace.go:171","msg":"trace[1716411697] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:904; }","duration":"309.228835ms","start":"2026-03-09T22:29:09.891389Z","end":"2026-03-09T22:29:10.200618Z","steps":["trace[1716411697] 'agreement among raft nodes before linearized reading'  (duration: 308.855987ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:10.200709Z","caller":"traceutil/trace.go:171","msg":"trace[902299803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:904; }","duration":"392.031003ms","start":"2026-03-09T22:29:09.808655Z","end":"2026-03-09T22:29:10.200686Z","steps":["trace[902299803] 'agreement among raft nodes before linearized reading'  (duration: 391.709026ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:10.200727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:09.891372Z","time spent":"309.345588ms","remote":"127.0.0.1:47566","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-09T22:29:10.20077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:09.808634Z","time spent":"392.116664ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-09T22:29:10.948665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:10.564217Z","time spent":"384.443193ms","remote":"127.0.0.1:34250","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-09T22:29:10.948915Z","caller":"traceutil/trace.go:171","msg":"trace[271380772] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"734.51549ms","start":"2026-03-09T22:29:10.214363Z","end":"2026-03-09T22:29:10.948878Z","steps":["trace[271380772] 'process raft request'  (duration: 671.266999ms)","trace[271380772] 'compare'  (duration: 63.045676ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:29:10.949092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:10.214343Z","time spent":"734.659553ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:902 > 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-09T22:29:11.034268Z","caller":"traceutil/trace.go:171","msg":"trace[1739371313] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"818.170947ms","start":"2026-03-09T22:29:10.216077Z","end":"2026-03-09T22:29:11.034248Z","steps":["trace[1739371313] 'process raft request'  (duration: 817.996692ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:11.034377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:10.21606Z","time spent":"818.258039ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:900 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-09T22:29:11.034597Z","caller":"traceutil/trace.go:171","msg":"trace[52755689] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"817.44912ms","start":"2026-03-09T22:29:10.217142Z","end":"2026-03-09T22:29:11.034591Z","steps":["trace[52755689] 'process raft request'  (duration: 817.074211ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:11.034625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:10.217132Z","time spent":"817.478291ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:899 > 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-09T22:29:11.034674Z","caller":"traceutil/trace.go:171","msg":"trace[208848158] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"816.892908ms","start":"2026-03-09T22:29:10.217776Z","end":"2026-03-09T22:29:11.034669Z","steps":["trace[208848158] 'process raft request'  (duration: 816.685324ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:11.034707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:10.217759Z","time spent":"816.923929ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:901 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-09T22:29:11.052153Z","caller":"traceutil/trace.go:171","msg":"trace[190432074] linearizableReadLoop","detail":"{readStateIndex:947; appliedIndex:942; }","duration":"426.891149ms","start":"2026-03-09T22:29:10.625242Z","end":"2026-03-09T22:29:11.052133Z","steps":["trace[190432074] 'read index received'  (duration: 260.390956ms)","trace[190432074] 'applied index is now lower than readState.Index'  (duration: 166.499133ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:29:11.052351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.044473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-09T22:29:11.052493Z","caller":"traceutil/trace.go:171","msg":"trace[1470111489] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:908; }","duration":"427.263068ms","start":"2026-03-09T22:29:10.6252Z","end":"2026-03-09T22:29:11.052463Z","steps":["trace[1470111489] 'agreement among raft nodes before linearized reading'  (duration: 426.995662ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:11.052548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:10.62518Z","time spent":"427.35893ms","remote":"127.0.0.1:37294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:29:13.435956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.725826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:29:13.436051Z","caller":"traceutil/trace.go:171","msg":"trace[695190229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:910; }","duration":"326.86083ms","start":"2026-03-09T22:29:13.109169Z","end":"2026-03-09T22:29:13.436029Z","steps":["trace[695190229] 'range keys from in-memory index tree'  (duration: 326.664205ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:13.436043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.543545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-03-09T22:29:13.436092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:13.109152Z","time spent":"326.931631ms","remote":"127.0.0.1:47288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-09T22:29:13.436162Z","caller":"traceutil/trace.go:171","msg":"trace[1584798127] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:910; }","duration":"397.670578ms","start":"2026-03-09T22:29:13.038437Z","end":"2026-03-09T22:29:13.436107Z","steps":["trace[1584798127] 'range keys from in-memory index tree'  (duration: 397.392212ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:13.436222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:13.038419Z","time spent":"397.788441ms","remote":"127.0.0.1:47566","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-09T22:29:13.436359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.895358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-09T22:29:13.436421Z","caller":"traceutil/trace.go:171","msg":"trace[1882541341] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:910; }","duration":"225.923158ms","start":"2026-03-09T22:29:13.210455Z","end":"2026-03-09T22:29:13.436378Z","steps":["trace[1882541341] 'range keys from in-memory index tree'  (duration: 225.715144ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:13.436417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.29024ms","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-09T22:29:13.436467Z","caller":"traceutil/trace.go:171","msg":"trace[1918477669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:910; }","duration":"397.408233ms","start":"2026-03-09T22:29:13.039046Z","end":"2026-03-09T22:29:13.436454Z","steps":["trace[1918477669] 'range keys from in-memory index tree'  (duration: 397.100906ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:13.436498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:13.039014Z","time spent":"397.474794ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-09T22:29:13.436603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.637697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-09T22:29:13.436615Z","caller":"traceutil/trace.go:171","msg":"trace[779200011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:910; }","duration":"397.658178ms","start":"2026-03-09T22:29:13.038953Z","end":"2026-03-09T22:29:13.436611Z","steps":["trace[779200011] 'range keys from in-memory index tree'  (duration: 397.592657ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:13.436627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:13.038949Z","time spent":"397.674399ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-09T22:29:23.135098Z","caller":"traceutil/trace.go:171","msg":"trace[390960998] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"128.552297ms","start":"2026-03-09T22:29:23.006526Z","end":"2026-03-09T22:29:23.135079Z","steps":["trace[390960998] 'process raft request'  (duration: 128.418944ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:24.702729Z","caller":"traceutil/trace.go:171","msg":"trace[1265544372] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"190.605221ms","start":"2026-03-09T22:29:24.512104Z","end":"2026-03-09T22:29:24.70271Z","steps":["trace[1265544372] 'process raft request'  (duration: 190.509239ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:25.748315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.487548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-09T22:29:25.748422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.698707ms","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-09T22:29:25.748435Z","caller":"traceutil/trace.go:171","msg":"trace[515738431] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:944; }","duration":"464.626211ms","start":"2026-03-09T22:29:25.283755Z","end":"2026-03-09T22:29:25.748381Z","steps":["trace[515738431] 'count revisions from in-memory index tree'  (duration: 464.402707ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:25.748472Z","caller":"traceutil/trace.go:171","msg":"trace[2058985628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:944; }","duration":"166.748518ms","start":"2026-03-09T22:29:25.581707Z","end":"2026-03-09T22:29:25.748455Z","steps":["trace[2058985628] 'range keys from in-memory index tree'  (duration: 166.460441ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:25.748505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:25.283719Z","time spent":"464.769765ms","remote":"127.0.0.1:37330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-03-09T22:29:25.748614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.379986ms","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-09T22:29:25.748709Z","caller":"traceutil/trace.go:171","msg":"trace[45888831] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:944; }","duration":"264.522438ms","start":"2026-03-09T22:29:25.484162Z","end":"2026-03-09T22:29:25.748684Z","steps":["trace[45888831] 'count revisions from in-memory index tree'  (duration: 264.306773ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:25.748794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.220623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-09T22:29:25.748844Z","caller":"traceutil/trace.go:171","msg":"trace[189935638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:944; }","duration":"178.265744ms","start":"2026-03-09T22:29:25.570565Z","end":"2026-03-09T22:29:25.74883Z","steps":["trace[189935638] 'range keys from in-memory index tree'  (duration: 178.0744ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:25.748909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.326408ms","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-09T22:29:25.748999Z","caller":"traceutil/trace.go:171","msg":"trace[592573932] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:944; }","duration":"166.43115ms","start":"2026-03-09T22:29:25.582548Z","end":"2026-03-09T22:29:25.748979Z","steps":["trace[592573932] 'range keys from in-memory index tree'  (duration: 166.115024ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:25.749028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.522046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:29:25.749077Z","caller":"traceutil/trace.go:171","msg":"trace[664281965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:944; }","duration":"637.606598ms","start":"2026-03-09T22:29:25.111456Z","end":"2026-03-09T22:29:25.749063Z","steps":["trace[664281965] 'range keys from in-memory index tree'  (duration: 637.455135ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:25.749106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:25.111436Z","time spent":"637.662849ms","remote":"127.0.0.1:47288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-09T22:29:25.749172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.2426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-03-09T22:29:25.749247Z","caller":"traceutil/trace.go:171","msg":"trace[327182212] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:944; }","duration":"611.321413ms","start":"2026-03-09T22:29:25.137891Z","end":"2026-03-09T22:29:25.749213Z","steps":["trace[327182212] 'range keys from in-memory index tree'  (duration: 611.145128ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:25.749282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:25.137877Z","time spent":"611.396534ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-09T22:29:26.431459Z","caller":"traceutil/trace.go:171","msg":"trace[1248830644] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"131.497883ms","start":"2026-03-09T22:29:26.299937Z","end":"2026-03-09T22:29:26.431435Z","steps":["trace[1248830644] 'process raft request'  (duration: 131.37337ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:27.308363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.181238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:29:27.308505Z","caller":"traceutil/trace.go:171","msg":"trace[1938965616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:951; }","duration":"197.368792ms","start":"2026-03-09T22:29:27.111111Z","end":"2026-03-09T22:29:27.30848Z","steps":["trace[1938965616] 'range keys from in-memory index tree'  (duration: 197.110096ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:28.181232Z","caller":"traceutil/trace.go:171","msg":"trace[654074212] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"449.32889ms","start":"2026-03-09T22:29:27.73189Z","end":"2026-03-09T22:29:28.181219Z","steps":["trace[654074212] 'process raft request'  (duration: 448.796169ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:28.181959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:27.731872Z","time spent":"449.423542ms","remote":"127.0.0.1:47466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5353,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:746 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5319 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-09T22:29:28.182631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.645862ms","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-09T22:29:28.182682Z","caller":"traceutil/trace.go:171","msg":"trace[1420381748] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:952; }","duration":"373.736304ms","start":"2026-03-09T22:29:27.808935Z","end":"2026-03-09T22:29:28.182671Z","steps":["trace[1420381748] 'agreement among raft nodes before linearized reading'  (duration: 373.594161ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:28.182714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:27.808913Z","time spent":"373.794235ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-09T22:29:28.181052Z","caller":"traceutil/trace.go:171","msg":"trace[1685886627] linearizableReadLoop","detail":"{readStateIndex:994; appliedIndex:993; }","duration":"372.056696ms","start":"2026-03-09T22:29:27.808976Z","end":"2026-03-09T22:29:28.181033Z","steps":["trace[1685886627] 'read index received'  (duration: 371.829541ms)","trace[1685886627] 'applied index is now lower than readState.Index'  (duration: 225.855µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:29:28.287663Z","caller":"traceutil/trace.go:171","msg":"trace[490246235] linearizableReadLoop","detail":"{readStateIndex:995; appliedIndex:994; }","duration":"104.494159ms","start":"2026-03-09T22:29:28.183149Z","end":"2026-03-09T22:29:28.287643Z","steps":["trace[490246235] 'read index received'  (duration: 33.093128ms)","trace[490246235] 'applied index is now lower than readState.Index'  (duration: 71.400031ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:29:28.288006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.610361ms","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-09T22:29:28.288062Z","caller":"traceutil/trace.go:171","msg":"trace[1549700715] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:953; }","duration":"442.727713ms","start":"2026-03-09T22:29:27.845317Z","end":"2026-03-09T22:29:28.288044Z","steps":["trace[1549700715] 'agreement among raft nodes before linearized reading'  (duration: 442.460366ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:28.288117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:27.845298Z","time spent":"442.808315ms","remote":"127.0.0.1:47566","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-09T22:29:28.288447Z","caller":"traceutil/trace.go:171","msg":"trace[1503924030] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"297.663719ms","start":"2026-03-09T22:29:27.990712Z","end":"2026-03-09T22:29:28.288376Z","steps":["trace[1503924030] 'process raft request'  (duration: 225.5225ms)","trace[1503924030] 'compare'  (duration: 71.310699ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:29:28.288638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.802715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:29:28.28868Z","caller":"traceutil/trace.go:171","msg":"trace[1660584231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:953; }","duration":"177.957449ms","start":"2026-03-09T22:29:28.110714Z","end":"2026-03-09T22:29:28.288672Z","steps":["trace[1660584231] 'agreement among raft nodes before linearized reading'  (duration: 177.897568ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:28.288856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.831675ms","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-09T22:29:28.288888Z","caller":"traceutil/trace.go:171","msg":"trace[356800302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:953; }","duration":"442.965759ms","start":"2026-03-09T22:29:27.845915Z","end":"2026-03-09T22:29:28.28888Z","steps":["trace[356800302] 'agreement among raft nodes before linearized reading'  (duration: 442.875887ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:28.288916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:27.845903Z","time spent":"443.006569ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-09T22:29:28.289075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.067151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-09T22:29:28.289107Z","caller":"traceutil/trace.go:171","msg":"trace[1737700139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:953; }","duration":"443.115391ms","start":"2026-03-09T22:29:27.845983Z","end":"2026-03-09T22:29:28.289099Z","steps":["trace[1737700139] 'agreement among raft nodes before linearized reading'  (duration: 443.0409ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:28.289131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:27.845975Z","time spent":"443.150692ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-09T22:29:28.298665Z","caller":"traceutil/trace.go:171","msg":"trace[1980547671] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"112.355145ms","start":"2026-03-09T22:29:28.1863Z","end":"2026-03-09T22:29:28.298655Z","steps":["trace[1980547671] 'process raft request'  (duration: 112.296674ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:28.558307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.406182ms","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-09T22:29:28.558395Z","caller":"traceutil/trace.go:171","msg":"trace[1577484485] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:958; }","duration":"123.551806ms","start":"2026-03-09T22:29:28.434824Z","end":"2026-03-09T22:29:28.558376Z","steps":["trace[1577484485] 'range keys from in-memory index tree'  (duration: 123.236469ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:29.255033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.058829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5367"}
{"level":"info","ts":"2026-03-09T22:29:29.255103Z","caller":"traceutil/trace.go:171","msg":"trace[1545735074] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:962; }","duration":"151.170201ms","start":"2026-03-09T22:29:29.103916Z","end":"2026-03-09T22:29:29.255086Z","steps":["trace[1545735074] 'range keys from in-memory index tree'  (duration: 150.884945ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:29.535511Z","caller":"traceutil/trace.go:171","msg":"trace[1831425695] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"227.438782ms","start":"2026-03-09T22:29:29.308048Z","end":"2026-03-09T22:29:29.535486Z","steps":["trace[1831425695] 'process raft request'  (duration: 227.271808ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:29.925322Z","caller":"traceutil/trace.go:171","msg":"trace[963912771] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"386.136202ms","start":"2026-03-09T22:29:29.539163Z","end":"2026-03-09T22:29:29.9253Z","steps":["trace[963912771] 'process raft request'  (duration: 386.014069ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:29.925471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:29.539139Z","time spent":"386.251444ms","remote":"127.0.0.1:47394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":821,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-r2w5k.189b4cd81887aeaa\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-r2w5k.189b4cd81887aeaa\" value_size:728 lease:3207016847069001722 >> failure:<>"}
{"level":"warn","ts":"2026-03-09T22:29:30.207739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.788417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:29:30.207833Z","caller":"traceutil/trace.go:171","msg":"trace[1572909178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"117.94021ms","start":"2026-03-09T22:29:30.089873Z","end":"2026-03-09T22:29:30.207813Z","steps":["trace[1572909178] 'range keys from in-memory index tree'  (duration: 117.662004ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:30.757273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.629681ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388883923777921 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:955 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-09T22:29:30.757412Z","caller":"traceutil/trace.go:171","msg":"trace[1916358262] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1009; }","duration":"107.732842ms","start":"2026-03-09T22:29:30.649666Z","end":"2026-03-09T22:29:30.757399Z","steps":["trace[1916358262] 'read index received'  (duration: 57.951µs)","trace[1916358262] 'applied index is now lower than readState.Index'  (duration: 107.673761ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:29:30.757411Z","caller":"traceutil/trace.go:171","msg":"trace[1852532398] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"399.381057ms","start":"2026-03-09T22:29:30.358011Z","end":"2026-03-09T22:29:30.757392Z","steps":["trace[1852532398] 'process raft request'  (duration: 247.552461ms)","trace[1852532398] 'compare'  (duration: 151.519639ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:29:30.757506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:30.357977Z","time spent":"399.477379ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:955 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-09T22:29:30.757524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.863365ms","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-09T22:29:30.757555Z","caller":"traceutil/trace.go:171","msg":"trace[1302927429] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:968; }","duration":"107.930746ms","start":"2026-03-09T22:29:30.649618Z","end":"2026-03-09T22:29:30.757549Z","steps":["trace[1302927429] 'agreement among raft nodes before linearized reading'  (duration: 107.816314ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:30.757708Z","caller":"traceutil/trace.go:171","msg":"trace[2048527081] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"399.672733ms","start":"2026-03-09T22:29:30.35803Z","end":"2026-03-09T22:29:30.757703Z","steps":["trace[2048527081] 'process raft request'  (duration: 399.325405ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:30.757738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:30.358009Z","time spent":"399.713064ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:957 > 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-09T22:29:33.374813Z","caller":"traceutil/trace.go:171","msg":"trace[822315183] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"155.942476ms","start":"2026-03-09T22:29:33.218838Z","end":"2026-03-09T22:29:33.37478Z","steps":["trace[822315183] 'process raft request'  (duration: 155.705821ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:33.376176Z","caller":"traceutil/trace.go:171","msg":"trace[640537699] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"135.765278ms","start":"2026-03-09T22:29:33.240372Z","end":"2026-03-09T22:29:33.376138Z","steps":["trace[640537699] 'process raft request'  (duration: 135.626125ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:38.612515Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12430388883923778035,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-09T22:29:38.907188Z","caller":"traceutil/trace.go:171","msg":"trace[533861209] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"829.944628ms","start":"2026-03-09T22:29:38.077214Z","end":"2026-03-09T22:29:38.907159Z","steps":["trace[533861209] 'process raft request'  (duration: 829.776954ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:38.907357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:38.077199Z","time spent":"830.071481ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13706,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-ggj7l\" mod_revision:886 > success:<request_put:<key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-ggj7l\" value_size:13631 >> failure:<request_range:<key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-ggj7l\" > >"}
{"level":"warn","ts":"2026-03-09T22:29:39.041449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.375323ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388883923778037 > lease_revoke:<id:2c819cd4b63db93e>","response":"size:28"}
{"level":"info","ts":"2026-03-09T22:29:39.041801Z","caller":"traceutil/trace.go:171","msg":"trace[1252474360] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"134.900419ms","start":"2026-03-09T22:29:38.906868Z","end":"2026-03-09T22:29:39.041768Z","steps":["trace[1252474360] 'process raft request'  (duration: 134.684284ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:39.041814Z","caller":"traceutil/trace.go:171","msg":"trace[87298998] linearizableReadLoop","detail":"{readStateIndex:1080; appliedIndex:1078; }","duration":"930.197684ms","start":"2026-03-09T22:29:38.111588Z","end":"2026-03-09T22:29:39.041786Z","steps":["trace[87298998] 'read index received'  (duration: 795.400378ms)","trace[87298998] 'applied index is now lower than readState.Index'  (duration: 134.794736ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:29:39.042088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"930.488971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:29:39.04181Z","caller":"traceutil/trace.go:171","msg":"trace[472142627] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"125.967129ms","start":"2026-03-09T22:29:38.915822Z","end":"2026-03-09T22:29:39.041789Z","steps":["trace[472142627] 'process raft request'  (duration: 125.915258ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:39.042166Z","caller":"traceutil/trace.go:171","msg":"trace[517364154] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1038; }","duration":"930.616293ms","start":"2026-03-09T22:29:38.111533Z","end":"2026-03-09T22:29:39.042149Z","steps":["trace[517364154] 'agreement among raft nodes before linearized reading'  (duration: 930.47331ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:39.042274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:38.111523Z","time spent":"930.739266ms","remote":"127.0.0.1:47288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-09T22:29:39.042236Z","caller":"traceutil/trace.go:171","msg":"trace[1253738051] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"126.849748ms","start":"2026-03-09T22:29:38.915038Z","end":"2026-03-09T22:29:39.041887Z","steps":["trace[1253738051] 'process raft request'  (duration: 126.651234ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:39.163134Z","caller":"traceutil/trace.go:171","msg":"trace[1731634822] linearizableReadLoop","detail":"{readStateIndex:1084; appliedIndex:1083; }","duration":"121.125482ms","start":"2026-03-09T22:29:39.041977Z","end":"2026-03-09T22:29:39.163103Z","steps":["trace[1731634822] 'read index received'  (duration: 115.010665ms)","trace[1731634822] 'applied index is now lower than readState.Index'  (duration: 6.113397ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:29:39.163218Z","caller":"traceutil/trace.go:171","msg":"trace[2021621760] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"242.814535ms","start":"2026-03-09T22:29:38.920365Z","end":"2026-03-09T22:29:39.163179Z","steps":["trace[2021621760] 'process raft request'  (duration: 236.707908ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:39.16336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.358579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-09T22:29:39.163361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.15483ms","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-09T22:29:39.163401Z","caller":"traceutil/trace.go:171","msg":"trace[988864469] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1039; }","duration":"370.455881ms","start":"2026-03-09T22:29:38.792935Z","end":"2026-03-09T22:29:39.163391Z","steps":["trace[988864469] 'agreement among raft nodes before linearized reading'  (duration: 370.308248ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:29:39.163422Z","caller":"traceutil/trace.go:171","msg":"trace[1202286947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1039; }","duration":"368.278873ms","start":"2026-03-09T22:29:38.795127Z","end":"2026-03-09T22:29:39.163406Z","steps":["trace[1202286947] 'agreement among raft nodes before linearized reading'  (duration: 368.073028ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:39.163459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:38.792912Z","time spent":"370.539874ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-09T22:29:39.163465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:38.795091Z","time spent":"368.361315ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-09T22:29:39.16352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.702941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:29:39.163586Z","caller":"traceutil/trace.go:171","msg":"trace[1714831348] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1039; }","duration":"667.825733ms","start":"2026-03-09T22:29:38.495741Z","end":"2026-03-09T22:29:39.163567Z","steps":["trace[1714831348] 'agreement among raft nodes before linearized reading'  (duration: 667.720141ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:39.163637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.082821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-09T22:29:39.163682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:38.495719Z","time spent":"667.949607ms","remote":"127.0.0.1:42030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"info","ts":"2026-03-09T22:29:39.163754Z","caller":"traceutil/trace.go:171","msg":"trace[457480212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1039; }","duration":"369.48796ms","start":"2026-03-09T22:29:38.79424Z","end":"2026-03-09T22:29:39.163728Z","steps":["trace[457480212] 'agreement among raft nodes before linearized reading'  (duration: 368.885587ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:39.163892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.118778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:29:39.16404Z","caller":"traceutil/trace.go:171","msg":"trace[1770181533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1039; }","duration":"120.503947ms","start":"2026-03-09T22:29:39.043511Z","end":"2026-03-09T22:29:39.164015Z","steps":["trace[1770181533] 'agreement among raft nodes before linearized reading'  (duration: 120.026497ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:39.164988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.937709ms","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-09T22:29:39.165069Z","caller":"traceutil/trace.go:171","msg":"trace[675118260] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1039; }","duration":"587.062951ms","start":"2026-03-09T22:29:38.577992Z","end":"2026-03-09T22:29:39.165055Z","steps":["trace[675118260] 'agreement among raft nodes before linearized reading'  (duration: 585.365954ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:39.165104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:38.57797Z","time spent":"587.125773ms","remote":"127.0.0.1:47566","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-09T22:29:39.163821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:38.794208Z","time spent":"369.599833ms","remote":"127.0.0.1:47566","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-09T22:29:39.164877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.800978ms","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-09T22:29:39.165756Z","caller":"traceutil/trace.go:171","msg":"trace[1676458386] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1039; }","duration":"779.738379ms","start":"2026-03-09T22:29:38.386001Z","end":"2026-03-09T22:29:39.16574Z","steps":["trace[1676458386] 'agreement among raft nodes before linearized reading'  (duration: 777.321915ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:29:39.165808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:29:38.385983Z","time spent":"779.810421ms","remote":"127.0.0.1:47566","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":"info","ts":"2026-03-09T22:30:51.334897Z","caller":"traceutil/trace.go:171","msg":"trace[1631765651] linearizableReadLoop","detail":"{readStateIndex:1395; appliedIndex:1394; }","duration":"224.364193ms","start":"2026-03-09T22:30:51.110509Z","end":"2026-03-09T22:30:51.334873Z","steps":["trace[1631765651] 'read index received'  (duration: 224.173909ms)","trace[1631765651] 'applied index is now lower than readState.Index'  (duration: 189.424µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:30:51.335014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.491466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:30:51.335047Z","caller":"traceutil/trace.go:171","msg":"trace[719478527] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1336; }","duration":"224.561398ms","start":"2026-03-09T22:30:51.110475Z","end":"2026-03-09T22:30:51.335036Z","steps":["trace[719478527] 'agreement among raft nodes before linearized reading'  (duration: 224.494506ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:30:51.334959Z","caller":"traceutil/trace.go:171","msg":"trace[462221219] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"267.020477ms","start":"2026-03-09T22:30:51.0679Z","end":"2026-03-09T22:30:51.33492Z","steps":["trace[462221219] 'process raft request'  (duration: 266.838393ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:30:52.164934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.289239ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388883923778808 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1332 > 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-09T22:30:52.165053Z","caller":"traceutil/trace.go:171","msg":"trace[727495268] linearizableReadLoop","detail":"{readStateIndex:1400; appliedIndex:1399; }","duration":"396.824949ms","start":"2026-03-09T22:30:51.768207Z","end":"2026-03-09T22:30:52.165032Z","steps":["trace[727495268] 'read index received'  (duration: 57.471µs)","trace[727495268] 'applied index is now lower than readState.Index'  (duration: 396.765538ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:30:52.165255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.046113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-03-09T22:30:52.165312Z","caller":"traceutil/trace.go:171","msg":"trace[315359813] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1341; }","duration":"397.143066ms","start":"2026-03-09T22:30:51.768154Z","end":"2026-03-09T22:30:52.165298Z","steps":["trace[315359813] 'agreement among raft nodes before linearized reading'  (duration: 396.967632ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:30:52.165368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:30:51.768129Z","time spent":"397.224788ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"info","ts":"2026-03-09T22:30:52.165403Z","caller":"traceutil/trace.go:171","msg":"trace[1194937127] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"522.104369ms","start":"2026-03-09T22:30:51.643054Z","end":"2026-03-09T22:30:52.165158Z","steps":["trace[1194937127] 'process raft request'  (duration: 114.486862ms)","trace[1194937127] 'compare'  (duration: 407.140916ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:30:52.165527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T22:30:51.643035Z","time spent":"522.434716ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1332 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-09T22:30:52.299394Z","caller":"traceutil/trace.go:171","msg":"trace[1460644495] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"129.899014ms","start":"2026-03-09T22:30:52.169472Z","end":"2026-03-09T22:30:52.299371Z","steps":["trace[1460644495] 'process raft request'  (duration: 129.72336ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:31:21.887288Z","caller":"traceutil/trace.go:171","msg":"trace[1271499673] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"116.270693ms","start":"2026-03-09T22:31:21.770973Z","end":"2026-03-09T22:31:21.887243Z","steps":["trace[1271499673] 'process raft request'  (duration: 100.979604ms)","trace[1271499673] 'compare'  (duration: 15.148666ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:31:29.915252Z","caller":"traceutil/trace.go:171","msg":"trace[515032209] transaction","detail":"{read_only:false; response_revision:1493; number_of_response:1; }","duration":"112.290914ms","start":"2026-03-09T22:31:29.802929Z","end":"2026-03-09T22:31:29.915219Z","steps":["trace[515032209] 'process raft request'  (duration: 43.638425ms)","trace[515032209] 'compare'  (duration: 68.539167ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T22:31:32.038993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.473427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-09T22:31:32.039089Z","caller":"traceutil/trace.go:171","msg":"trace[1752420166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1501; }","duration":"102.620331ms","start":"2026-03-09T22:31:31.936449Z","end":"2026-03-09T22:31:32.03907Z","steps":["trace[1752420166] 'range keys from in-memory index tree'  (duration: 102.285573ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:31:32.039461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.868902ms","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-09T22:31:32.03955Z","caller":"traceutil/trace.go:171","msg":"trace[1946103129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1501; }","duration":"119.989264ms","start":"2026-03-09T22:31:31.919528Z","end":"2026-03-09T22:31:32.039517Z","steps":["trace[1946103129] 'range keys from in-memory index tree'  (duration: 119.654787ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:32:00.481492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.95462ms","expected-duration":"100ms","prefix":"","request":"header:<ID:12430388883923779527 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1611 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-09T22:32:00.481766Z","caller":"traceutil/trace.go:171","msg":"trace[80184068] transaction","detail":"{read_only:false; response_revision:1619; number_of_response:1; }","duration":"166.29814ms","start":"2026-03-09T22:32:00.315427Z","end":"2026-03-09T22:32:00.481725Z","steps":["trace[80184068] 'process raft request'  (duration: 28.710266ms)","trace[80184068] 'compare'  (duration: 136.788117ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:32:33.264344Z","caller":"traceutil/trace.go:171","msg":"trace[724264675] linearizableReadLoop","detail":"{readStateIndex:1834; appliedIndex:1833; }","duration":"120.903005ms","start":"2026-03-09T22:32:33.143417Z","end":"2026-03-09T22:32:33.26432Z","steps":["trace[724264675] 'read index received'  (duration: 120.789952ms)","trace[724264675] 'applied index is now lower than readState.Index'  (duration: 112.133µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T22:32:33.264513Z","caller":"traceutil/trace.go:171","msg":"trace[2056552481] transaction","detail":"{read_only:false; response_revision:1755; number_of_response:1; }","duration":"135.791304ms","start":"2026-03-09T22:32:33.128589Z","end":"2026-03-09T22:32:33.26438Z","steps":["trace[2056552481] 'process raft request'  (duration: 135.573509ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:32:33.264613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.179911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T22:32:33.2647Z","caller":"traceutil/trace.go:171","msg":"trace[1506508203] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:0; response_revision:1755; }","duration":"121.299064ms","start":"2026-03-09T22:32:33.143378Z","end":"2026-03-09T22:32:33.264677Z","steps":["trace[1506508203] 'agreement among raft nodes before linearized reading'  (duration: 121.166841ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:32:45.52903Z","caller":"traceutil/trace.go:171","msg":"trace[719764677] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"186.960638ms","start":"2026-03-09T22:32:45.342042Z","end":"2026-03-09T22:32:45.529003Z","steps":["trace[719764677] 'process raft request'  (duration: 186.806334ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T22:32:55.83712Z","caller":"traceutil/trace.go:171","msg":"trace[531066858] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"242.499261ms","start":"2026-03-09T22:32:55.594596Z","end":"2026-03-09T22:32:55.837095Z","steps":["trace[531066858] 'process raft request'  (duration: 242.365518ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T22:32:56.746492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.665326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-03-09T22:32:56.746559Z","caller":"traceutil/trace.go:171","msg":"trace[1515205651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1876; }","duration":"147.774059ms","start":"2026-03-09T22:32:56.598772Z","end":"2026-03-09T22:32:56.746546Z","steps":["trace[1515205651] 'range keys from in-memory index tree'  (duration: 147.562254ms)"],"step_count":1}