{"level":"warn","ts":"2026-03-19T13:36:43.35963Z","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-19T13:36:43.359714Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.136:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.136:2380","--initial-cluster=instance=https://199.19.213.136:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.136:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.136: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-19T13:36:43.359781Z","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-19T13:36:43.359792Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.136:2380"]}
{"level":"info","ts":"2026-03-19T13:36:43.359814Z","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-19T13:36:43.360399Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"]}
{"level":"info","ts":"2026-03-19T13:36:43.360471Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.136:2380"],"listen-peer-urls":["https://199.19.213.136:2380"],"advertise-client-urls":["https://199.19.213.136:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.136: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-19T13:36:43.371815Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"11.076744ms"}
{"level":"info","ts":"2026-03-19T13:36:43.386153Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bcbe0b88c51dc5e5","cluster-id":"e591ddd6f6a32da9"}
{"level":"info","ts":"2026-03-19T13:36:43.386269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-19T13:36:43.386295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became follower at term 0"}
{"level":"info","ts":"2026-03-19T13:36:43.386304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bcbe0b88c51dc5e5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-19T13:36:43.38632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became follower at term 1"}
{"level":"info","ts":"2026-03-19T13:36:43.386355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=(13600320606755997157)"}
{"level":"warn","ts":"2026-03-19T13:36:43.402405Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-19T13:36:43.404162Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-19T13:36:43.405852Z","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-19T13:36:43.409358Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bcbe0b88c51dc5e5","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-19T13:36:43.409592Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bcbe0b88c51dc5e5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-19T13:36:43.409768Z","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-19T13:36:43.409814Z","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-19T13:36:43.409825Z","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-19T13:36:43.413477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=(13600320606755997157)"}
{"level":"info","ts":"2026-03-19T13:36:43.413717Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e591ddd6f6a32da9","local-member-id":"bcbe0b88c51dc5e5","added-peer-id":"bcbe0b88c51dc5e5","added-peer-peer-urls":["https://199.19.213.136:2380"]}
{"level":"info","ts":"2026-03-19T13:36:43.415238Z","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-19T13:36:43.415369Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.136:2380"}
{"level":"info","ts":"2026-03-19T13:36:43.415447Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.136:2380"}
{"level":"info","ts":"2026-03-19T13:36:43.41567Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bcbe0b88c51dc5e5","initial-advertise-peer-urls":["https://199.19.213.136:2380"],"listen-peer-urls":["https://199.19.213.136:2380"],"advertise-client-urls":["https://199.19.213.136:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-19T13:36:43.415706Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-19T13:36:44.386837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-19T13:36:44.386923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-19T13:36:44.386952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 received MsgPreVoteResp from bcbe0b88c51dc5e5 at term 1"}
{"level":"info","ts":"2026-03-19T13:36:44.386974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became candidate at term 2"}
{"level":"info","ts":"2026-03-19T13:36:44.386985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 received MsgVoteResp from bcbe0b88c51dc5e5 at term 2"}
{"level":"info","ts":"2026-03-19T13:36:44.387003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became leader at term 2"}
{"level":"info","ts":"2026-03-19T13:36:44.387017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bcbe0b88c51dc5e5 elected leader bcbe0b88c51dc5e5 at term 2"}
{"level":"info","ts":"2026-03-19T13:36:44.388613Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bcbe0b88c51dc5e5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.136:2379]}","request-path":"/0/members/bcbe0b88c51dc5e5/attributes","cluster-id":"e591ddd6f6a32da9","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-19T13:36:44.388743Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T13:36:44.388947Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:36:44.388978Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-19T13:36:44.389093Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-19T13:36:44.390335Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e591ddd6f6a32da9","local-member-id":"bcbe0b88c51dc5e5","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:36:44.390534Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:36:44.390596Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-19T13:36:44.392351Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-19T13:36:44.40245Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-19T13:36:44.404333Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.136:2379"}
{"level":"warn","ts":"2026-03-19T13:37:25.173785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.126124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:37:25.173883Z","caller":"traceutil/trace.go:171","msg":"trace[1780063622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"239.272707ms","start":"2026-03-19T13:37:24.934594Z","end":"2026-03-19T13:37:25.173866Z","steps":["trace[1780063622] 'range keys from in-memory index tree'  (duration: 239.064562ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:28.620634Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259976445577100948,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-19T13:37:28.792141Z","caller":"traceutil/trace.go:171","msg":"trace[1558366978] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:539; }","duration":"672.07355ms","start":"2026-03-19T13:37:28.120039Z","end":"2026-03-19T13:37:28.792112Z","steps":["trace[1558366978] 'read index received'  (duration: 671.874985ms)","trace[1558366978] 'applied index is now lower than readState.Index'  (duration: 197.775µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:37:28.792198Z","caller":"traceutil/trace.go:171","msg":"trace[1596592528] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"756.184488ms","start":"2026-03-19T13:37:28.035974Z","end":"2026-03-19T13:37:28.792158Z","steps":["trace[1596592528] 'process raft request'  (duration: 755.996784ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:28.792435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.364969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-19T13:37:28.792506Z","caller":"traceutil/trace.go:171","msg":"trace[1340520376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:521; }","duration":"672.453321ms","start":"2026-03-19T13:37:28.120035Z","end":"2026-03-19T13:37:28.792488Z","steps":["trace[1340520376] 'agreement among raft nodes before linearized reading'  (duration: 672.202963ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:28.792559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.05241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-19T13:37:28.792552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:28.119997Z","time spent":"672.544743ms","remote":"127.0.0.1:46336","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-19T13:37:28.792652Z","caller":"traceutil/trace.go:171","msg":"trace[2043200154] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"285.195384ms","start":"2026-03-19T13:37:28.507438Z","end":"2026-03-19T13:37:28.792634Z","steps":["trace[2043200154] 'agreement among raft nodes before linearized reading'  (duration: 285.03034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:28.792656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.307324ms","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-19T13:37:28.792682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:28.035963Z","time spent":"756.296261ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:515 > 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-19T13:37:28.792728Z","caller":"traceutil/trace.go:171","msg":"trace[559663994] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:521; }","duration":"155.432877ms","start":"2026-03-19T13:37:28.637278Z","end":"2026-03-19T13:37:28.792711Z","steps":["trace[559663994] 'agreement among raft nodes before linearized reading'  (duration: 155.271513ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:33.008849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.211699ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259976445577100975 > lease_revoke:<id:45e59d06500f7e0c>","response":"size:29"}
{"level":"info","ts":"2026-03-19T13:37:33.008921Z","caller":"traceutil/trace.go:171","msg":"trace[1730689534] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"523.559947ms","start":"2026-03-19T13:37:32.485349Z","end":"2026-03-19T13:37:33.008909Z","steps":["trace[1730689534] 'read index received'  (duration: 373.121952ms)","trace[1730689534] 'applied index is now lower than readState.Index'  (duration: 150.437155ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:37:33.009054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.711201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cjd76\" ","response":"range_response_count:1 size:16965"}
{"level":"warn","ts":"2026-03-19T13:37:33.009055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.010523ms","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-19T13:37:33.009078Z","caller":"traceutil/trace.go:171","msg":"trace[980892184] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cjd76; range_end:; response_count:1; response_revision:532; }","duration":"523.777234ms","start":"2026-03-19T13:37:32.485295Z","end":"2026-03-19T13:37:33.009072Z","steps":["trace[980892184] 'agreement among raft nodes before linearized reading'  (duration: 523.674791ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:33.009103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:32.485229Z","time spent":"523.868686ms","remote":"127.0.0.1:46256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-cjd76\" "}
{"level":"info","ts":"2026-03-19T13:37:33.009098Z","caller":"traceutil/trace.go:171","msg":"trace[129834086] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:532; }","duration":"198.088657ms","start":"2026-03-19T13:37:32.810997Z","end":"2026-03-19T13:37:33.009086Z","steps":["trace[129834086] 'agreement among raft nodes before linearized reading'  (duration: 198.009264ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:33.00939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.395469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-19T13:37:33.009431Z","caller":"traceutil/trace.go:171","msg":"trace[1873568727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:532; }","duration":"194.479001ms","start":"2026-03-19T13:37:32.814943Z","end":"2026-03-19T13:37:33.009422Z","steps":["trace[1873568727] 'agreement among raft nodes before linearized reading'  (duration: 194.371578ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:33.0097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.795948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-19T13:37:33.009793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.877342ms","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-19T13:37:33.009826Z","caller":"traceutil/trace.go:171","msg":"trace[1122934954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:532; }","duration":"194.937244ms","start":"2026-03-19T13:37:32.814879Z","end":"2026-03-19T13:37:33.009816Z","steps":["trace[1122934954] 'agreement among raft nodes before linearized reading'  (duration: 194.853011ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:33.009802Z","caller":"traceutil/trace.go:171","msg":"trace[254807816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:532; }","duration":"197.961593ms","start":"2026-03-19T13:37:32.811819Z","end":"2026-03-19T13:37:33.00978Z","steps":["trace[254807816] 'agreement among raft nodes before linearized reading'  (duration: 197.750227ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:33.472567Z","caller":"traceutil/trace.go:171","msg":"trace[41297119] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"459.564172ms","start":"2026-03-19T13:37:33.012979Z","end":"2026-03-19T13:37:33.472543Z","steps":["trace[41297119] 'process raft request'  (duration: 459.364336ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:33.472727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:33.012966Z","time spent":"459.677275ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:528 > 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-19T13:37:33.472952Z","caller":"traceutil/trace.go:171","msg":"trace[1838815343] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"459.649703ms","start":"2026-03-19T13:37:33.013283Z","end":"2026-03-19T13:37:33.472932Z","steps":["trace[1838815343] 'process raft request'  (duration: 459.219761ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:33.473073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:33.013271Z","time spent":"459.732596ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:526 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-19T13:37:33.4735Z","caller":"traceutil/trace.go:171","msg":"trace[1096576643] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"446.733642ms","start":"2026-03-19T13:37:33.026747Z","end":"2026-03-19T13:37:33.473481Z","steps":["trace[1096576643] 'process raft request'  (duration: 446.453484ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:33.473547Z","caller":"traceutil/trace.go:171","msg":"trace[51163505] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"457.849636ms","start":"2026-03-19T13:37:33.015646Z","end":"2026-03-19T13:37:33.473496Z","steps":["trace[51163505] 'process raft request'  (duration: 457.217359ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:33.473586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:33.026729Z","time spent":"446.818083ms","remote":"127.0.0.1:46256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-cjd76\" mod_revision:507 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-cjd76\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-cjd76\" > >"}
{"level":"warn","ts":"2026-03-19T13:37:33.473728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:33.015639Z","time spent":"458.00034ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:527 > 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-19T13:37:53.361363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.692293ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259976445577101334 > lease_revoke:<id:45e59d06500f7f0d>","response":"size:29"}
{"level":"info","ts":"2026-03-19T13:37:53.361491Z","caller":"traceutil/trace.go:171","msg":"trace[318353719] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:747; }","duration":"503.463585ms","start":"2026-03-19T13:37:52.858005Z","end":"2026-03-19T13:37:53.361468Z","steps":["trace[318353719] 'read index received'  (duration: 88.545996ms)","trace[318353719] 'applied index is now lower than readState.Index'  (duration: 414.915709ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:37:53.361621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.431993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:37:53.361618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.590729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:37:53.361671Z","caller":"traceutil/trace.go:171","msg":"trace[974138714] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:722; }","duration":"503.491895ms","start":"2026-03-19T13:37:52.858161Z","end":"2026-03-19T13:37:53.361653Z","steps":["trace[974138714] 'agreement among raft nodes before linearized reading'  (duration: 503.423594ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:53.361674Z","caller":"traceutil/trace.go:171","msg":"trace[1301918536] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:722; }","duration":"503.68266ms","start":"2026-03-19T13:37:52.857978Z","end":"2026-03-19T13:37:53.361661Z","steps":["trace[1301918536] 'agreement among raft nodes before linearized reading'  (duration: 503.573818ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:53.36169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.874788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:37:53.361718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:52.857964Z","time spent":"503.740493ms","remote":"127.0.0.1:45690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "}
{"level":"info","ts":"2026-03-19T13:37:53.361755Z","caller":"traceutil/trace.go:171","msg":"trace[213312183] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:722; }","duration":"176.001441ms","start":"2026-03-19T13:37:53.185735Z","end":"2026-03-19T13:37:53.361736Z","steps":["trace[213312183] 'agreement among raft nodes before linearized reading'  (duration: 175.883078ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:53.361718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:52.858155Z","time spent":"503.549217ms","remote":"127.0.0.1:45690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-03-19T13:37:53.361819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.93568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:37:53.361835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.274886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:37:53.361866Z","caller":"traceutil/trace.go:171","msg":"trace[611654131] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:722; }","duration":"190.023102ms","start":"2026-03-19T13:37:53.171831Z","end":"2026-03-19T13:37:53.361854Z","steps":["trace[611654131] 'agreement among raft nodes before linearized reading'  (duration: 189.94905ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:53.3619Z","caller":"traceutil/trace.go:171","msg":"trace[1623549213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:722; }","duration":"427.368428ms","start":"2026-03-19T13:37:52.934514Z","end":"2026-03-19T13:37:53.361883Z","steps":["trace[1623549213] 'agreement among raft nodes before linearized reading'  (duration: 427.295006ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:53.361901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.289483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:37:53.361942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:52.934492Z","time spent":"427.44521ms","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-19T13:37:53.361959Z","caller":"traceutil/trace.go:171","msg":"trace[1457578917] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:722; }","duration":"189.396776ms","start":"2026-03-19T13:37:53.172545Z","end":"2026-03-19T13:37:53.361942Z","steps":["trace[1457578917] 'agreement among raft nodes before linearized reading'  (duration: 189.289783ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:53.361994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.228444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:37:53.362011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.409686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"warn","ts":"2026-03-19T13:37:53.362067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.363008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:37:53.362082Z","caller":"traceutil/trace.go:171","msg":"trace[108560568] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:722; }","duration":"138.512209ms","start":"2026-03-19T13:37:53.223552Z","end":"2026-03-19T13:37:53.362064Z","steps":["trace[108560568] 'agreement among raft nodes before linearized reading'  (duration: 138.299053ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:53.362129Z","caller":"traceutil/trace.go:171","msg":"trace[1700282428] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:722; }","duration":"157.419229ms","start":"2026-03-19T13:37:53.204666Z","end":"2026-03-19T13:37:53.362085Z","steps":["trace[1700282428] 'agreement among raft nodes before linearized reading'  (duration: 157.381918ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:53.362142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.408502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:37:53.362213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.745494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:37:53.362231Z","caller":"traceutil/trace.go:171","msg":"trace[329669381] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:722; }","duration":"176.536205ms","start":"2026-03-19T13:37:53.185678Z","end":"2026-03-19T13:37:53.362214Z","steps":["trace[329669381] 'agreement among raft nodes before linearized reading'  (duration: 176.418072ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:53.362246Z","caller":"traceutil/trace.go:171","msg":"trace[1247792048] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:722; }","duration":"175.792387ms","start":"2026-03-19T13:37:53.186446Z","end":"2026-03-19T13:37:53.362238Z","steps":["trace[1247792048] 'agreement among raft nodes before linearized reading'  (duration: 175.746025ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:53.362284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.949897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:37:53.362028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.53202ms","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":"warn","ts":"2026-03-19T13:37:53.361775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.720621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:37:53.362359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.498981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-19T13:37:53.362389Z","caller":"traceutil/trace.go:171","msg":"trace[309768625] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:722; }","duration":"143.564793ms","start":"2026-03-19T13:37:53.218819Z","end":"2026-03-19T13:37:53.362383Z","steps":["trace[309768625] 'agreement among raft nodes before linearized reading'  (duration: 143.521772ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:53.362165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.834974ms","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-19T13:37:53.362438Z","caller":"traceutil/trace.go:171","msg":"trace[1569059091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:722; }","duration":"228.145003ms","start":"2026-03-19T13:37:53.134288Z","end":"2026-03-19T13:37:53.362433Z","steps":["trace[1569059091] 'agreement among raft nodes before linearized reading'  (duration: 227.793923ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:53.362372Z","caller":"traceutil/trace.go:171","msg":"trace[1809834742] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:722; }","duration":"189.925511ms","start":"2026-03-19T13:37:53.172427Z","end":"2026-03-19T13:37:53.362353Z","steps":["trace[1809834742] 'agreement among raft nodes before linearized reading'  (duration: 189.580181ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:53.362034Z","caller":"traceutil/trace.go:171","msg":"trace[662080155] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:722; }","duration":"157.310896ms","start":"2026-03-19T13:37:53.204715Z","end":"2026-03-19T13:37:53.362026Z","steps":["trace[662080155] 'agreement among raft nodes before linearized reading'  (duration: 157.219343ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:53.362325Z","caller":"traceutil/trace.go:171","msg":"trace[1993950205] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:722; }","duration":"503.994729ms","start":"2026-03-19T13:37:52.858317Z","end":"2026-03-19T13:37:53.362312Z","steps":["trace[1993950205] 'agreement among raft nodes before linearized reading'  (duration: 503.950198ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:53.362632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:52.858312Z","time spent":"504.299346ms","remote":"127.0.0.1:45690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "}
{"level":"info","ts":"2026-03-19T13:37:53.362388Z","caller":"traceutil/trace.go:171","msg":"trace[2065689799] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:722; }","duration":"157.370768ms","start":"2026-03-19T13:37:53.20501Z","end":"2026-03-19T13:37:53.362381Z","steps":["trace[2065689799] 'agreement among raft nodes before linearized reading'  (duration: 156.69381ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:37:53.82046Z","caller":"traceutil/trace.go:171","msg":"trace[1410940109] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"452.213827ms","start":"2026-03-19T13:37:53.368205Z","end":"2026-03-19T13:37:53.820419Z","steps":["trace[1410940109] 'process raft request'  (duration: 452.026902ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:53.820599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:53.368182Z","time spent":"452.346851ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:718 > 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-19T13:37:55.147593Z","caller":"traceutil/trace.go:171","msg":"trace[1289837230] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:748; }","duration":"1.593579848s","start":"2026-03-19T13:37:53.553981Z","end":"2026-03-19T13:37:55.14756Z","steps":["trace[1289837230] 'read index received'  (duration: 266.283203ms)","trace[1289837230] 'applied index is now lower than readState.Index'  (duration: 1.327295295s)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:37:55.147814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.593821884s","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-19T13:37:55.147899Z","caller":"traceutil/trace.go:171","msg":"trace[1875208051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:724; }","duration":"1.593970488s","start":"2026-03-19T13:37:53.55391Z","end":"2026-03-19T13:37:55.147881Z","steps":["trace[1875208051] 'agreement among raft nodes before linearized reading'  (duration: 1.593740432s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:55.147945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.588433142s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-03-19T13:37:55.147961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:53.553887Z","time spent":"1.594065551s","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-19T13:37:55.147991Z","caller":"traceutil/trace.go:171","msg":"trace[1173040047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:724; }","duration":"1.588524194s","start":"2026-03-19T13:37:53.559446Z","end":"2026-03-19T13:37:55.14797Z","steps":["trace[1173040047] 'agreement among raft nodes before linearized reading'  (duration: 1.588312199s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:55.147995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.346069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:37:55.148025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:53.559428Z","time spent":"1.588589225s","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-19T13:37:55.148029Z","caller":"traceutil/trace.go:171","msg":"trace[1541815941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:724; }","duration":"213.418222ms","start":"2026-03-19T13:37:54.934601Z","end":"2026-03-19T13:37:55.148019Z","steps":["trace[1541815941] 'agreement among raft nodes before linearized reading'  (duration: 213.360841ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:55.148259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.587748983s","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-19T13:37:55.148281Z","caller":"traceutil/trace.go:171","msg":"trace[771181146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:724; }","duration":"1.587782724s","start":"2026-03-19T13:37:53.560492Z","end":"2026-03-19T13:37:55.148275Z","steps":["trace[771181146] 'agreement among raft nodes before linearized reading'  (duration: 1.587651179s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:55.148299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:53.560484Z","time spent":"1.587810035s","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-19T13:37:55.148491Z","caller":"traceutil/trace.go:171","msg":"trace[1534476970] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"1.777538369s","start":"2026-03-19T13:37:53.370075Z","end":"2026-03-19T13:37:55.147613Z","steps":["trace[1534476970] 'process raft request'  (duration: 1.777184939s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:55.148671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:53.370057Z","time spent":"1.778518255s","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:719 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-19T13:37:56.208959Z","caller":"traceutil/trace.go:171","msg":"trace[111804096] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"380.20697ms","start":"2026-03-19T13:37:55.82872Z","end":"2026-03-19T13:37:56.208927Z","steps":["trace[111804096] 'process raft request'  (duration: 379.995424ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:37:56.209141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:37:55.828701Z","time spent":"380.342724ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:723 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-19T13:38:18.802024Z","caller":"traceutil/trace.go:171","msg":"trace[1395088048] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"328.464589ms","start":"2026-03-19T13:38:18.47354Z","end":"2026-03-19T13:38:18.802005Z","steps":["trace[1395088048] 'process raft request'  (duration: 328.336986ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:18.802145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:18.473518Z","time spent":"328.568052ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:789 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-19T13:38:19.37848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.321667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:38:19.378586Z","caller":"traceutil/trace.go:171","msg":"trace[16358210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"444.488882ms","start":"2026-03-19T13:38:18.934074Z","end":"2026-03-19T13:38:19.378563Z","steps":["trace[16358210] 'range keys from in-memory index tree'  (duration: 444.219395ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:19.378632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:18.934038Z","time spent":"444.581914ms","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-19T13:38:19.378917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.876061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-03-19T13:38:19.379057Z","caller":"traceutil/trace.go:171","msg":"trace[1335646581] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:796; }","duration":"107.074186ms","start":"2026-03-19T13:38:19.271965Z","end":"2026-03-19T13:38:19.379039Z","steps":["trace[1335646581] 'range keys from in-memory index tree'  (duration: 106.605443ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:19.924436Z","caller":"traceutil/trace.go:171","msg":"trace[1393180041] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"541.768529ms","start":"2026-03-19T13:38:19.382623Z","end":"2026-03-19T13:38:19.924392Z","steps":["trace[1393180041] 'process raft request'  (duration: 541.657316ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:19.924544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:19.382602Z","time spent":"541.882772ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:792 > 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-19T13:38:20.087818Z","caller":"traceutil/trace.go:171","msg":"trace[1997481846] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"703.870943ms","start":"2026-03-19T13:38:19.383924Z","end":"2026-03-19T13:38:20.087795Z","steps":["trace[1997481846] 'process raft request'  (duration: 703.834553ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:20.087841Z","caller":"traceutil/trace.go:171","msg":"trace[1474780571] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"704.748516ms","start":"2026-03-19T13:38:19.383059Z","end":"2026-03-19T13:38:20.087808Z","steps":["trace[1474780571] 'process raft request'  (duration: 704.527309ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:20.087972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:19.383911Z","time spent":"703.986676ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:790 > 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-19T13:38:20.088002Z","caller":"traceutil/trace.go:171","msg":"trace[304180416] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"704.810038ms","start":"2026-03-19T13:38:19.383166Z","end":"2026-03-19T13:38:20.087976Z","steps":["trace[304180416] 'process raft request'  (duration: 704.556682ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:20.088299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:19.383159Z","time spent":"704.90277ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:793 > 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-19T13:38:20.088065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:19.383036Z","time spent":"704.879039ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:791 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-19T13:38:21.34171Z","caller":"traceutil/trace.go:171","msg":"trace[747808071] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:832; }","duration":"391.797418ms","start":"2026-03-19T13:38:20.949887Z","end":"2026-03-19T13:38:21.341685Z","steps":["trace[747808071] 'read index received'  (duration: 391.758947ms)","trace[747808071] 'applied index is now lower than readState.Index'  (duration: 37.201µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:38:21.341781Z","caller":"traceutil/trace.go:171","msg":"trace[1272341484] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"531.456906ms","start":"2026-03-19T13:38:20.810295Z","end":"2026-03-19T13:38:21.341752Z","steps":["trace[1272341484] 'process raft request'  (duration: 531.250871ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:21.341907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:20.810269Z","time spent":"531.571859ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:796 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-19T13:38:21.341909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.007913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:38:21.341975Z","caller":"traceutil/trace.go:171","msg":"trace[470736885] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"392.103806ms","start":"2026-03-19T13:38:20.949854Z","end":"2026-03-19T13:38:21.341958Z","steps":["trace[470736885] 'agreement among raft nodes before linearized reading'  (duration: 391.939551ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:21.342192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:20.949837Z","time spent":"392.337701ms","remote":"127.0.0.1:46090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-19T13:38:21.740585Z","caller":"traceutil/trace.go:171","msg":"trace[1058442924] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"277.842378ms","start":"2026-03-19T13:38:21.462714Z","end":"2026-03-19T13:38:21.740557Z","steps":["trace[1058442924] 'process raft request'  (duration: 261.522007ms)","trace[1058442924] 'compare'  (duration: 15.916861ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:38:34.730349Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259976445577101752,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-19T13:38:35.231324Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259976445577101752,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-19T13:38:35.731447Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259976445577101752,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-19T13:38:36.231772Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259976445577101752,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-19T13:38:36.732503Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259976445577101752,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-19T13:38:36.932227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000105063s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-19T13:38:36.932369Z","caller":"traceutil/trace.go:171","msg":"trace[877622233] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000284087s","start":"2026-03-19T13:38:34.932056Z","end":"2026-03-19T13:38:36.93234Z","steps":["trace[877622233] 'agreement among raft nodes before linearized reading'  (duration: 2.000128994s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:36.932447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:34.932039Z","time spent":"2.00039007s","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-19T13:38:37.078866Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.888318708s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-19T13:38:37.079409Z","caller":"traceutil/trace.go:171","msg":"trace[1870630839] linearizableReadLoop","detail":"{readStateIndex:924; appliedIndex:922; }","duration":"2.849989409s","start":"2026-03-19T13:38:34.229399Z","end":"2026-03-19T13:38:37.079388Z","steps":["trace[1870630839] 'read index received'  (duration: 2.84962437s)","trace[1870630839] 'applied index is now lower than readState.Index'  (duration: 364.239µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:38:37.079535Z","caller":"traceutil/trace.go:171","msg":"trace[130116571] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"2.889053736s","start":"2026-03-19T13:38:34.190467Z","end":"2026-03-19T13:38:37.079521Z","steps":["trace[130116571] 'process raft request'  (duration: 2.888875392s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.079675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:34.190453Z","time spent":"2.889128269s","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:881 > 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-19T13:38:37.079527Z","caller":"traceutil/trace.go:171","msg":"trace[1120598689] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"2.889027056s","start":"2026-03-19T13:38:34.190466Z","end":"2026-03-19T13:38:37.079493Z","steps":["trace[1120598689] 'process raft request'  (duration: 2.888641766s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.079761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322832859s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-19T13:38:37.079777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.943256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-19T13:38:37.079796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.60541691s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-19T13:38:37.079837Z","caller":"traceutil/trace.go:171","msg":"trace[1192870167] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:888; }","duration":"1.322962633s","start":"2026-03-19T13:38:35.756853Z","end":"2026-03-19T13:38:37.079816Z","steps":["trace[1192870167] 'agreement among raft nodes before linearized reading'  (duration: 1.322790068s)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:37.079853Z","caller":"traceutil/trace.go:171","msg":"trace[867012893] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:888; }","duration":"146.051928ms","start":"2026-03-19T13:38:36.933779Z","end":"2026-03-19T13:38:37.079831Z","steps":["trace[867012893] 'agreement among raft nodes before linearized reading'  (duration: 145.946975ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:37.079855Z","caller":"traceutil/trace.go:171","msg":"trace[260918014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:888; }","duration":"1.605501892s","start":"2026-03-19T13:38:35.474338Z","end":"2026-03-19T13:38:37.07984Z","steps":["trace[260918014] 'agreement among raft nodes before linearized reading'  (duration: 1.605335028s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.079895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:35.474324Z","time spent":"1.605561133s","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-19T13:38:37.079895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:35.756835Z","time spent":"1.323043415s","remote":"127.0.0.1:46464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":31,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"warn","ts":"2026-03-19T13:38:37.07998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:34.190453Z","time spent":"2.889371106s","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:882 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-19T13:38:37.080094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.784762027s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-19T13:38:37.080146Z","caller":"traceutil/trace.go:171","msg":"trace[1667591846] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:888; }","duration":"2.784847579s","start":"2026-03-19T13:38:34.295284Z","end":"2026-03-19T13:38:37.080131Z","steps":["trace[1667591846] 'agreement among raft nodes before linearized reading'  (duration: 2.784763677s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.080188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:34.295269Z","time spent":"2.78490756s","remote":"127.0.0.1:46244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":31,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "}
{"level":"warn","ts":"2026-03-19T13:38:37.080378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.84260328s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-03-19T13:38:37.080607Z","caller":"traceutil/trace.go:171","msg":"trace[164403324] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:888; }","duration":"2.842691882s","start":"2026-03-19T13:38:34.237722Z","end":"2026-03-19T13:38:37.080414Z","steps":["trace[164403324] 'agreement among raft nodes before linearized reading'  (duration: 2.841841309s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.080627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.851225752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-19T13:38:37.080665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:34.237702Z","time spent":"2.842947078s","remote":"127.0.0.1:46336","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-19T13:38:37.080687Z","caller":"traceutil/trace.go:171","msg":"trace[1479959136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:888; }","duration":"2.851308063s","start":"2026-03-19T13:38:34.229358Z","end":"2026-03-19T13:38:37.080666Z","steps":["trace[1479959136] 'agreement among raft nodes before linearized reading'  (duration: 2.850291417s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.081124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:34.22934Z","time spent":"2.851767716s","remote":"127.0.0.1:46336","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-19T13:38:37.448659Z","caller":"traceutil/trace.go:171","msg":"trace[1691651090] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"363.142309ms","start":"2026-03-19T13:38:37.085481Z","end":"2026-03-19T13:38:37.448623Z","steps":["trace[1691651090] 'process raft request'  (duration: 362.562614ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.448803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:37.085452Z","time spent":"363.293953ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189e41ad98ecbad3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189e41ad98ecbad3\" value_size:672 lease:5036604408722325508 >> failure:<>"}
{"level":"info","ts":"2026-03-19T13:38:37.467438Z","caller":"traceutil/trace.go:171","msg":"trace[687741851] linearizableReadLoop","detail":"{readStateIndex:928; appliedIndex:924; }","duration":"380.569118ms","start":"2026-03-19T13:38:37.086841Z","end":"2026-03-19T13:38:37.46741Z","steps":["trace[687741851] 'read index received'  (duration: 361.26477ms)","trace[687741851] 'applied index is now lower than readState.Index'  (duration: 19.222896ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:38:37.467554Z","caller":"traceutil/trace.go:171","msg":"trace[51256917] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"381.74714ms","start":"2026-03-19T13:38:37.085789Z","end":"2026-03-19T13:38:37.467536Z","steps":["trace[51256917] 'process raft request'  (duration: 381.477012ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:37.467581Z","caller":"traceutil/trace.go:171","msg":"trace[722909936] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"381.609676ms","start":"2026-03-19T13:38:37.085958Z","end":"2026-03-19T13:38:37.467568Z","steps":["trace[722909936] 'process raft request'  (duration: 381.342098ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.467657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:37.085755Z","time spent":"381.843713ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:885 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-19T13:38:37.467702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:37.085942Z","time spent":"381.678407ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:886 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-19T13:38:37.467779Z","caller":"traceutil/trace.go:171","msg":"trace[1248595822] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"381.984276ms","start":"2026-03-19T13:38:37.085789Z","end":"2026-03-19T13:38:37.467773Z","steps":["trace[1248595822] 'process raft request'  (duration: 381.36034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.467812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:37.085752Z","time spent":"382.041757ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:884 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-19T13:38:37.467966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.125042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:38:37.467989Z","caller":"traceutil/trace.go:171","msg":"trace[2140047204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:892; }","duration":"381.178174ms","start":"2026-03-19T13:38:37.086805Z","end":"2026-03-19T13:38:37.467983Z","steps":["trace[2140047204] 'agreement among raft nodes before linearized reading'  (duration: 381.139963ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:37.468008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:37.086794Z","time spent":"381.211195ms","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-19T13:38:37.468113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.800611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:38:37.46813Z","caller":"traceutil/trace.go:171","msg":"trace[1466788035] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:892; }","duration":"157.844491ms","start":"2026-03-19T13:38:37.31028Z","end":"2026-03-19T13:38:37.468125Z","steps":["trace[1466788035] 'agreement among raft nodes before linearized reading'  (duration: 157.812701ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:51.237718Z","caller":"traceutil/trace.go:171","msg":"trace[1632435233] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"106.268252ms","start":"2026-03-19T13:38:51.131431Z","end":"2026-03-19T13:38:51.237699Z","steps":["trace[1632435233] 'process raft request'  (duration: 106.147948ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:51.239116Z","caller":"traceutil/trace.go:171","msg":"trace[328578765] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"106.440376ms","start":"2026-03-19T13:38:51.132648Z","end":"2026-03-19T13:38:51.239089Z","steps":["trace[328578765] 'process raft request'  (duration: 106.326332ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:55.843936Z","caller":"traceutil/trace.go:171","msg":"trace[1756433484] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"243.387751ms","start":"2026-03-19T13:38:55.60053Z","end":"2026-03-19T13:38:55.843918Z","steps":["trace[1756433484] 'read index received'  (duration: 243.208577ms)","trace[1756433484] 'applied index is now lower than readState.Index'  (duration: 178.214µs)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:38:55.84405Z","caller":"traceutil/trace.go:171","msg":"trace[1024827509] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"247.917927ms","start":"2026-03-19T13:38:55.596121Z","end":"2026-03-19T13:38:55.844039Z","steps":["trace[1024827509] 'process raft request'  (duration: 247.64088ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:55.844228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.110419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-19T13:38:55.844274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.356337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-19T13:38:55.844298Z","caller":"traceutil/trace.go:171","msg":"trace[485106323] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:968; }","duration":"201.232043ms","start":"2026-03-19T13:38:55.643055Z","end":"2026-03-19T13:38:55.844287Z","steps":["trace[485106323] 'agreement among raft nodes before linearized reading'  (duration: 201.111329ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:55.844277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.719479ms","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-19T13:38:55.844334Z","caller":"traceutil/trace.go:171","msg":"trace[566146812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:968; }","duration":"241.454461ms","start":"2026-03-19T13:38:55.602863Z","end":"2026-03-19T13:38:55.844318Z","steps":["trace[566146812] 'agreement among raft nodes before linearized reading'  (duration: 241.239145ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:55.844355Z","caller":"traceutil/trace.go:171","msg":"trace[59400277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:968; }","duration":"243.829502ms","start":"2026-03-19T13:38:55.600507Z","end":"2026-03-19T13:38:55.844336Z","steps":["trace[59400277] 'agreement among raft nodes before linearized reading'  (duration: 243.608506ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:58.072613Z","caller":"traceutil/trace.go:171","msg":"trace[649959670] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"160.658154ms","start":"2026-03-19T13:38:57.911921Z","end":"2026-03-19T13:38:58.072579Z","steps":["trace[649959670] 'process raft request'  (duration: 135.467644ms)","trace[649959670] 'compare'  (duration: 24.928123ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:38:58.075022Z","caller":"traceutil/trace.go:171","msg":"trace[1908044734] linearizableReadLoop","detail":"{readStateIndex:1032; appliedIndex:1030; }","duration":"143.894833ms","start":"2026-03-19T13:38:57.9311Z","end":"2026-03-19T13:38:58.074995Z","steps":["trace[1908044734] 'read index received'  (duration: 116.28136ms)","trace[1908044734] 'applied index is now lower than readState.Index'  (duration: 27.612493ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:38:58.075142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.019686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:38:58.075156Z","caller":"traceutil/trace.go:171","msg":"trace[881878089] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"163.181639ms","start":"2026-03-19T13:38:57.91195Z","end":"2026-03-19T13:38:58.075131Z","steps":["trace[881878089] 'process raft request'  (duration: 162.922023ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:58.07519Z","caller":"traceutil/trace.go:171","msg":"trace[466084023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:990; }","duration":"144.113398ms","start":"2026-03-19T13:38:57.931059Z","end":"2026-03-19T13:38:58.075173Z","steps":["trace[466084023] 'agreement among raft nodes before linearized reading'  (duration: 144.029976ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:58.902766Z","caller":"traceutil/trace.go:171","msg":"trace[1574467279] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"358.777156ms","start":"2026-03-19T13:38:58.543971Z","end":"2026-03-19T13:38:58.902748Z","steps":["trace[1574467279] 'process raft request'  (duration: 358.669313ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:58.902879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:58.543952Z","time spent":"358.866948ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:922 > 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-19T13:38:59.398594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.458881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-19T13:38:59.398623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.310284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"}
{"level":"info","ts":"2026-03-19T13:38:59.398684Z","caller":"traceutil/trace.go:171","msg":"trace[928307139] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:991; }","duration":"124.620435ms","start":"2026-03-19T13:38:59.274042Z","end":"2026-03-19T13:38:59.398662Z","steps":["trace[928307139] 'range keys from in-memory index tree'  (duration: 124.266826ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:59.398793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.805831ms","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-19T13:38:59.398908Z","caller":"traceutil/trace.go:171","msg":"trace[302015709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:991; }","duration":"124.947744ms","start":"2026-03-19T13:38:59.273946Z","end":"2026-03-19T13:38:59.398893Z","steps":["trace[302015709] 'range keys from in-memory index tree'  (duration: 124.589684ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:59.398684Z","caller":"traceutil/trace.go:171","msg":"trace[2089702448] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:991; }","duration":"332.401237ms","start":"2026-03-19T13:38:59.066268Z","end":"2026-03-19T13:38:59.398669Z","steps":["trace[2089702448] 'range keys from in-memory index tree'  (duration: 332.16599ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:38:59.399288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:38:59.066248Z","time spent":"332.813877ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-19T13:38:59.507081Z","caller":"traceutil/trace.go:171","msg":"trace[86964971] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"104.602218ms","start":"2026-03-19T13:38:59.402449Z","end":"2026-03-19T13:38:59.507051Z","steps":["trace[86964971] 'process raft request'  (duration: 104.339622ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:59.53801Z","caller":"traceutil/trace.go:171","msg":"trace[1724607975] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"134.159231ms","start":"2026-03-19T13:38:59.403828Z","end":"2026-03-19T13:38:59.537987Z","steps":["trace[1724607975] 'process raft request'  (duration: 134.112019ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:38:59.538108Z","caller":"traceutil/trace.go:171","msg":"trace[333357503] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"135.306542ms","start":"2026-03-19T13:38:59.402783Z","end":"2026-03-19T13:38:59.53809Z","steps":["trace[333357503] 'process raft request'  (duration: 135.047994ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.218437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.141336946s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-19T13:39:01.218514Z","caller":"traceutil/trace.go:171","msg":"trace[883929343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:996; }","duration":"1.141445779s","start":"2026-03-19T13:39:00.077043Z","end":"2026-03-19T13:39:01.218488Z","steps":["trace[883929343] 'range keys from in-memory index tree'  (duration: 1.141163202s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.218542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:00.077029Z","time spent":"1.14150688s","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-19T13:39:01.218712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.139594752s","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-19T13:39:01.218731Z","caller":"traceutil/trace.go:171","msg":"trace[1395986854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:996; }","duration":"1.139641082s","start":"2026-03-19T13:39:00.079084Z","end":"2026-03-19T13:39:01.218725Z","steps":["trace[1395986854] 'range keys from in-memory index tree'  (duration: 1.139505398s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.218747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:00.079069Z","time spent":"1.139673674s","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-19T13:39:01.218858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.092442614s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-19T13:39:01.218876Z","caller":"traceutil/trace.go:171","msg":"trace[1060166400] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:996; }","duration":"1.092501846s","start":"2026-03-19T13:39:00.126368Z","end":"2026-03-19T13:39:01.21887Z","steps":["trace[1060166400] 'count revisions from in-memory index tree'  (duration: 1.092368662s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.218894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:00.126342Z","time spent":"1.092546198s","remote":"127.0.0.1:46408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-03-19T13:39:01.219054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060239024s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:39:01.219072Z","caller":"traceutil/trace.go:171","msg":"trace[277986130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:996; }","duration":"1.060292216s","start":"2026-03-19T13:39:00.158775Z","end":"2026-03-19T13:39:01.219067Z","steps":["trace[277986130] 'range keys from in-memory index tree'  (duration: 1.060174702s)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.219091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:00.158756Z","time spent":"1.060330556s","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-19T13:39:01.219524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.522102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:39:01.219544Z","caller":"traceutil/trace.go:171","msg":"trace[285784582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:996; }","duration":"286.583293ms","start":"2026-03-19T13:39:00.932955Z","end":"2026-03-19T13:39:01.219538Z","steps":["trace[285784582] 'range keys from in-memory index tree'  (duration: 286.449931ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.219864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.253729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-19T13:39:01.219953Z","caller":"traceutil/trace.go:171","msg":"trace[1220887223] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:996; }","duration":"171.393622ms","start":"2026-03-19T13:39:01.048543Z","end":"2026-03-19T13:39:01.219937Z","steps":["trace[1220887223] 'range keys from in-memory index tree'  (duration: 171.109695ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:01.765436Z","caller":"traceutil/trace.go:171","msg":"trace[1396262246] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"541.622352ms","start":"2026-03-19T13:39:01.223795Z","end":"2026-03-19T13:39:01.765418Z","steps":["trace[1396262246] 'process raft request'  (duration: 541.508769ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.765565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:01.223777Z","time spent":"541.719256ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" mod_revision:977 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" value_size:422 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-19T13:39:01.813583Z","caller":"traceutil/trace.go:171","msg":"trace[317851619] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1039; }","duration":"301.5433ms","start":"2026-03-19T13:39:01.512018Z","end":"2026-03-19T13:39:01.813561Z","steps":["trace[317851619] 'read index received'  (duration: 253.533411ms)","trace[317851619] 'applied index is now lower than readState.Index'  (duration: 48.008789ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:39:01.813856Z","caller":"traceutil/trace.go:171","msg":"trace[684932965] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"587.400414ms","start":"2026-03-19T13:39:01.226438Z","end":"2026-03-19T13:39:01.813839Z","steps":["trace[684932965] 'process raft request'  (duration: 587.079676ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:01.813845Z","caller":"traceutil/trace.go:171","msg":"trace[1910589025] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"589.887948ms","start":"2026-03-19T13:39:01.223934Z","end":"2026-03-19T13:39:01.813822Z","steps":["trace[1910589025] 'process raft request'  (duration: 589.476458ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.813937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:01.226421Z","time spent":"587.465345ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:989 > 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-19T13:39:01.813994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:01.223913Z","time spent":"589.99198ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:990 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-19T13:39:01.813985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.947706ms","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-19T13:39:01.814048Z","caller":"traceutil/trace.go:171","msg":"trace[847140345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:999; }","duration":"272.05849ms","start":"2026-03-19T13:39:01.541972Z","end":"2026-03-19T13:39:01.81403Z","steps":["trace[847140345] 'agreement among raft nodes before linearized reading'  (duration: 271.881524ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.814363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.349831ms","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-19T13:39:01.814533Z","caller":"traceutil/trace.go:171","msg":"trace[439464666] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:999; }","duration":"302.544136ms","start":"2026-03-19T13:39:01.511979Z","end":"2026-03-19T13:39:01.814523Z","steps":["trace[439464666] 'agreement among raft nodes before linearized reading'  (duration: 301.788466ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:01.814553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:01.511961Z","time spent":"302.584956ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-19T13:39:01.980718Z","caller":"traceutil/trace.go:171","msg":"trace[2079562644] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"163.331574ms","start":"2026-03-19T13:39:01.817352Z","end":"2026-03-19T13:39:01.980684Z","steps":["trace[2079562644] 'process raft request'  (duration: 150.804821ms)","trace[2079562644] 'compare'  (duration: 12.200714ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:39:02.011581Z","caller":"traceutil/trace.go:171","msg":"trace[1655611210] linearizableReadLoop","detail":"{readStateIndex:1043; appliedIndex:1041; }","duration":"100.079632ms","start":"2026-03-19T13:39:01.911482Z","end":"2026-03-19T13:39:02.011562Z","steps":["trace[1655611210] 'read index received'  (duration: 56.651442ms)","trace[1655611210] 'applied index is now lower than readState.Index'  (duration: 43.42748ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:39:02.011686Z","caller":"traceutil/trace.go:171","msg":"trace[1274513380] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"194.110667ms","start":"2026-03-19T13:39:01.817563Z","end":"2026-03-19T13:39:02.011674Z","steps":["trace[1274513380] 'process raft request'  (duration: 193.889032ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:02.012022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.516812ms","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-19T13:39:02.012083Z","caller":"traceutil/trace.go:171","msg":"trace[534985576] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1001; }","duration":"100.617875ms","start":"2026-03-19T13:39:01.91145Z","end":"2026-03-19T13:39:02.012068Z","steps":["trace[534985576] 'agreement among raft nodes before linearized reading'  (duration: 100.472961ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:02.349947Z","caller":"traceutil/trace.go:171","msg":"trace[1680071278] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"106.789415ms","start":"2026-03-19T13:39:02.243123Z","end":"2026-03-19T13:39:02.349913Z","steps":["trace[1680071278] 'process raft request'  (duration: 68.001075ms)","trace[1680071278] 'compare'  (duration: 38.454942ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:39:02.724373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.929203ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259976445577102026 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-5vfnb.189e41b3826a5f62\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-5vfnb.189e41b3826a5f62\" value_size:701 lease:5036604408722326066 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-19T13:39:02.724596Z","caller":"traceutil/trace.go:171","msg":"trace[1846841585] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"248.321887ms","start":"2026-03-19T13:39:02.476241Z","end":"2026-03-19T13:39:02.724563Z","steps":["trace[1846841585] 'process raft request'  (duration: 18.132308ms)","trace[1846841585] 'compare'  (duration: 229.80539ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:39:02.967906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.410321ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259976445577102027 > lease_revoke:<id:45e59d06500f8210>","response":"size:29"}
{"level":"info","ts":"2026-03-19T13:39:02.968009Z","caller":"traceutil/trace.go:171","msg":"trace[1932208090] linearizableReadLoop","detail":"{readStateIndex:1054; appliedIndex:1052; }","duration":"393.096253ms","start":"2026-03-19T13:39:02.574896Z","end":"2026-03-19T13:39:02.967992Z","steps":["trace[1932208090] 'read index received'  (duration: 128.771013ms)","trace[1932208090] 'applied index is now lower than readState.Index'  (duration: 264.32353ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:39:02.968085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.186955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:39:02.968113Z","caller":"traceutil/trace.go:171","msg":"trace[2091132096] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:1011; }","duration":"393.258307ms","start":"2026-03-19T13:39:02.574845Z","end":"2026-03-19T13:39:02.968103Z","steps":["trace[2091132096] 'agreement among raft nodes before linearized reading'  (duration: 393.189145ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:02.968143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:02.574825Z","time spent":"393.309758ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"info","ts":"2026-03-19T13:39:03.26563Z","caller":"traceutil/trace.go:171","msg":"trace[269880920] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"299.736403ms","start":"2026-03-19T13:39:02.965863Z","end":"2026-03-19T13:39:03.265599Z","steps":["trace[269880920] 'process raft request'  (duration: 299.567148ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:03.540194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.154003ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259976445577102030 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:452 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-19T13:39:03.540329Z","caller":"traceutil/trace.go:171","msg":"trace[845149328] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"270.305943ms","start":"2026-03-19T13:39:03.270009Z","end":"2026-03-19T13:39:03.540315Z","steps":["trace[845149328] 'process raft request'  (duration: 270.263032ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:03.540418Z","caller":"traceutil/trace.go:171","msg":"trace[432841818] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"567.740856ms","start":"2026-03-19T13:39:02.972648Z","end":"2026-03-19T13:39:03.540389Z","steps":["trace[432841818] 'process raft request'  (duration: 298.338817ms)","trace[432841818] 'compare'  (duration: 269.01785ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:39:03.540544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:02.972627Z","time spent":"567.86386ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:452 >> failure:<>"}
{"level":"info","ts":"2026-03-19T13:39:03.695259Z","caller":"traceutil/trace.go:171","msg":"trace[69805441] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"147.506655ms","start":"2026-03-19T13:39:03.547725Z","end":"2026-03-19T13:39:03.695232Z","steps":["trace[69805441] 'process raft request'  (duration: 124.8295ms)","trace[69805441] 'compare'  (duration: 22.452589ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:39:03.947052Z","caller":"traceutil/trace.go:171","msg":"trace[1618506206] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1059; }","duration":"129.648985ms","start":"2026-03-19T13:39:03.817375Z","end":"2026-03-19T13:39:03.947024Z","steps":["trace[1618506206] 'read index received'  (duration: 84.795488ms)","trace[1618506206] 'applied index is now lower than readState.Index'  (duration: 44.852477ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:39:03.947089Z","caller":"traceutil/trace.go:171","msg":"trace[1568334518] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"237.980191ms","start":"2026-03-19T13:39:03.709072Z","end":"2026-03-19T13:39:03.947052Z","steps":["trace[1568334518] 'process raft request'  (duration: 193.172825ms)","trace[1568334518] 'compare'  (duration: 44.682863ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:39:03.94747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.856911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-19T13:39:03.947506Z","caller":"traceutil/trace.go:171","msg":"trace[802231766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1017; }","duration":"130.161278ms","start":"2026-03-19T13:39:03.817335Z","end":"2026-03-19T13:39:03.947497Z","steps":["trace[802231766] 'agreement among raft nodes before linearized reading'  (duration: 129.796919ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:03.947614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.014604ms","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-19T13:39:03.948018Z","caller":"traceutil/trace.go:171","msg":"trace[1028520961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1017; }","duration":"130.449236ms","start":"2026-03-19T13:39:03.81754Z","end":"2026-03-19T13:39:03.947989Z","steps":["trace[1028520961] 'agreement among raft nodes before linearized reading'  (duration: 129.719568ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:09.532927Z","caller":"traceutil/trace.go:171","msg":"trace[1936063958] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"568.493438ms","start":"2026-03-19T13:39:08.964415Z","end":"2026-03-19T13:39:09.532908Z","steps":["trace[1936063958] 'process raft request'  (duration: 568.351894ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:09.533119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:08.964378Z","time spent":"568.627521ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:991 > 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-19T13:39:10.218684Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14259976445577102100,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-19T13:39:10.542272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.49759ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259976445577102101 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1028 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-19T13:39:10.542396Z","caller":"traceutil/trace.go:171","msg":"trace[1661653742] linearizableReadLoop","detail":"{readStateIndex:1090; appliedIndex:1089; }","duration":"824.118042ms","start":"2026-03-19T13:39:09.718257Z","end":"2026-03-19T13:39:10.542375Z","steps":["trace[1661653742] 'read index received'  (duration: 670.370786ms)","trace[1661653742] 'applied index is now lower than readState.Index'  (duration: 153.745346ms)"],"step_count":2}
{"level":"info","ts":"2026-03-19T13:39:10.542445Z","caller":"traceutil/trace.go:171","msg":"trace[1169139525] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"984.427798ms","start":"2026-03-19T13:39:09.557985Z","end":"2026-03-19T13:39:10.542413Z","steps":["trace[1169139525] 'process raft request'  (duration: 830.686012ms)","trace[1169139525] 'compare'  (duration: 152.73045ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:39:10.542558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:09.557958Z","time spent":"984.544451ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1028 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-19T13:39:10.542639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.041928ms","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-19T13:39:10.54266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.40534ms","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":"warn","ts":"2026-03-19T13:39:10.542661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.49399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-03-19T13:39:10.542703Z","caller":"traceutil/trace.go:171","msg":"trace[383727754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1046; }","duration":"555.142332ms","start":"2026-03-19T13:39:09.987545Z","end":"2026-03-19T13:39:10.542687Z","steps":["trace[383727754] 'agreement among raft nodes before linearized reading'  (duration: 554.952747ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:10.54271Z","caller":"traceutil/trace.go:171","msg":"trace[1696806071] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1046; }","duration":"824.501982ms","start":"2026-03-19T13:39:09.718195Z","end":"2026-03-19T13:39:10.542697Z","steps":["trace[1696806071] 'agreement among raft nodes before linearized reading'  (duration: 824.279686ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:39:10.542725Z","caller":"traceutil/trace.go:171","msg":"trace[1495106269] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1046; }","duration":"465.612953ms","start":"2026-03-19T13:39:10.077099Z","end":"2026-03-19T13:39:10.542712Z","steps":["trace[1495106269] 'agreement among raft nodes before linearized reading'  (duration: 465.431489ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:10.542755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:10.077079Z","time spent":"465.669945ms","remote":"127.0.0.1:46336","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-19T13:39:10.542752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:09.987526Z","time spent":"555.213585ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-19T13:39:10.542757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:09.718166Z","time spent":"824.576345ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"warn","ts":"2026-03-19T13:39:10.542894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.487169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-19T13:39:10.542912Z","caller":"traceutil/trace.go:171","msg":"trace[788872787] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1046; }","duration":"382.554411ms","start":"2026-03-19T13:39:10.160353Z","end":"2026-03-19T13:39:10.542907Z","steps":["trace[788872787] 'agreement among raft nodes before linearized reading'  (duration: 382.52274ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:10.542927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:10.160327Z","time spent":"382.596581ms","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-19T13:39:10.542959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.797893ms","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-19T13:39:10.543016Z","caller":"traceutil/trace.go:171","msg":"trace[181205886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1046; }","duration":"535.883515ms","start":"2026-03-19T13:39:10.007119Z","end":"2026-03-19T13:39:10.543002Z","steps":["trace[181205886] 'agreement among raft nodes before linearized reading'  (duration: 535.751172ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:10.543023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.406489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-19T13:39:10.543064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:10.007101Z","time spent":"535.951397ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-19T13:39:10.543071Z","caller":"traceutil/trace.go:171","msg":"trace[1976699390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1046; }","duration":"555.490001ms","start":"2026-03-19T13:39:09.987566Z","end":"2026-03-19T13:39:10.543056Z","steps":["trace[1976699390] 'agreement among raft nodes before linearized reading'  (duration: 555.359848ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:10.543115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:09.987545Z","time spent":"555.559923ms","remote":"127.0.0.1:46336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-19T13:39:10.54323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.827693ms","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-19T13:39:10.543281Z","caller":"traceutil/trace.go:171","msg":"trace[168311440] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1046; }","duration":"502.915995ms","start":"2026-03-19T13:39:10.040353Z","end":"2026-03-19T13:39:10.543269Z","steps":["trace[168311440] 'agreement among raft nodes before linearized reading'  (duration: 502.798852ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:39:10.543318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T13:39:10.040336Z","time spent":"502.972836ms","remote":"127.0.0.1:46336","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-19T13:42:02.914455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.992357ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14259976445577103935 > lease_revoke:<id:45e59d06500f89a2>","response":"size:29"}
{"level":"info","ts":"2026-03-19T13:42:02.914557Z","caller":"traceutil/trace.go:171","msg":"trace[507293215] linearizableReadLoop","detail":"{readStateIndex:1831; appliedIndex:1830; }","duration":"155.599778ms","start":"2026-03-19T13:42:02.758943Z","end":"2026-03-19T13:42:02.914542Z","steps":["trace[507293215] 'read index received'  (duration: 29.18µs)","trace[507293215] 'applied index is now lower than readState.Index'  (duration: 155.569518ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-19T13:42:02.914681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.728241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"}
{"level":"info","ts":"2026-03-19T13:42:02.914709Z","caller":"traceutil/trace.go:171","msg":"trace[1622638946] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1752; }","duration":"155.788963ms","start":"2026-03-19T13:42:02.758911Z","end":"2026-03-19T13:42:02.9147Z","steps":["trace[1622638946] 'agreement among raft nodes before linearized reading'  (duration: 155.66861ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:42:27.645985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.981794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-03-19T13:42:27.645983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.503609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-19T13:42:27.646048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.34433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-19T13:42:27.646085Z","caller":"traceutil/trace.go:171","msg":"trace[419704717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1886; }","duration":"134.122377ms","start":"2026-03-19T13:42:27.511944Z","end":"2026-03-19T13:42:27.646067Z","steps":["trace[419704717] 'range keys from in-memory index tree'  (duration: 133.833419ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:42:27.646113Z","caller":"traceutil/trace.go:171","msg":"trace[1476011529] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1886; }","duration":"136.681005ms","start":"2026-03-19T13:42:27.509408Z","end":"2026-03-19T13:42:27.646089Z","steps":["trace[1476011529] 'range keys from in-memory index tree'  (duration: 136.233771ms)"],"step_count":1}
{"level":"info","ts":"2026-03-19T13:42:27.646131Z","caller":"traceutil/trace.go:171","msg":"trace[1623730649] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1886; }","duration":"145.461053ms","start":"2026-03-19T13:42:27.500647Z","end":"2026-03-19T13:42:27.646108Z","steps":["trace[1623730649] 'range keys from in-memory index tree'  (duration: 145.188145ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:42:27.645961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.719581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-19T13:42:27.646235Z","caller":"traceutil/trace.go:171","msg":"trace[795806593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1886; }","duration":"125.115043ms","start":"2026-03-19T13:42:27.521097Z","end":"2026-03-19T13:42:27.646212Z","steps":["trace[795806593] 'range keys from in-memory index tree'  (duration: 124.467764ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:42:27.64726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.416415ms","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-19T13:42:27.647341Z","caller":"traceutil/trace.go:171","msg":"trace[1601436909] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1886; }","duration":"127.882614ms","start":"2026-03-19T13:42:27.519441Z","end":"2026-03-19T13:42:27.647323Z","steps":["trace[1601436909] 'range keys from in-memory index tree'  (duration: 126.233821ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-19T13:42:27.647283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.720811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-19T13:42:27.647915Z","caller":"traceutil/trace.go:171","msg":"trace[1005443159] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1886; }","duration":"157.606879ms","start":"2026-03-19T13:42:27.490291Z","end":"2026-03-19T13:42:27.647898Z","steps":["trace[1005443159] 'range keys from in-memory index tree'  (duration: 155.485955ms)"],"step_count":1}