{"level":"warn","ts":"2026-03-18T00:46:18.635952Z","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-18T00:46:18.636059Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-18T00:46:18.636175Z","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-18T00:46:18.636196Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]}
{"level":"info","ts":"2026-03-18T00:46:18.636219Z","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-18T00:46:18.636921Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]}
{"level":"info","ts":"2026-03-18T00:46:18.637023Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-18T00:46:18.643399Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.098267ms"}
{"level":"info","ts":"2026-03-18T00:46:18.65508Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"}
{"level":"info","ts":"2026-03-18T00:46:18.655164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-18T00:46:18.655182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"}
{"level":"info","ts":"2026-03-18T00:46:18.655196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-18T00:46:18.655205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"}
{"level":"info","ts":"2026-03-18T00:46:18.655242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"}
{"level":"warn","ts":"2026-03-18T00:46:18.665726Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-18T00:46:18.67231Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-18T00:46:18.673752Z","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-18T00:46:18.676502Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-18T00:46:18.676679Z","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-18T00:46:18.676793Z","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-18T00:46:18.67682Z","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-18T00:46:18.676863Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-18T00:46:18.679147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"}
{"level":"info","ts":"2026-03-18T00:46:18.679587Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]}
{"level":"info","ts":"2026-03-18T00:46:18.681126Z","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-18T00:46:18.681296Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"}
{"level":"info","ts":"2026-03-18T00:46:18.681363Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"}
{"level":"info","ts":"2026-03-18T00:46:18.68276Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-18T00:46:18.682803Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-18T00:46:19.456394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-18T00:46:19.456448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-18T00:46:19.456467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"}
{"level":"info","ts":"2026-03-18T00:46:19.456483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"}
{"level":"info","ts":"2026-03-18T00:46:19.456491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"}
{"level":"info","ts":"2026-03-18T00:46:19.456509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"}
{"level":"info","ts":"2026-03-18T00:46:19.456531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"}
{"level":"info","ts":"2026-03-18T00:46:19.45763Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:46:19.458748Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-18T00:46:19.458824Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:46:19.459017Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T00:46:19.459348Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:46:19.459494Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:46:19.459528Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T00:46:19.459536Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-18T00:46:19.459603Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-18T00:46:19.462388Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"}
{"level":"info","ts":"2026-03-18T00:46:19.463775Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-03-18T00:46:47.813803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.740599ms","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-18T00:46:47.813767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.389854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T00:46:47.813897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.04281ms","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-18T00:46:47.813909Z","caller":"traceutil/trace.go:171","msg":"trace[1149766283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:506; }","duration":"147.585818ms","start":"2026-03-18T00:46:47.666301Z","end":"2026-03-18T00:46:47.813887Z","steps":["trace[1149766283] 'range keys from in-memory index tree'  (duration: 147.295632ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:46:47.813954Z","caller":"traceutil/trace.go:171","msg":"trace[1712792205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:506; }","duration":"273.139522ms","start":"2026-03-18T00:46:47.540791Z","end":"2026-03-18T00:46:47.81393Z","steps":["trace[1712792205] 'range keys from in-memory index tree'  (duration: 272.922527ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:46:47.813887Z","caller":"traceutil/trace.go:171","msg":"trace[1981057971] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:506; }","duration":"315.884862ms","start":"2026-03-18T00:46:47.497982Z","end":"2026-03-18T00:46:47.813867Z","steps":["trace[1981057971] 'range keys from in-memory index tree'  (duration: 315.587386ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:46:47.814223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:46:47.49796Z","time spent":"316.25056ms","remote":"127.0.0.1:32960","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-18T00:46:47.813784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.229612ms","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-18T00:46:47.814362Z","caller":"traceutil/trace.go:171","msg":"trace[242665380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:506; }","duration":"207.881326ms","start":"2026-03-18T00:46:47.606469Z","end":"2026-03-18T00:46:47.81435Z","steps":["trace[242665380] 'range keys from in-memory index tree'  (duration: 207.12894ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:46:50.917762Z","caller":"traceutil/trace.go:171","msg":"trace[862467665] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"145.723308ms","start":"2026-03-18T00:46:50.772019Z","end":"2026-03-18T00:46:50.917742Z","steps":["trace[862467665] 'process raft request'  (duration: 145.610105ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:46:55.74814Z","caller":"traceutil/trace.go:171","msg":"trace[1854774919] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"194.980438ms","start":"2026-03-18T00:46:55.553131Z","end":"2026-03-18T00:46:55.748111Z","steps":["trace[1854774919] 'process raft request'  (duration: 194.715633ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:46:55.992508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.855939ms","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-18T00:46:55.992611Z","caller":"traceutil/trace.go:171","msg":"trace[155550927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:531; }","duration":"133.016962ms","start":"2026-03-18T00:46:55.859571Z","end":"2026-03-18T00:46:55.992588Z","steps":["trace[155550927] 'range keys from in-memory index tree'  (duration: 132.579183ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:46:55.992613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.857009ms","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-18T00:46:55.992671Z","caller":"traceutil/trace.go:171","msg":"trace[1779861115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"125.980782ms","start":"2026-03-18T00:46:55.866675Z","end":"2026-03-18T00:46:55.992655Z","steps":["trace[1779861115] 'range keys from in-memory index tree'  (duration: 125.636974ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:46:55.992797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.345866ms","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-18T00:46:55.992934Z","caller":"traceutil/trace.go:171","msg":"trace[32696292] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:531; }","duration":"124.54126ms","start":"2026-03-18T00:46:55.868367Z","end":"2026-03-18T00:46:55.992908Z","steps":["trace[32696292] 'range keys from in-memory index tree'  (duration: 123.771094ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:46:57.255977Z","caller":"traceutil/trace.go:171","msg":"trace[1910977267] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"296.950374ms","start":"2026-03-18T00:46:56.958989Z","end":"2026-03-18T00:46:57.255939Z","steps":["trace[1910977267] 'process raft request'  (duration: 296.728959ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:46:59.016569Z","caller":"traceutil/trace.go:171","msg":"trace[1504551789] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"330.498346ms","start":"2026-03-18T00:46:58.686043Z","end":"2026-03-18T00:46:59.016542Z","steps":["trace[1504551789] 'process raft request'  (duration: 330.329263ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:46:59.017053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:46:58.686035Z","time spent":"330.617758ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<>"}
{"level":"info","ts":"2026-03-18T00:47:16.51948Z","caller":"traceutil/trace.go:171","msg":"trace[56686859] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"370.190651ms","start":"2026-03-18T00:47:16.14927Z","end":"2026-03-18T00:47:16.519461Z","steps":["trace[56686859] 'process raft request'  (duration: 370.078139ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:16.51979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:16.149232Z","time spent":"370.308044ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:717 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-18T00:47:17.16632Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125953428675765496,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-18T00:47:17.19582Z","caller":"traceutil/trace.go:171","msg":"trace[654514300] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:746; }","duration":"529.791107ms","start":"2026-03-18T00:47:16.665989Z","end":"2026-03-18T00:47:17.19578Z","steps":["trace[654514300] 'read index received'  (duration: 529.43933ms)","trace[654514300] 'applied index is now lower than readState.Index'  (duration: 350.757µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:47:17.195837Z","caller":"traceutil/trace.go:171","msg":"trace[1705678842] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"1.045091294s","start":"2026-03-18T00:47:16.150714Z","end":"2026-03-18T00:47:17.195805Z","steps":["trace[1705678842] 'process raft request'  (duration: 1.044869499s)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:17.195888Z","caller":"traceutil/trace.go:171","msg":"trace[304980650] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"1.04446662s","start":"2026-03-18T00:47:16.151388Z","end":"2026-03-18T00:47:17.195855Z","steps":["trace[304980650] 'process raft request'  (duration: 1.044350157s)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:17.19594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.93422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:47:17.195982Z","caller":"traceutil/trace.go:171","msg":"trace[218277658] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:725; }","duration":"530.020892ms","start":"2026-03-18T00:47:16.665952Z","end":"2026-03-18T00:47:17.195973Z","steps":["trace[218277658] 'agreement among raft nodes before linearized reading'  (duration: 529.936821ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:17.196021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:16.665935Z","time spent":"530.080893ms","remote":"127.0.0.1:60886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-18T00:47:17.196026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:16.150701Z","time spent":"1.045237847s","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:719 > 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-18T00:47:17.196044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:16.151372Z","time spent":"1.044579223s","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision: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-18T00:47:17.587291Z","caller":"traceutil/trace.go:171","msg":"trace[645429402] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"219.593938ms","start":"2026-03-18T00:47:17.367605Z","end":"2026-03-18T00:47:17.587199Z","steps":["trace[645429402] 'process raft request'  (duration: 219.371123ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:17.831445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.937885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:47:17.831553Z","caller":"traceutil/trace.go:171","msg":"trace[640798074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:727; }","duration":"161.126899ms","start":"2026-03-18T00:47:17.670401Z","end":"2026-03-18T00:47:17.831528Z","steps":["trace[640798074] 'range keys from in-memory index tree'  (duration: 160.854454ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:43.288186Z","caller":"traceutil/trace.go:171","msg":"trace[208793783] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"200.597952ms","start":"2026-03-18T00:47:43.087565Z","end":"2026-03-18T00:47:43.288163Z","steps":["trace[208793783] 'process raft request'  (duration: 200.425699ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:43.812274Z","caller":"traceutil/trace.go:171","msg":"trace[1500166580] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:832; }","duration":"449.168976ms","start":"2026-03-18T00:47:43.363083Z","end":"2026-03-18T00:47:43.812252Z","steps":["trace[1500166580] 'read index received'  (duration: 449.026872ms)","trace[1500166580] 'applied index is now lower than readState.Index'  (duration: 140.874µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:47:43.812522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.41638ms","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-18T00:47:43.812556Z","caller":"traceutil/trace.go:171","msg":"trace[82234059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:803; }","duration":"105.516282ms","start":"2026-03-18T00:47:43.70703Z","end":"2026-03-18T00:47:43.812546Z","steps":["trace[82234059] 'agreement among raft nodes before linearized reading'  (duration: 105.366109ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:43.812584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.569897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T00:47:43.812607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.795846ms","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-18T00:47:43.812657Z","caller":"traceutil/trace.go:171","msg":"trace[18794345] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"145.69596ms","start":"2026-03-18T00:47:43.666942Z","end":"2026-03-18T00:47:43.812638Z","steps":["trace[18794345] 'agreement among raft nodes before linearized reading'  (duration: 145.556497ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:43.812691Z","caller":"traceutil/trace.go:171","msg":"trace[868457472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:803; }","duration":"433.908469ms","start":"2026-03-18T00:47:43.378762Z","end":"2026-03-18T00:47:43.812671Z","steps":["trace[868457472] 'agreement among raft nodes before linearized reading'  (duration: 433.630013ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:43.812709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.594246ms","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-18T00:47:43.813402Z","caller":"traceutil/trace.go:171","msg":"trace[1890897560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:803; }","duration":"450.323181ms","start":"2026-03-18T00:47:43.363059Z","end":"2026-03-18T00:47:43.813383Z","steps":["trace[1890897560] 'agreement among raft nodes before linearized reading'  (duration: 449.400501ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:43.81346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:43.363052Z","time spent":"450.397284ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-18T00:47:43.812744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:43.378749Z","time spent":"433.98569ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-18T00:47:43.8129Z","caller":"traceutil/trace.go:171","msg":"trace[707229463] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"453.981631ms","start":"2026-03-18T00:47:43.358909Z","end":"2026-03-18T00:47:43.81289Z","steps":["trace[707229463] 'process raft request'  (duration: 453.222124ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:43.81377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:43.358897Z","time spent":"454.730188ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:796 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-18T00:47:46.19914Z","caller":"traceutil/trace.go:171","msg":"trace[1809898358] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"286.549723ms","start":"2026-03-18T00:47:45.912566Z","end":"2026-03-18T00:47:46.199116Z","steps":["trace[1809898358] 'process raft request'  (duration: 286.410479ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:46.220887Z","caller":"traceutil/trace.go:171","msg":"trace[1483921854] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"120.8285ms","start":"2026-03-18T00:47:46.100035Z","end":"2026-03-18T00:47:46.220863Z","steps":["trace[1483921854] 'process raft request'  (duration: 120.748668ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:47:46.221035Z","caller":"traceutil/trace.go:171","msg":"trace[756990504] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"307.888444ms","start":"2026-03-18T00:47:45.913121Z","end":"2026-03-18T00:47:46.22101Z","steps":["trace[756990504] 'process raft request'  (duration: 307.504826ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:46.221142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:45.913095Z","time spent":"307.985396ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:805 > 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-18T00:47:46.221193Z","caller":"traceutil/trace.go:171","msg":"trace[1802601970] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"307.914664ms","start":"2026-03-18T00:47:45.913242Z","end":"2026-03-18T00:47:46.221157Z","steps":["trace[1802601970] 'process raft request'  (duration: 307.506996ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:46.221335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:45.913199Z","time spent":"308.046537ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:806 > 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-18T00:47:58.785349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.616147ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125953428675765932 > lease_revoke:<id:0c869cfe685e25d2>","response":"size:28"}
{"level":"info","ts":"2026-03-18T00:47:58.785486Z","caller":"traceutil/trace.go:171","msg":"trace[1209757193] linearizableReadLoop","detail":"{readStateIndex:928; appliedIndex:927; }","duration":"810.424618ms","start":"2026-03-18T00:47:57.975044Z","end":"2026-03-18T00:47:58.785468Z","steps":["trace[1209757193] 'read index received'  (duration: 426.498904ms)","trace[1209757193] 'applied index is now lower than readState.Index'  (duration: 383.924394ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:47:58.78564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.872766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:47:58.785676Z","caller":"traceutil/trace.go:171","msg":"trace[806543401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:893; }","duration":"113.956729ms","start":"2026-03-18T00:47:58.67171Z","end":"2026-03-18T00:47:58.785667Z","steps":["trace[806543401] 'agreement among raft nodes before linearized reading'  (duration: 113.876086ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:58.785708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.967209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-18T00:47:58.785786Z","caller":"traceutil/trace.go:171","msg":"trace[1708299358] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:893; }","duration":"524.088792ms","start":"2026-03-18T00:47:58.261679Z","end":"2026-03-18T00:47:58.785768Z","steps":["trace[1708299358] 'agreement among raft nodes before linearized reading'  (duration: 523.905317ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:58.785829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:58.261658Z","time spent":"524.162554ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-18T00:47:58.786084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.817245ms","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-18T00:47:58.786125Z","caller":"traceutil/trace.go:171","msg":"trace[955197435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:893; }","duration":"508.879635ms","start":"2026-03-18T00:47:58.277236Z","end":"2026-03-18T00:47:58.786115Z","steps":["trace[955197435] 'agreement among raft nodes before linearized reading'  (duration: 508.752163ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:58.78616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:58.277224Z","time spent":"508.928946ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-18T00:47:58.786286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.342ms","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-18T00:47:58.786319Z","caller":"traceutil/trace.go:171","msg":"trace[1778648659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:893; }","duration":"511.396922ms","start":"2026-03-18T00:47:58.274914Z","end":"2026-03-18T00:47:58.786311Z","steps":["trace[1778648659] 'agreement among raft nodes before linearized reading'  (duration: 511.31059ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:58.786351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:58.2749Z","time spent":"511.445302ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-18T00:47:58.786087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.038263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-18T00:47:58.786513Z","caller":"traceutil/trace.go:171","msg":"trace[1063776999] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:893; }","duration":"811.485523ms","start":"2026-03-18T00:47:57.975017Z","end":"2026-03-18T00:47:58.786502Z","steps":["trace[1063776999] 'agreement among raft nodes before linearized reading'  (duration: 810.939011ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:47:58.786552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:47:57.975003Z","time spent":"811.540034ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-18T00:48:17.179333Z","caller":"traceutil/trace.go:171","msg":"trace[1756653734] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1003; }","duration":"233.400008ms","start":"2026-03-18T00:48:16.945867Z","end":"2026-03-18T00:48:17.179267Z","steps":["trace[1756653734] 'read index received'  (duration: 233.178393ms)","trace[1756653734] 'applied index is now lower than readState.Index'  (duration: 220.075µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:48:17.179774Z","caller":"traceutil/trace.go:171","msg":"trace[1912198900] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"244.82112ms","start":"2026-03-18T00:48:16.934937Z","end":"2026-03-18T00:48:17.179758Z","steps":["trace[1912198900] 'process raft request'  (duration: 244.176425ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:17.179949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.95884ms","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-18T00:48:17.179964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.214291ms","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-18T00:48:17.179996Z","caller":"traceutil/trace.go:171","msg":"trace[1411982576] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:966; }","duration":"186.046672ms","start":"2026-03-18T00:48:16.993939Z","end":"2026-03-18T00:48:17.179986Z","steps":["trace[1411982576] 'agreement among raft nodes before linearized reading'  (duration: 185.883839ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:17.180027Z","caller":"traceutil/trace.go:171","msg":"trace[777763894] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:966; }","duration":"155.288632ms","start":"2026-03-18T00:48:17.024723Z","end":"2026-03-18T00:48:17.180011Z","steps":["trace[777763894] 'agreement among raft nodes before linearized reading'  (duration: 155.142159ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:17.180109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.421125ms","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-18T00:48:17.180132Z","caller":"traceutil/trace.go:171","msg":"trace[852376140] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:966; }","duration":"155.470106ms","start":"2026-03-18T00:48:17.024654Z","end":"2026-03-18T00:48:17.180124Z","steps":["trace[852376140] 'agreement among raft nodes before linearized reading'  (duration: 155.407665ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:17.180167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.295108ms","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-18T00:48:17.180193Z","caller":"traceutil/trace.go:171","msg":"trace[1526833748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:966; }","duration":"234.332669ms","start":"2026-03-18T00:48:16.945851Z","end":"2026-03-18T00:48:17.180184Z","steps":["trace[1526833748] 'agreement among raft nodes before linearized reading'  (duration: 234.259197ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:17.486537Z","caller":"traceutil/trace.go:171","msg":"trace[1272488956] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"302.083305ms","start":"2026-03-18T00:48:17.184428Z","end":"2026-03-18T00:48:17.486511Z","steps":["trace[1272488956] 'process raft request'  (duration: 281.228415ms)","trace[1272488956] 'compare'  (duration: 20.753508ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:48:17.486675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:17.184411Z","time spent":"302.193548ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:960 > 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-18T00:48:18.154584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.640861ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125953428675766108 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:962 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:48:18.154933Z","caller":"traceutil/trace.go:171","msg":"trace[2062906366] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1004; }","duration":"756.718682ms","start":"2026-03-18T00:48:17.398197Z","end":"2026-03-18T00:48:18.154915Z","steps":["trace[2062906366] 'read index received'  (duration: 67.475551ms)","trace[2062906366] 'applied index is now lower than readState.Index'  (duration: 689.242171ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:48:18.155003Z","caller":"traceutil/trace.go:171","msg":"trace[35228897] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"970.314993ms","start":"2026-03-18T00:48:17.184679Z","end":"2026-03-18T00:48:18.154994Z","steps":["trace[35228897] 'process raft request'  (duration: 970.009286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:18.155069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:17.184669Z","time spent":"970.363453ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:963 > 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-18T00:48:18.155078Z","caller":"traceutil/trace.go:171","msg":"trace[441500748] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"970.393374ms","start":"2026-03-18T00:48:17.184658Z","end":"2026-03-18T00:48:18.155051Z","steps":["trace[441500748] 'process raft request'  (duration: 637.15291ms)","trace[441500748] 'compare'  (duration: 332.544779ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:48:18.155212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:17.184482Z","time spent":"970.65611ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:962 > 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-18T00:48:18.155203Z","caller":"traceutil/trace.go:171","msg":"trace[2068994067] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"970.20882ms","start":"2026-03-18T00:48:17.184981Z","end":"2026-03-18T00:48:18.15519Z","steps":["trace[2068994067] 'process raft request'  (duration: 969.76792ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:18.155277Z","caller":"traceutil/trace.go:171","msg":"trace[1555388706] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"844.290367ms","start":"2026-03-18T00:48:17.310955Z","end":"2026-03-18T00:48:18.155246Z","steps":["trace[1555388706] 'process raft request'  (duration: 843.867158ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:18.155293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:17.18497Z","time spent":"970.284362ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:961 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-18T00:48:18.15532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.11839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:48:18.155354Z","caller":"traceutil/trace.go:171","msg":"trace[2112069959] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:971; }","duration":"757.190222ms","start":"2026-03-18T00:48:17.398152Z","end":"2026-03-18T00:48:18.155343Z","steps":["trace[2112069959] 'agreement among raft nodes before linearized reading'  (duration: 757.126241ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:18.155375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:17.39813Z","time spent":"757.240283ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-18T00:48:18.155382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:17.31092Z","time spent":"844.40965ms","remote":"127.0.0.1:60974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-fvb2x.189dc90fa67107c3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-fvb2x.189dc90fa67107c3\" value_size:683 lease:902581391820990061 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T00:48:18.29965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.576818ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125953428675766112 > lease_revoke:<id:0c869cfe685e26c7>","response":"size:28"}
{"level":"info","ts":"2026-03-18T00:48:18.299918Z","caller":"traceutil/trace.go:171","msg":"trace[696689674] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"144.920992ms","start":"2026-03-18T00:48:18.154963Z","end":"2026-03-18T00:48:18.299884Z","steps":["trace[696689674] 'read index received'  (duration: 27.111079ms)","trace[696689674] 'applied index is now lower than readState.Index'  (duration: 117.804613ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:48:18.300122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.050893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:48:18.300167Z","caller":"traceutil/trace.go:171","msg":"trace[1723321377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"635.141866ms","start":"2026-03-18T00:48:17.665012Z","end":"2026-03-18T00:48:18.300154Z","steps":["trace[1723321377] 'agreement among raft nodes before linearized reading'  (duration: 635.000983ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:18.30021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:17.664994Z","time spent":"635.208237ms","remote":"127.0.0.1:60886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-18T00:48:18.300285Z","caller":"traceutil/trace.go:171","msg":"trace[1866603371] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"138.570063ms","start":"2026-03-18T00:48:18.161675Z","end":"2026-03-18T00:48:18.300245Z","steps":["trace[1866603371] 'process raft request'  (duration: 138.107352ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:18.300412Z","caller":"traceutil/trace.go:171","msg":"trace[820333822] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"126.177859ms","start":"2026-03-18T00:48:18.1742Z","end":"2026-03-18T00:48:18.300377Z","steps":["trace[820333822] 'process raft request'  (duration: 125.823251ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:19.704331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.257586ms","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-18T00:48:19.704403Z","caller":"traceutil/trace.go:171","msg":"trace[1451253576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:977; }","duration":"210.374339ms","start":"2026-03-18T00:48:19.494011Z","end":"2026-03-18T00:48:19.704385Z","steps":["trace[1451253576] 'range keys from in-memory index tree'  (duration: 210.072302ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:20.031779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.485131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T00:48:20.031852Z","caller":"traceutil/trace.go:171","msg":"trace[104163257] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:978; }","duration":"167.631084ms","start":"2026-03-18T00:48:19.864202Z","end":"2026-03-18T00:48:20.031833Z","steps":["trace[104163257] 'count revisions from in-memory index tree'  (duration: 167.403419ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:20.349077Z","caller":"traceutil/trace.go:171","msg":"trace[2049108118] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"184.666211ms","start":"2026-03-18T00:48:20.164388Z","end":"2026-03-18T00:48:20.349054Z","steps":["trace[2049108118] 'process raft request'  (duration: 184.62ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:20.349218Z","caller":"traceutil/trace.go:171","msg":"trace[960746359] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"184.827564ms","start":"2026-03-18T00:48:20.164365Z","end":"2026-03-18T00:48:20.349192Z","steps":["trace[960746359] 'process raft request'  (duration: 184.502597ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:48:28.420123Z","caller":"traceutil/trace.go:171","msg":"trace[771113623] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"110.825289ms","start":"2026-03-18T00:48:28.30926Z","end":"2026-03-18T00:48:28.420086Z","steps":["trace[771113623] 'process raft request'  (duration: 110.553943ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:29.270364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.912598ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125953428675766251 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1033 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:48:29.270619Z","caller":"traceutil/trace.go:171","msg":"trace[472078836] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1082; }","duration":"674.428924ms","start":"2026-03-18T00:48:28.596144Z","end":"2026-03-18T00:48:29.270573Z","steps":["trace[472078836] 'read index received'  (duration: 476.810166ms)","trace[472078836] 'applied index is now lower than readState.Index'  (duration: 197.617778ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:48:29.270712Z","caller":"traceutil/trace.go:171","msg":"trace[848755118] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"846.036435ms","start":"2026-03-18T00:48:28.424665Z","end":"2026-03-18T00:48:29.270702Z","steps":["trace[848755118] 'process raft request'  (duration: 845.80405ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:29.270777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:28.42463Z","time spent":"846.113187ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1034 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-18T00:48:29.270745Z","caller":"traceutil/trace.go:171","msg":"trace[1298177928] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"846.165379ms","start":"2026-03-18T00:48:28.424551Z","end":"2026-03-18T00:48:29.270716Z","steps":["trace[1298177928] 'process raft request'  (duration: 125.811301ms)","trace[1298177928] 'compare'  (duration: 719.711583ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:48:29.270908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:28.424529Z","time spent":"846.306231ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1033 > 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-18T00:48:29.271065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.277907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:48:29.271102Z","caller":"traceutil/trace.go:171","msg":"trace[538083866] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1044; }","duration":"601.312518ms","start":"2026-03-18T00:48:28.669778Z","end":"2026-03-18T00:48:29.271091Z","steps":["trace[538083866] 'agreement among raft nodes before linearized reading'  (duration: 601.257477ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:29.271134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:28.669707Z","time spent":"601.421921ms","remote":"127.0.0.1:60886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-18T00:48:29.27119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.274052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T00:48:29.271265Z","caller":"traceutil/trace.go:171","msg":"trace[1919523242] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"846.24529ms","start":"2026-03-18T00:48:28.425007Z","end":"2026-03-18T00:48:29.271253Z","steps":["trace[1919523242] 'process raft request'  (duration: 845.513944ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:29.271338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:28.424998Z","time spent":"846.303571ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1003 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-18T00:48:29.271336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.17192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:48:29.271387Z","caller":"traceutil/trace.go:171","msg":"trace[966703857] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1044; }","duration":"675.278522ms","start":"2026-03-18T00:48:28.596093Z","end":"2026-03-18T00:48:29.271372Z","steps":["trace[966703857] 'agreement among raft nodes before linearized reading'  (duration: 675.18376ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:29.27143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:28.596071Z","time spent":"675.348543ms","remote":"127.0.0.1:50218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-03-18T00:48:29.271504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.153812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-03-18T00:48:29.271641Z","caller":"traceutil/trace.go:171","msg":"trace[1398617962] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1044; }","duration":"338.358837ms","start":"2026-03-18T00:48:28.933244Z","end":"2026-03-18T00:48:29.271603Z","steps":["trace[1398617962] 'agreement among raft nodes before linearized reading'  (duration: 337.961078ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:48:29.271742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:48:28.933221Z","time spent":"338.510241ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-03-18T00:48:29.27184Z","caller":"traceutil/trace.go:171","msg":"trace[2023942037] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1044; }","duration":"294.409336ms","start":"2026-03-18T00:48:28.976827Z","end":"2026-03-18T00:48:29.271236Z","steps":["trace[2023942037] 'agreement among raft nodes before linearized reading'  (duration: 294.300724ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:50:58.372883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.288556ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125953428675767819 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1642 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T00:50:58.373015Z","caller":"traceutil/trace.go:171","msg":"trace[936814801] linearizableReadLoop","detail":"{readStateIndex:1722; appliedIndex:1721; }","duration":"157.883305ms","start":"2026-03-18T00:50:58.215113Z","end":"2026-03-18T00:50:58.372996Z","steps":["trace[936814801] 'read index received'  (duration: 55.364834ms)","trace[936814801] 'applied index is now lower than readState.Index'  (duration: 102.517201ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:50:58.373079Z","caller":"traceutil/trace.go:171","msg":"trace[2029632458] transaction","detail":"{read_only:false; response_revision:1651; number_of_response:1; }","duration":"195.932786ms","start":"2026-03-18T00:50:58.177116Z","end":"2026-03-18T00:50:58.373048Z","steps":["trace[2029632458] 'process raft request'  (duration: 93.367075ms)","trace[2029632458] 'compare'  (duration: 102.102492ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:50:58.373228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.109561ms","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-18T00:50:58.373267Z","caller":"traceutil/trace.go:171","msg":"trace[1516188253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1651; }","duration":"158.174253ms","start":"2026-03-18T00:50:58.215081Z","end":"2026-03-18T00:50:58.373256Z","steps":["trace[1516188253] 'agreement among raft nodes before linearized reading'  (duration: 158.005119ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:51:33.556719Z","caller":"traceutil/trace.go:171","msg":"trace[1310537850] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"116.599076ms","start":"2026-03-18T00:51:33.440091Z","end":"2026-03-18T00:51:33.55669Z","steps":["trace[1310537850] 'process raft request'  (duration: 116.374851ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:51:42.528051Z","caller":"traceutil/trace.go:171","msg":"trace[1766819656] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"118.514096ms","start":"2026-03-18T00:51:42.409492Z","end":"2026-03-18T00:51:42.528006Z","steps":["trace[1766819656] 'process raft request'  (duration: 118.261081ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:43.022555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.683259ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125953428675768358 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:0c869cfe685e3025>","response":"size:40"}
{"level":"info","ts":"2026-03-18T00:51:43.022667Z","caller":"traceutil/trace.go:171","msg":"trace[138151045] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"493.123638ms","start":"2026-03-18T00:51:42.529524Z","end":"2026-03-18T00:51:43.022648Z","steps":["trace[138151045] 'read index received'  (duration: 152.119322ms)","trace[138151045] 'applied index is now lower than readState.Index'  (duration: 341.002686ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T00:51:43.022775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:51:42.528896Z","time spent":"493.876204ms","remote":"127.0.0.1:60926","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-18T00:51:43.023092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.624421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T00:51:43.024323Z","caller":"traceutil/trace.go:171","msg":"trace[481895226] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1861; }","duration":"114.348055ms","start":"2026-03-18T00:51:42.909382Z","end":"2026-03-18T00:51:43.02373Z","steps":["trace[481895226] 'agreement among raft nodes before linearized reading'  (duration: 113.583319ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:43.023121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.712997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-03-18T00:51:43.024621Z","caller":"traceutil/trace.go:171","msg":"trace[1975349716] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1861; }","duration":"448.124898ms","start":"2026-03-18T00:51:42.576322Z","end":"2026-03-18T00:51:43.024447Z","steps":["trace[1975349716] 'agreement among raft nodes before linearized reading'  (duration: 446.597974ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:43.02469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:51:42.576302Z","time spent":"448.370492ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-18T00:51:43.023243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.166724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-03-18T00:51:43.02488Z","caller":"traceutil/trace.go:171","msg":"trace[1559111762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1861; }","duration":"243.867441ms","start":"2026-03-18T00:51:42.780987Z","end":"2026-03-18T00:51:43.024854Z","steps":["trace[1559111762] 'agreement among raft nodes before linearized reading'  (duration: 242.196955ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:43.023332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.793023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:51:43.025039Z","caller":"traceutil/trace.go:171","msg":"trace[1160686460] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1861; }","duration":"495.52315ms","start":"2026-03-18T00:51:42.529504Z","end":"2026-03-18T00:51:43.025027Z","steps":["trace[1160686460] 'agreement among raft nodes before linearized reading'  (duration: 493.728461ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:43.025132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:51:42.529487Z","time spent":"495.625812ms","remote":"127.0.0.1:32830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "}
{"level":"warn","ts":"2026-03-18T00:51:43.023641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.411ms","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-18T00:51:43.025643Z","caller":"traceutil/trace.go:171","msg":"trace[1538146106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1861; }","duration":"448.463785ms","start":"2026-03-18T00:51:42.577164Z","end":"2026-03-18T00:51:43.025628Z","steps":["trace[1538146106] 'agreement among raft nodes before linearized reading'  (duration: 446.103424ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:43.025802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T00:51:42.57714Z","time spent":"448.644608ms","remote":"127.0.0.1:32960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-18T00:51:43.196246Z","caller":"traceutil/trace.go:171","msg":"trace[1231721544] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"172.148554ms","start":"2026-03-18T00:51:43.024071Z","end":"2026-03-18T00:51:43.196219Z","steps":["trace[1231721544] 'process raft request'  (duration: 112.861475ms)","trace[1231721544] 'compare'  (duration: 59.132196ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:51:43.217941Z","caller":"traceutil/trace.go:171","msg":"trace[687307677] linearizableReadLoop","detail":"{readStateIndex:1946; appliedIndex:1942; }","duration":"178.270197ms","start":"2026-03-18T00:51:43.039655Z","end":"2026-03-18T00:51:43.217925Z","steps":["trace[687307677] 'read index received'  (duration: 97.295769ms)","trace[687307677] 'applied index is now lower than readState.Index'  (duration: 80.973428ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T00:51:43.218286Z","caller":"traceutil/trace.go:171","msg":"trace[539798081] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"181.059496ms","start":"2026-03-18T00:51:43.037214Z","end":"2026-03-18T00:51:43.218273Z","steps":["trace[539798081] 'process raft request'  (duration: 180.678018ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:51:43.218278Z","caller":"traceutil/trace.go:171","msg":"trace[150620599] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"181.034625ms","start":"2026-03-18T00:51:43.037214Z","end":"2026-03-18T00:51:43.218249Z","steps":["trace[150620599] 'process raft request'  (duration: 180.636267ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T00:51:43.218408Z","caller":"traceutil/trace.go:171","msg":"trace[226459761] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"181.408614ms","start":"2026-03-18T00:51:43.036944Z","end":"2026-03-18T00:51:43.218353Z","steps":["trace[226459761] 'process raft request'  (duration: 180.731879ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:43.218574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.847818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"}
{"level":"info","ts":"2026-03-18T00:51:43.218623Z","caller":"traceutil/trace.go:171","msg":"trace[1950825059] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1865; }","duration":"140.93039ms","start":"2026-03-18T00:51:43.077675Z","end":"2026-03-18T00:51:43.218605Z","steps":["trace[1950825059] 'agreement among raft nodes before linearized reading'  (duration: 140.709515ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:43.218599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.559697ms","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:530"}
{"level":"info","ts":"2026-03-18T00:51:43.218727Z","caller":"traceutil/trace.go:171","msg":"trace[260427975] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1865; }","duration":"168.75135ms","start":"2026-03-18T00:51:43.049943Z","end":"2026-03-18T00:51:43.218694Z","steps":["trace[260427975] 'agreement among raft nodes before linearized reading'  (duration: 168.337551ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T00:51:43.219153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.470182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T00:51:43.219228Z","caller":"traceutil/trace.go:171","msg":"trace[1128685383] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1865; }","duration":"179.596725ms","start":"2026-03-18T00:51:43.039613Z","end":"2026-03-18T00:51:43.219209Z","steps":["trace[1128685383] 'agreement among raft nodes before linearized reading'  (duration: 179.467952ms)"],"step_count":1}