{"level":"warn","ts":"2026-02-25T15:07:48.980309Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T15:07:48.980379Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.65: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.65:2380","--initial-cluster=instance=https://199.19.213.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.65: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-02-25T15:07:48.980434Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T15:07:48.980444Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.65:2380"]}
{"level":"info","ts":"2026-02-25T15:07:48.980459Z","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-02-25T15:07:48.981045Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"]}
{"level":"info","ts":"2026-02-25T15:07:48.981109Z","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.65:2380"],"listen-peer-urls":["https://199.19.213.65:2380"],"advertise-client-urls":["https://199.19.213.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.65: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-02-25T15:07:48.985059Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.773823ms"}
{"level":"info","ts":"2026-02-25T15:07:48.990727Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a071a454a8148542","cluster-id":"aa233e43aeaf7fe5"}
{"level":"info","ts":"2026-02-25T15:07:48.990814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T15:07:48.990836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became follower at term 0"}
{"level":"info","ts":"2026-02-25T15:07:48.990848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a071a454a8148542 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T15:07:48.990854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became follower at term 1"}
{"level":"info","ts":"2026-02-25T15:07:48.990888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=(11561202401940899138)"}
{"level":"warn","ts":"2026-02-25T15:07:48.996709Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T15:07:48.997903Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T15:07:48.999498Z","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-02-25T15:07:49.002371Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a071a454a8148542","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T15:07:49.002583Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a071a454a8148542","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T15:07:49.002829Z","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-02-25T15:07:49.002924Z","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-02-25T15:07:49.002939Z","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-02-25T15:07:49.004478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=(11561202401940899138)"}
{"level":"info","ts":"2026-02-25T15:07:49.004944Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa233e43aeaf7fe5","local-member-id":"a071a454a8148542","added-peer-id":"a071a454a8148542","added-peer-peer-urls":["https://199.19.213.65:2380"]}
{"level":"info","ts":"2026-02-25T15:07:49.006473Z","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-02-25T15:07:49.006568Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.65:2380"}
{"level":"info","ts":"2026-02-25T15:07:49.006622Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.65:2380"}
{"level":"info","ts":"2026-02-25T15:07:49.007515Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a071a454a8148542","initial-advertise-peer-urls":["https://199.19.213.65:2380"],"listen-peer-urls":["https://199.19.213.65:2380"],"advertise-client-urls":["https://199.19.213.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T15:07:49.007573Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T15:07:49.892152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T15:07:49.892215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T15:07:49.892261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 received MsgPreVoteResp from a071a454a8148542 at term 1"}
{"level":"info","ts":"2026-02-25T15:07:49.892277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became candidate at term 2"}
{"level":"info","ts":"2026-02-25T15:07:49.892287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 received MsgVoteResp from a071a454a8148542 at term 2"}
{"level":"info","ts":"2026-02-25T15:07:49.892301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became leader at term 2"}
{"level":"info","ts":"2026-02-25T15:07:49.89232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a071a454a8148542 elected leader a071a454a8148542 at term 2"}
{"level":"info","ts":"2026-02-25T15:07:49.893513Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a071a454a8148542","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.65:2379]}","request-path":"/0/members/a071a454a8148542/attributes","cluster-id":"aa233e43aeaf7fe5","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T15:07:49.893549Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T15:07:49.893566Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T15:07:49.893831Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T15:07:49.894075Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T15:07:49.894182Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T15:07:49.895038Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa233e43aeaf7fe5","local-member-id":"a071a454a8148542","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T15:07:49.895152Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T15:07:49.895201Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T15:07:49.896649Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T15:07:49.89674Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.65:2379"}
{"level":"info","ts":"2026-02-25T15:08:01.838067Z","caller":"traceutil/trace.go:171","msg":"trace[1069831832] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"254.643432ms","start":"2026-02-25T15:08:01.583403Z","end":"2026-02-25T15:08:01.838047Z","steps":["trace[1069831832] 'process raft request'  (duration: 254.516108ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:01.844167Z","caller":"traceutil/trace.go:171","msg":"trace[318500683] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"133.398397ms","start":"2026-02-25T15:08:01.710752Z","end":"2026-02-25T15:08:01.84415Z","steps":["trace[318500683] 'process raft request'  (duration: 133.303864ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:22.916364Z","caller":"traceutil/trace.go:171","msg":"trace[863023579] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"261.552959ms","start":"2026-02-25T15:08:22.654786Z","end":"2026-02-25T15:08:22.916339Z","steps":["trace[863023579] 'process raft request'  (duration: 261.347984ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:24.122963Z","caller":"traceutil/trace.go:171","msg":"trace[902361522] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"181.076237ms","start":"2026-02-25T15:08:23.94181Z","end":"2026-02-25T15:08:24.122886Z","steps":["trace[902361522] 'process raft request'  (duration: 148.733384ms)","trace[902361522] 'compare'  (duration: 32.130387ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:08:26.311091Z","caller":"traceutil/trace.go:171","msg":"trace[294620600] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"166.480473ms","start":"2026-02-25T15:08:26.144568Z","end":"2026-02-25T15:08:26.311048Z","steps":["trace[294620600] 'process raft request'  (duration: 166.129583ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:33.226281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.559834ms","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-02-25T15:08:33.226402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.615625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.65\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-25T15:08:33.226492Z","caller":"traceutil/trace.go:171","msg":"trace[76239889] range","detail":"{range_begin:/registry/masterleases/199.19.213.65; range_end:; response_count:1; response_revision:503; }","duration":"309.747889ms","start":"2026-02-25T15:08:32.916714Z","end":"2026-02-25T15:08:33.226462Z","steps":["trace[76239889] 'range keys from in-memory index tree'  (duration: 309.200564ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:33.226601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.387463ms","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-02-25T15:08:33.226574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:32.916684Z","time spent":"309.876013ms","remote":"127.0.0.1:40714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.65\" "}
{"level":"info","ts":"2026-02-25T15:08:33.226644Z","caller":"traceutil/trace.go:171","msg":"trace[835584916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:503; }","duration":"228.460526ms","start":"2026-02-25T15:08:32.99817Z","end":"2026-02-25T15:08:33.226631Z","steps":["trace[835584916] 'range keys from in-memory index tree'  (duration: 228.232599ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:33.226636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.070609ms","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-02-25T15:08:33.2267Z","caller":"traceutil/trace.go:171","msg":"trace[1797960317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:503; }","duration":"233.169302ms","start":"2026-02-25T15:08:32.993511Z","end":"2026-02-25T15:08:33.22668Z","steps":["trace[1797960317] 'range keys from in-memory index tree'  (duration: 232.72362ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:33.226482Z","caller":"traceutil/trace.go:171","msg":"trace[400470799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:503; }","duration":"226.78919ms","start":"2026-02-25T15:08:32.999649Z","end":"2026-02-25T15:08:33.226438Z","steps":["trace[400470799] 'range keys from in-memory index tree'  (duration: 226.337098ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:33.226936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.739316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cblsq\" ","response":"range_response_count:1 size:16652"}
{"level":"info","ts":"2026-02-25T15:08:33.22703Z","caller":"traceutil/trace.go:171","msg":"trace[1387881731] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cblsq; range_end:; response_count:1; response_revision:503; }","duration":"290.88624ms","start":"2026-02-25T15:08:32.936119Z","end":"2026-02-25T15:08:33.227005Z","steps":["trace[1387881731] 'range keys from in-memory index tree'  (duration: 289.800991ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:33.829148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.818368ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9602409520740270700 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:498 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:08:33.829493Z","caller":"traceutil/trace.go:171","msg":"trace[1373192998] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"598.038399ms","start":"2026-02-25T15:08:33.231409Z","end":"2026-02-25T15:08:33.829448Z","steps":["trace[1373192998] 'process raft request'  (duration: 225.760662ms)","trace[1373192998] 'compare'  (duration: 370.645203ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:08:33.829557Z","caller":"traceutil/trace.go:171","msg":"trace[1955166803] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"598.03021ms","start":"2026-02-25T15:08:33.231509Z","end":"2026-02-25T15:08:33.829539Z","steps":["trace[1955166803] 'process raft request'  (duration: 597.780523ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:33.829627Z","caller":"traceutil/trace.go:171","msg":"trace[1326171531] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"587.730672ms","start":"2026-02-25T15:08:33.241879Z","end":"2026-02-25T15:08:33.829609Z","steps":["trace[1326171531] 'process raft request'  (duration: 587.558667ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:33.829657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:33.231505Z","time spent":"598.100212ms","remote":"127.0.0.1:40930","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:497 > 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-02-25T15:08:33.829682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:33.241862Z","time spent":"587.790643ms","remote":"127.0.0.1:40852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-cblsq\" mod_revision:479 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-cblsq\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-cblsq\" > >"}
{"level":"info","ts":"2026-02-25T15:08:33.829642Z","caller":"traceutil/trace.go:171","msg":"trace[855660461] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"597.959517ms","start":"2026-02-25T15:08:33.231592Z","end":"2026-02-25T15:08:33.829551Z","steps":["trace[855660461] 'process raft request'  (duration: 597.809373ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:33.829715Z","caller":"traceutil/trace.go:171","msg":"trace[2135892829] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"491.565506ms","start":"2026-02-25T15:08:33.338132Z","end":"2026-02-25T15:08:33.829697Z","steps":["trace[2135892829] 'process raft request'  (duration: 491.358991ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:33.829714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:33.231394Z","time spent":"598.206184ms","remote":"127.0.0.1:40930","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:498 > 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-02-25T15:08:33.829801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:33.338103Z","time spent":"491.649269ms","remote":"127.0.0.1:40714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.65\" mod_revision:445 > success:<request_put:<key:\"/registry/masterleases/199.19.213.65\" value_size:66 lease:379037483885494890 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.65\" > >"}
{"level":"warn","ts":"2026-02-25T15:08:33.8298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:33.231557Z","time spent":"598.163683ms","remote":"127.0.0.1:40930","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:496 > 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-02-25T15:08:33.829549Z","caller":"traceutil/trace.go:171","msg":"trace[1250030643] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:522; }","duration":"544.251859ms","start":"2026-02-25T15:08:33.285277Z","end":"2026-02-25T15:08:33.829529Z","steps":["trace[1250030643] 'read index received'  (duration: 51.593673ms)","trace[1250030643] 'applied index is now lower than readState.Index'  (duration: 492.657036ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:08:33.829979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.71075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:08:33.830021Z","caller":"traceutil/trace.go:171","msg":"trace[1284461791] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"544.801144ms","start":"2026-02-25T15:08:33.285208Z","end":"2026-02-25T15:08:33.830009Z","steps":["trace[1284461791] 'agreement among raft nodes before linearized reading'  (duration: 544.373292ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:33.830048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:33.285187Z","time spent":"544.854944ms","remote":"127.0.0.1:50118","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-02-25T15:08:34.733377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.065013ms","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-02-25T15:08:34.73352Z","caller":"traceutil/trace.go:171","msg":"trace[2119069701] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:508; }","duration":"391.466275ms","start":"2026-02-25T15:08:34.342021Z","end":"2026-02-25T15:08:34.733487Z","steps":["trace[2119069701] 'range keys from in-memory index tree'  (duration: 390.705875ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:34.733589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:34.341997Z","time spent":"391.574017ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T15:08:36.033507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.816062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:08:36.033625Z","caller":"traceutil/trace.go:171","msg":"trace[1161105718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"748.001557ms","start":"2026-02-25T15:08:35.285596Z","end":"2026-02-25T15:08:36.033598Z","steps":["trace[1161105718] 'range keys from in-memory index tree'  (duration: 747.701949ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:36.033695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:35.28557Z","time spent":"748.11401ms","remote":"127.0.0.1:50118","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-02-25T15:08:36.335606Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602409520740270712,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:08:36.588537Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.215018619s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T15:08:36.589157Z","caller":"traceutil/trace.go:171","msg":"trace[1929454683] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"754.421889ms","start":"2026-02-25T15:08:35.834702Z","end":"2026-02-25T15:08:36.589124Z","steps":["trace[1929454683] 'read index received'  (duration: 754.033819ms)","trace[1929454683] 'applied index is now lower than readState.Index'  (duration: 386.74µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:08:36.589269Z","caller":"traceutil/trace.go:171","msg":"trace[1481570957] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.215863882s","start":"2026-02-25T15:08:35.373393Z","end":"2026-02-25T15:08:36.589257Z","steps":["trace[1481570957] 'process raft request'  (duration: 1.21544027s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:36.589414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:35.373359Z","time spent":"1.215943784s","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:485 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-25T15:08:36.589633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.81924ms","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-02-25T15:08:36.589674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.336629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:08:36.589739Z","caller":"traceutil/trace.go:171","msg":"trace[2122178967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"754.980074ms","start":"2026-02-25T15:08:35.834717Z","end":"2026-02-25T15:08:36.589697Z","steps":["trace[2122178967] 'agreement among raft nodes before linearized reading'  (duration: 754.811999ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:36.589797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:35.834679Z","time spent":"755.106757ms","remote":"127.0.0.1:40930","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-02-25T15:08:36.590034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.767958ms","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-02-25T15:08:36.590059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.351994ms","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-02-25T15:08:36.590134Z","caller":"traceutil/trace.go:171","msg":"trace[179896964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:510; }","duration":"755.481527ms","start":"2026-02-25T15:08:35.834641Z","end":"2026-02-25T15:08:36.590123Z","steps":["trace[179896964] 'agreement among raft nodes before linearized reading'  (duration: 755.22961ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:36.590078Z","caller":"traceutil/trace.go:171","msg":"trace[981938644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:510; }","duration":"755.392345ms","start":"2026-02-25T15:08:35.834676Z","end":"2026-02-25T15:08:36.590068Z","steps":["trace[981938644] 'agreement among raft nodes before linearized reading'  (duration: 754.706876ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:36.590196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:35.834601Z","time spent":"755.58315ms","remote":"127.0.0.1:40930","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-02-25T15:08:36.590226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:35.834647Z","time spent":"755.545189ms","remote":"127.0.0.1:40930","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-02-25T15:08:36.589778Z","caller":"traceutil/trace.go:171","msg":"trace[1009037795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"554.521914ms","start":"2026-02-25T15:08:36.03523Z","end":"2026-02-25T15:08:36.589752Z","steps":["trace[1009037795] 'agreement among raft nodes before linearized reading'  (duration: 554.280648ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:36.59039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:36.035193Z","time spent":"555.190832ms","remote":"127.0.0.1:50124","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-02-25T15:08:37.475998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.507911ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:08:37.476178Z","caller":"traceutil/trace.go:171","msg":"trace[1164080545] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:511; }","duration":"472.709927ms","start":"2026-02-25T15:08:37.003444Z","end":"2026-02-25T15:08:37.476153Z","steps":["trace[1164080545] 'range keys from in-memory index tree'  (duration: 472.481941ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:37.488191Z","caller":"traceutil/trace.go:171","msg":"trace[1538769746] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"892.978869ms","start":"2026-02-25T15:08:36.595187Z","end":"2026-02-25T15:08:37.488166Z","steps":["trace[1538769746] 'process raft request'  (duration: 892.690931ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:37.488282Z","caller":"traceutil/trace.go:171","msg":"trace[2126245099] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"892.893377ms","start":"2026-02-25T15:08:36.595349Z","end":"2026-02-25T15:08:37.488242Z","steps":["trace[2126245099] 'process raft request'  (duration: 892.733923ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:37.488356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:36.595156Z","time spent":"893.104933ms","remote":"127.0.0.1:40930","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:505 > 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-02-25T15:08:37.488167Z","caller":"traceutil/trace.go:171","msg":"trace[737030954] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:530; }","duration":"889.891946ms","start":"2026-02-25T15:08:36.598241Z","end":"2026-02-25T15:08:37.488132Z","steps":["trace[737030954] 'read index received'  (duration: 27.073231ms)","trace[737030954] 'applied index is now lower than readState.Index'  (duration: 862.817375ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:08:37.488487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:36.595332Z","time spent":"893.049382ms","remote":"127.0.0.1:40930","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:506 > 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-02-25T15:08:37.488518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.254446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:08:37.488842Z","caller":"traceutil/trace.go:171","msg":"trace[702235886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"890.623736ms","start":"2026-02-25T15:08:36.598198Z","end":"2026-02-25T15:08:37.488822Z","steps":["trace[702235886] 'agreement among raft nodes before linearized reading'  (duration: 890.191864ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:37.488868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.014566ms","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-02-25T15:08:37.488974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:36.598183Z","time spent":"890.743239ms","remote":"127.0.0.1:50118","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-02-25T15:08:37.488974Z","caller":"traceutil/trace.go:171","msg":"trace[1091406904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"642.193651ms","start":"2026-02-25T15:08:36.846757Z","end":"2026-02-25T15:08:37.48895Z","steps":["trace[1091406904] 'agreement among raft nodes before linearized reading'  (duration: 641.833272ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:37.489323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:36.846727Z","time spent":"642.578702ms","remote":"127.0.0.1:40930","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-02-25T15:08:40.553238Z","caller":"traceutil/trace.go:171","msg":"trace[946099977] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:569; }","duration":"257.057867ms","start":"2026-02-25T15:08:40.296153Z","end":"2026-02-25T15:08:40.553211Z","steps":["trace[946099977] 'read index received'  (duration: 256.869392ms)","trace[946099977] 'applied index is now lower than readState.Index'  (duration: 186.945µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:08:40.553432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.217261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:08:40.553534Z","caller":"traceutil/trace.go:171","msg":"trace[41788838] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:549; }","duration":"257.321174ms","start":"2026-02-25T15:08:40.296138Z","end":"2026-02-25T15:08:40.553459Z","steps":["trace[41788838] 'agreement among raft nodes before linearized reading'  (duration: 257.19548ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:40.553635Z","caller":"traceutil/trace.go:171","msg":"trace[148399710] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"438.062382ms","start":"2026-02-25T15:08:40.115541Z","end":"2026-02-25T15:08:40.553603Z","steps":["trace[148399710] 'process raft request'  (duration: 437.489416ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:40.553792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:40.115514Z","time spent":"438.192145ms","remote":"127.0.0.1:40746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:548 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:5070 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" > >"}
{"level":"info","ts":"2026-02-25T15:08:40.614719Z","caller":"traceutil/trace.go:171","msg":"trace[685975582] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"115.897378ms","start":"2026-02-25T15:08:40.498778Z","end":"2026-02-25T15:08:40.614676Z","steps":["trace[685975582] 'process raft request'  (duration: 115.498917ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:42.57139Z","caller":"traceutil/trace.go:171","msg":"trace[1571357066] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"308.172617ms","start":"2026-02-25T15:08:42.263193Z","end":"2026-02-25T15:08:42.571365Z","steps":["trace[1571357066] 'process raft request'  (duration: 291.515497ms)","trace[1571357066] 'compare'  (duration: 16.396403ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:08:42.571512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:42.263163Z","time spent":"308.28436ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:499 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-25T15:08:42.784522Z","caller":"traceutil/trace.go:171","msg":"trace[173370986] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:598; }","duration":"288.240258ms","start":"2026-02-25T15:08:42.496242Z","end":"2026-02-25T15:08:42.784482Z","steps":["trace[173370986] 'read index received'  (duration: 58.54694ms)","trace[173370986] 'applied index is now lower than readState.Index'  (duration: 229.691628ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:08:42.784604Z","caller":"traceutil/trace.go:171","msg":"trace[1952471279] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"481.634998ms","start":"2026-02-25T15:08:42.302919Z","end":"2026-02-25T15:08:42.784554Z","steps":["trace[1952471279] 'process raft request'  (duration: 434.886057ms)","trace[1952471279] 'compare'  (duration: 46.473394ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:08:42.784831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:42.302874Z","time spent":"481.827963ms","remote":"127.0.0.1:40746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" value_size:23189 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T15:08:42.784945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.67151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"}
{"level":"info","ts":"2026-02-25T15:08:42.784999Z","caller":"traceutil/trace.go:171","msg":"trace[426071212] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:579; }","duration":"288.807814ms","start":"2026-02-25T15:08:42.496173Z","end":"2026-02-25T15:08:42.784981Z","steps":["trace[426071212] 'agreement among raft nodes before linearized reading'  (duration: 288.502556ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:42.78514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.088432ms","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-02-25T15:08:42.785243Z","caller":"traceutil/trace.go:171","msg":"trace[1954986366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:579; }","duration":"103.231506ms","start":"2026-02-25T15:08:42.681984Z","end":"2026-02-25T15:08:42.785216Z","steps":["trace[1954986366] 'agreement among raft nodes before linearized reading'  (duration: 102.947188ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:42.913865Z","caller":"traceutil/trace.go:171","msg":"trace[731308947] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"112.090015ms","start":"2026-02-25T15:08:42.80174Z","end":"2026-02-25T15:08:42.91383Z","steps":["trace[731308947] 'process raft request'  (duration: 111.89292ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:47.883951Z","caller":"traceutil/trace.go:171","msg":"trace[714099620] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"136.087803ms","start":"2026-02-25T15:08:47.747844Z","end":"2026-02-25T15:08:47.883932Z","steps":["trace[714099620] 'process raft request'  (duration: 135.964309ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:48.133972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.11313ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9602409520740270951 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:618 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:08:48.134113Z","caller":"traceutil/trace.go:171","msg":"trace[654695414] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"198.786165ms","start":"2026-02-25T15:08:47.9353Z","end":"2026-02-25T15:08:48.134086Z","steps":["trace[654695414] 'process raft request'  (duration: 61.449759ms)","trace[654695414] 'compare'  (duration: 136.822462ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:08:55.461746Z","caller":"traceutil/trace.go:171","msg":"trace[2034811343] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:725; }","duration":"178.488027ms","start":"2026-02-25T15:08:55.283228Z","end":"2026-02-25T15:08:55.461716Z","steps":["trace[2034811343] 'read index received'  (duration: 178.203389ms)","trace[2034811343] 'applied index is now lower than readState.Index'  (duration: 283.608µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:08:55.461906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.660851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:08:55.461933Z","caller":"traceutil/trace.go:171","msg":"trace[197481759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:700; }","duration":"178.752583ms","start":"2026-02-25T15:08:55.28317Z","end":"2026-02-25T15:08:55.461922Z","steps":["trace[197481759] 'agreement among raft nodes before linearized reading'  (duration: 178.676821ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:55.462036Z","caller":"traceutil/trace.go:171","msg":"trace[1188623322] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"565.573493ms","start":"2026-02-25T15:08:54.896415Z","end":"2026-02-25T15:08:55.461989Z","steps":["trace[1188623322] 'process raft request'  (duration: 565.118421ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:55.462226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:54.896386Z","time spent":"565.752308ms","remote":"127.0.0.1:40930","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:692 > 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-02-25T15:08:56.310916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.970434ms","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-02-25T15:08:56.311007Z","caller":"traceutil/trace.go:171","msg":"trace[762378910] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:700; }","duration":"609.123349ms","start":"2026-02-25T15:08:55.701864Z","end":"2026-02-25T15:08:56.310987Z","steps":["trace[762378910] 'range keys from in-memory index tree'  (duration: 608.736108ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:56.311278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:55.819368Z","time spent":"491.905906ms","remote":"127.0.0.1:32934","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-25T15:08:56.311366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.216412ms","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-02-25T15:08:56.311443Z","caller":"traceutil/trace.go:171","msg":"trace[548186024] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:700; }","duration":"609.316314ms","start":"2026-02-25T15:08:55.702111Z","end":"2026-02-25T15:08:56.311427Z","steps":["trace[548186024] 'range keys from in-memory index tree'  (duration: 609.1423ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:56.311472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:55.702102Z","time spent":"609.364315ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T15:08:56.311367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.418277ms","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-02-25T15:08:56.311571Z","caller":"traceutil/trace.go:171","msg":"trace[2002366618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:700; }","duration":"602.639964ms","start":"2026-02-25T15:08:55.708909Z","end":"2026-02-25T15:08:56.311549Z","steps":["trace[2002366618] 'range keys from in-memory index tree'  (duration: 602.332205ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:56.31159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:55.708898Z","time spent":"602.687225ms","remote":"127.0.0.1:40930","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-02-25T15:08:56.311973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:55.701799Z","time spent":"609.242012ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T15:08:57.122332Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602409520740271073,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T15:08:57.283263Z","caller":"traceutil/trace.go:171","msg":"trace[97179892] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"966.852314ms","start":"2026-02-25T15:08:56.316339Z","end":"2026-02-25T15:08:57.283191Z","steps":["trace[97179892] 'process raft request'  (duration: 966.490364ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:57.283464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:56.316314Z","time spent":"967.046888ms","remote":"127.0.0.1:40930","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:697 > 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-02-25T15:08:57.284123Z","caller":"traceutil/trace.go:171","msg":"trace[1717380371] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"966.774101ms","start":"2026-02-25T15:08:56.317331Z","end":"2026-02-25T15:08:57.284105Z","steps":["trace[1717380371] 'process raft request'  (duration: 966.539855ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:57.28424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:56.317241Z","time spent":"966.933715ms","remote":"127.0.0.1:40930","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:699 > 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-02-25T15:08:57.284412Z","caller":"traceutil/trace.go:171","msg":"trace[1074117168] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"966.990427ms","start":"2026-02-25T15:08:56.317395Z","end":"2026-02-25T15:08:57.284385Z","steps":["trace[1074117168] 'process raft request'  (duration: 966.662728ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:08:57.28454Z","caller":"traceutil/trace.go:171","msg":"trace[537344410] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"924.317895ms","start":"2026-02-25T15:08:56.360201Z","end":"2026-02-25T15:08:57.284519Z","steps":["trace[537344410] 'process raft request'  (duration: 924.094889ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:57.284599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:56.317383Z","time spent":"967.13065ms","remote":"127.0.0.1:40930","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:696 > 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-02-25T15:08:57.284639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:56.360174Z","time spent":"924.414248ms","remote":"127.0.0.1:40844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4727,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:641 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4693 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-25T15:08:57.462641Z","caller":"traceutil/trace.go:171","msg":"trace[1222986738] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:727; }","duration":"840.847102ms","start":"2026-02-25T15:08:56.621763Z","end":"2026-02-25T15:08:57.46261Z","steps":["trace[1222986738] 'read index received'  (duration: 661.214365ms)","trace[1222986738] 'applied index is now lower than readState.Index'  (duration: 179.631317ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:08:57.462728Z","caller":"traceutil/trace.go:171","msg":"trace[1306055739] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"425.927694ms","start":"2026-02-25T15:08:57.036753Z","end":"2026-02-25T15:08:57.462681Z","steps":["trace[1306055739] 'process raft request'  (duration: 425.695748ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:57.462893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:57.036715Z","time spent":"426.099699ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:622 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-25T15:08:57.462916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.831245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:08:57.462968Z","caller":"traceutil/trace.go:171","msg":"trace[874697047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:706; }","duration":"175.944928ms","start":"2026-02-25T15:08:57.28701Z","end":"2026-02-25T15:08:57.462955Z","steps":["trace[874697047] 'agreement among raft nodes before linearized reading'  (duration: 175.832925ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:57.462935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.106089ms","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-02-25T15:08:57.463045Z","caller":"traceutil/trace.go:171","msg":"trace[1541114622] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:706; }","duration":"841.264604ms","start":"2026-02-25T15:08:56.621754Z","end":"2026-02-25T15:08:57.463018Z","steps":["trace[1541114622] 'agreement among raft nodes before linearized reading'  (duration: 841.019727ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:57.463097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:56.62167Z","time spent":"841.416487ms","remote":"127.0.0.1:40910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:08:58.905613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.816758ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9602409520740271087 > lease_revoke:<id:05429c95578d82ee>","response":"size:29"}
{"level":"info","ts":"2026-02-25T15:08:58.905728Z","caller":"traceutil/trace.go:171","msg":"trace[1948866182] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:733; }","duration":"503.852827ms","start":"2026-02-25T15:08:58.401857Z","end":"2026-02-25T15:08:58.90571Z","steps":["trace[1948866182] 'read index received'  (duration: 225.861605ms)","trace[1948866182] 'applied index is now lower than readState.Index'  (duration: 277.990212ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:08:58.906023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.150046ms","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-02-25T15:08:58.906101Z","caller":"traceutil/trace.go:171","msg":"trace[726565943] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:707; }","duration":"504.303029ms","start":"2026-02-25T15:08:58.40178Z","end":"2026-02-25T15:08:58.906083Z","steps":["trace[726565943] 'agreement among raft nodes before linearized reading'  (duration: 504.042662ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:58.906141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:58.401719Z","time spent":"504.414953ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T15:08:58.906206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.702323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T15:08:58.90628Z","caller":"traceutil/trace.go:171","msg":"trace[1142792121] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:707; }","duration":"397.879418ms","start":"2026-02-25T15:08:58.50838Z","end":"2026-02-25T15:08:58.90626Z","steps":["trace[1142792121] 'agreement among raft nodes before linearized reading'  (duration: 397.644402ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:08:58.906323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:08:58.508351Z","time spent":"397.95957ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":12,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:09:23.973306Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602409520740271316,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T15:09:24.440005Z","caller":"traceutil/trace.go:171","msg":"trace[821021510] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"970.135766ms","start":"2026-02-25T15:09:23.469833Z","end":"2026-02-25T15:09:24.439969Z","steps":["trace[821021510] 'process raft request'  (duration: 969.914ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:24.440224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:23.469801Z","time spent":"970.307081ms","remote":"127.0.0.1:40930","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:776 > 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-02-25T15:09:24.457483Z","caller":"traceutil/trace.go:171","msg":"trace[1058735399] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:813; }","duration":"984.291449ms","start":"2026-02-25T15:09:23.473172Z","end":"2026-02-25T15:09:24.457463Z","steps":["trace[1058735399] 'read index received'  (duration: 966.603411ms)","trace[1058735399] 'applied index is now lower than readState.Index'  (duration: 17.687218ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:09:24.457538Z","caller":"traceutil/trace.go:171","msg":"trace[387889647] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"978.217285ms","start":"2026-02-25T15:09:23.479306Z","end":"2026-02-25T15:09:24.457523Z","steps":["trace[387889647] 'process raft request'  (duration: 978.107932ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:24.457603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:23.479291Z","time spent":"978.273046ms","remote":"127.0.0.1:40930","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:753 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-25T15:09:24.45759Z","caller":"traceutil/trace.go:171","msg":"trace[622324038] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"984.868785ms","start":"2026-02-25T15:09:23.472616Z","end":"2026-02-25T15:09:24.457484Z","steps":["trace[622324038] 'process raft request'  (duration: 984.69011ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:24.457674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.492435ms","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-02-25T15:09:24.457728Z","caller":"traceutil/trace.go:171","msg":"trace[640787102] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:783; }","duration":"984.570786ms","start":"2026-02-25T15:09:23.473136Z","end":"2026-02-25T15:09:24.457707Z","steps":["trace[640787102] 'agreement among raft nodes before linearized reading'  (duration: 984.433262ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:24.457797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:23.473124Z","time spent":"984.657769ms","remote":"127.0.0.1:40930","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-02-25T15:09:24.457852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.820242ms","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-02-25T15:09:24.457925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.869959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:09:24.457934Z","caller":"traceutil/trace.go:171","msg":"trace[1905300061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:783; }","duration":"805.947496ms","start":"2026-02-25T15:09:23.651967Z","end":"2026-02-25T15:09:24.457914Z","steps":["trace[1905300061] 'agreement among raft nodes before linearized reading'  (duration: 805.7407ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:24.457875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:23.472587Z","time spent":"985.134861ms","remote":"127.0.0.1:40930","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:775 > 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-02-25T15:09:24.457963Z","caller":"traceutil/trace.go:171","msg":"trace[760165510] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:783; }","duration":"296.948521ms","start":"2026-02-25T15:09:24.161003Z","end":"2026-02-25T15:09:24.457951Z","steps":["trace[760165510] 'agreement among raft nodes before linearized reading'  (duration: 296.888889ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:24.457974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.823754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:09:24.458075Z","caller":"traceutil/trace.go:171","msg":"trace[715328252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:783; }","duration":"172.904926ms","start":"2026-02-25T15:09:24.285127Z","end":"2026-02-25T15:09:24.458032Z","steps":["trace[715328252] 'agreement among raft nodes before linearized reading'  (duration: 172.751772ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:24.457968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:23.651943Z","time spent":"806.018478ms","remote":"127.0.0.1:40930","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-02-25T15:09:26.753473Z","caller":"traceutil/trace.go:171","msg":"trace[554664257] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"289.613063ms","start":"2026-02-25T15:09:26.463832Z","end":"2026-02-25T15:09:26.753445Z","steps":["trace[554664257] 'read index received'  (duration: 289.369376ms)","trace[554664257] 'applied index is now lower than readState.Index'  (duration: 242.136µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:09:26.753606Z","caller":"traceutil/trace.go:171","msg":"trace[1883113226] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"304.618788ms","start":"2026-02-25T15:09:26.448974Z","end":"2026-02-25T15:09:26.753593Z","steps":["trace[1883113226] 'process raft request'  (duration: 304.300939ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:26.75377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:26.44896Z","time spent":"304.677029ms","remote":"127.0.0.1:40930","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:781 > 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-02-25T15:09:26.753877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.644982ms","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-02-25T15:09:26.753969Z","caller":"traceutil/trace.go:171","msg":"trace[42541489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:787; }","duration":"225.780696ms","start":"2026-02-25T15:09:26.528163Z","end":"2026-02-25T15:09:26.753944Z","steps":["trace[42541489] 'agreement among raft nodes before linearized reading'  (duration: 225.579381ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:26.754099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.25233ms","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-02-25T15:09:26.754159Z","caller":"traceutil/trace.go:171","msg":"trace[1824605496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:787; }","duration":"290.347901ms","start":"2026-02-25T15:09:26.463797Z","end":"2026-02-25T15:09:26.754145Z","steps":["trace[1824605496] 'agreement among raft nodes before linearized reading'  (duration: 290.131696ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:26.754285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.421979ms","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-02-25T15:09:26.754333Z","caller":"traceutil/trace.go:171","msg":"trace[445285144] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:787; }","duration":"224.498221ms","start":"2026-02-25T15:09:26.529822Z","end":"2026-02-25T15:09:26.75432Z","steps":["trace[445285144] 'agreement among raft nodes before linearized reading'  (duration: 224.375538ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:43.373287Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602409520740271555,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:09:43.875491Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602409520740271555,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:09:43.960606Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.090573463s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T15:09:44.490373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.522869ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9602409520740271556 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:888 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:09:44.490476Z","caller":"traceutil/trace.go:171","msg":"trace[998551728] linearizableReadLoop","detail":"{readStateIndex:931; appliedIndex:930; }","duration":"1.618114139s","start":"2026-02-25T15:09:42.872347Z","end":"2026-02-25T15:09:44.490461Z","steps":["trace[998551728] 'read index received'  (duration: 1.088374343s)","trace[998551728] 'applied index is now lower than readState.Index'  (duration: 529.738686ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:09:44.49066Z","caller":"traceutil/trace.go:171","msg":"trace[598387343] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"1.62073313s","start":"2026-02-25T15:09:42.869917Z","end":"2026-02-25T15:09:44.49065Z","steps":["trace[598387343] 'process raft request'  (duration: 1.090868541s)","trace[598387343] 'compare'  (duration: 529.333404ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:09:44.490716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:42.869891Z","time spent":"1.620803201s","remote":"127.0.0.1:40930","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:888 > 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-02-25T15:09:44.49091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.618562391s","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-02-25T15:09:44.490937Z","caller":"traceutil/trace.go:171","msg":"trace[1436334025] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:893; }","duration":"1.618589631s","start":"2026-02-25T15:09:42.872339Z","end":"2026-02-25T15:09:44.490928Z","steps":["trace[1436334025] 'agreement among raft nodes before linearized reading'  (duration: 1.618484908s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:44.490956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:42.872294Z","time spent":"1.618658214s","remote":"127.0.0.1:40930","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-02-25T15:09:44.491077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.570763718s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.65\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-25T15:09:44.491101Z","caller":"traceutil/trace.go:171","msg":"trace[1775945769] range","detail":"{range_begin:/registry/masterleases/199.19.213.65; range_end:; response_count:1; response_revision:893; }","duration":"1.57082445s","start":"2026-02-25T15:09:42.920271Z","end":"2026-02-25T15:09:44.491096Z","steps":["trace[1775945769] 'agreement among raft nodes before linearized reading'  (duration: 1.570765578s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:44.491118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:42.920251Z","time spent":"1.570863261s","remote":"127.0.0.1:40714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.65\" "}
{"level":"warn","ts":"2026-02-25T15:09:44.491258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204244506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:09:44.491283Z","caller":"traceutil/trace.go:171","msg":"trace[427219211] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:893; }","duration":"1.204325969s","start":"2026-02-25T15:09:43.286951Z","end":"2026-02-25T15:09:44.491277Z","steps":["trace[427219211] 'agreement among raft nodes before linearized reading'  (duration: 1.204290188s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:44.4913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:43.28691Z","time spent":"1.20438655s","remote":"127.0.0.1:50118","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-02-25T15:09:44.491406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.296245594s","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-02-25T15:09:44.491429Z","caller":"traceutil/trace.go:171","msg":"trace[956817113] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:893; }","duration":"1.296304886s","start":"2026-02-25T15:09:43.195119Z","end":"2026-02-25T15:09:44.491423Z","steps":["trace[956817113] 'agreement among raft nodes before linearized reading'  (duration: 1.296252304s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:44.491446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:43.195096Z","time spent":"1.296344847s","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T15:09:44.49153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.384713356s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:09:44.491552Z","caller":"traceutil/trace.go:171","msg":"trace[1971515326] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:893; }","duration":"1.384780908s","start":"2026-02-25T15:09:43.106766Z","end":"2026-02-25T15:09:44.491547Z","steps":["trace[1971515326] 'agreement among raft nodes before linearized reading'  (duration: 1.384745347s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:44.49157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:43.106734Z","time spent":"1.38483154s","remote":"127.0.0.1:41120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"info","ts":"2026-02-25T15:09:48.655211Z","caller":"traceutil/trace.go:171","msg":"trace[1787869963] linearizableReadLoop","detail":"{readStateIndex:946; appliedIndex:945; }","duration":"134.241761ms","start":"2026-02-25T15:09:48.520948Z","end":"2026-02-25T15:09:48.65519Z","steps":["trace[1787869963] 'read index received'  (duration: 134.018855ms)","trace[1787869963] 'applied index is now lower than readState.Index'  (duration: 221.866µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:09:48.655357Z","caller":"traceutil/trace.go:171","msg":"trace[1249941812] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"138.642819ms","start":"2026-02-25T15:09:48.516669Z","end":"2026-02-25T15:09:48.655312Z","steps":["trace[1249941812] 'process raft request'  (duration: 138.380092ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:48.655428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.461746ms","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-02-25T15:09:48.655535Z","caller":"traceutil/trace.go:171","msg":"trace[1291960896] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:906; }","duration":"134.634921ms","start":"2026-02-25T15:09:48.520891Z","end":"2026-02-25T15:09:48.655526Z","steps":["trace[1291960896] 'agreement among raft nodes before linearized reading'  (duration: 134.411285ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:48.655708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.254339ms","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-02-25T15:09:48.655822Z","caller":"traceutil/trace.go:171","msg":"trace[2038517261] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:906; }","duration":"131.475296ms","start":"2026-02-25T15:09:48.524321Z","end":"2026-02-25T15:09:48.655796Z","steps":["trace[2038517261] 'agreement among raft nodes before linearized reading'  (duration: 131.100316ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:59.224946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.026831ms","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-02-25T15:09:59.225054Z","caller":"traceutil/trace.go:171","msg":"trace[1403185588] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:945; }","duration":"250.186476ms","start":"2026-02-25T15:09:58.974841Z","end":"2026-02-25T15:09:59.225028Z","steps":["trace[1403185588] 'range keys from in-memory index tree'  (duration: 249.801895ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:59.225053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.660734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5115"}
{"level":"info","ts":"2026-02-25T15:09:59.225144Z","caller":"traceutil/trace.go:171","msg":"trace[157561727] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:945; }","duration":"248.775807ms","start":"2026-02-25T15:09:58.976343Z","end":"2026-02-25T15:09:59.225119Z","steps":["trace[157561727] 'range keys from in-memory index tree'  (duration: 248.519801ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:59.225558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.131248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:09:59.22558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.439249ms","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-02-25T15:09:59.225617Z","caller":"traceutil/trace.go:171","msg":"trace[1508252357] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:945; }","duration":"303.238071ms","start":"2026-02-25T15:09:58.922361Z","end":"2026-02-25T15:09:59.225599Z","steps":["trace[1508252357] 'count revisions from in-memory index tree'  (duration: 302.975114ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:09:59.225619Z","caller":"traceutil/trace.go:171","msg":"trace[1538740681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:945; }","duration":"302.49461ms","start":"2026-02-25T15:09:58.923113Z","end":"2026-02-25T15:09:59.225608Z","steps":["trace[1538740681] 'range keys from in-memory index tree'  (duration: 302.310436ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:59.225648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:58.92234Z","time spent":"303.299192ms","remote":"127.0.0.1:60528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:09:59.225653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:58.923101Z","time spent":"302.542172ms","remote":"127.0.0.1:40930","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-02-25T15:09:59.225688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.883328ms","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-02-25T15:09:59.225729Z","caller":"traceutil/trace.go:171","msg":"trace[1979962794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:945; }","duration":"374.95039ms","start":"2026-02-25T15:09:58.850768Z","end":"2026-02-25T15:09:59.225718Z","steps":["trace[1979962794] 'range keys from in-memory index tree'  (duration: 374.757105ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:59.225759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:58.850746Z","time spent":"375.004101ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T15:09:59.225877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.726818ms","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-02-25T15:09:59.225904Z","caller":"traceutil/trace.go:171","msg":"trace[1521279969] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:945; }","duration":"359.748389ms","start":"2026-02-25T15:09:58.866144Z","end":"2026-02-25T15:09:59.225893Z","steps":["trace[1521279969] 'range keys from in-memory index tree'  (duration: 359.660346ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:09:59.225932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:09:58.866118Z","time spent":"359.803951ms","remote":"127.0.0.1:40930","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":"info","ts":"2026-02-25T15:10:02.857866Z","caller":"traceutil/trace.go:171","msg":"trace[1392654835] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"111.067914ms","start":"2026-02-25T15:10:02.74677Z","end":"2026-02-25T15:10:02.857837Z","steps":["trace[1392654835] 'process raft request'  (duration: 110.91608ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:03.722283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.733904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:10:03.722374Z","caller":"traceutil/trace.go:171","msg":"trace[378696419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:962; }","duration":"438.897219ms","start":"2026-02-25T15:10:03.283454Z","end":"2026-02-25T15:10:03.722351Z","steps":["trace[378696419] 'range keys from in-memory index tree'  (duration: 438.587971ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:03.722437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:03.28341Z","time spent":"438.995832ms","remote":"127.0.0.1:50118","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-02-25T15:10:03.72234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.400505ms","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-02-25T15:10:03.722521Z","caller":"traceutil/trace.go:171","msg":"trace[400093955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:962; }","duration":"435.62106ms","start":"2026-02-25T15:10:03.286877Z","end":"2026-02-25T15:10:03.722498Z","steps":["trace[400093955] 'range keys from in-memory index tree'  (duration: 435.197449ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:03.722573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:03.286865Z","time spent":"435.694013ms","remote":"127.0.0.1:40930","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-02-25T15:10:03.722636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.521928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-02-25T15:10:03.722723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.626159ms","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-02-25T15:10:03.722765Z","caller":"traceutil/trace.go:171","msg":"trace[985153042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:962; }","duration":"439.703101ms","start":"2026-02-25T15:10:03.283051Z","end":"2026-02-25T15:10:03.722754Z","steps":["trace[985153042] 'range keys from in-memory index tree'  (duration: 439.489915ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:03.722792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:03.283028Z","time spent":"439.757423ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-25T15:10:03.722718Z","caller":"traceutil/trace.go:171","msg":"trace[539193196] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:962; }","duration":"435.646982ms","start":"2026-02-25T15:10:03.287049Z","end":"2026-02-25T15:10:03.722696Z","steps":["trace[539193196] 'range keys from in-memory index tree'  (duration: 435.292902ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:03.7229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:03.287042Z","time spent":"435.851567ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-25T15:10:03.722995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.769691ms","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-02-25T15:10:03.723041Z","caller":"traceutil/trace.go:171","msg":"trace[634393093] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:962; }","duration":"436.836814ms","start":"2026-02-25T15:10:03.28619Z","end":"2026-02-25T15:10:03.723027Z","steps":["trace[634393093] 'range keys from in-memory index tree'  (duration: 436.659719ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:03.723086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:03.286179Z","time spent":"436.886885ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-25T15:10:04.121131Z","caller":"traceutil/trace.go:171","msg":"trace[769550161] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"393.42561ms","start":"2026-02-25T15:10:03.727667Z","end":"2026-02-25T15:10:04.121092Z","steps":["trace[769550161] 'process raft request'  (duration: 393.184763ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:04.121317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:03.727643Z","time spent":"393.579573ms","remote":"127.0.0.1:40930","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:957 > 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-02-25T15:10:04.409171Z","caller":"traceutil/trace.go:171","msg":"trace[1270160633] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"680.691309ms","start":"2026-02-25T15:10:03.728447Z","end":"2026-02-25T15:10:04.409138Z","steps":["trace[1270160633] 'process raft request'  (duration: 680.649107ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:04.409209Z","caller":"traceutil/trace.go:171","msg":"trace[535824810] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"681.161821ms","start":"2026-02-25T15:10:03.728025Z","end":"2026-02-25T15:10:04.409187Z","steps":["trace[535824810] 'process raft request'  (duration: 680.901604ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:04.409339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:03.728005Z","time spent":"681.250314ms","remote":"127.0.0.1:40930","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:959 > 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-02-25T15:10:04.409393Z","caller":"traceutil/trace.go:171","msg":"trace[576899131] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"681.057468ms","start":"2026-02-25T15:10:03.728322Z","end":"2026-02-25T15:10:04.40938Z","steps":["trace[576899131] 'process raft request'  (duration: 680.736129ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:04.409338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:03.728438Z","time spent":"680.814532ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:960 > 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-02-25T15:10:04.409469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:03.728307Z","time spent":"681.126681ms","remote":"127.0.0.1:40930","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:958 > 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-02-25T15:10:05.658995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.078957ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9602409520740271744 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w.189785e6df8b8532\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w.189785e6df8b8532\" value_size:685 lease:379037483885495667 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:10:05.659094Z","caller":"traceutil/trace.go:171","msg":"trace[684266315] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1012; }","duration":"374.439217ms","start":"2026-02-25T15:10:05.284637Z","end":"2026-02-25T15:10:05.659076Z","steps":["trace[684266315] 'read index received'  (duration: 46.991µs)","trace[684266315] 'applied index is now lower than readState.Index'  (duration: 374.390656ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:10:05.65913Z","caller":"traceutil/trace.go:171","msg":"trace[998983412] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"623.257495ms","start":"2026-02-25T15:10:05.035825Z","end":"2026-02-25T15:10:05.659083Z","steps":["trace[998983412] 'process raft request'  (duration: 53.019433ms)","trace[998983412] 'compare'  (duration: 569.79808ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:10:05.659176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.533029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:10:05.659764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:05.035802Z","time spent":"623.42579ms","remote":"127.0.0.1:40760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w.189785e6df8b8532\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w.189785e6df8b8532\" value_size:685 lease:379037483885495667 >> failure:<>"}
{"level":"info","ts":"2026-02-25T15:10:05.659867Z","caller":"traceutil/trace.go:171","msg":"trace[862609951] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:970; }","duration":"375.197217ms","start":"2026-02-25T15:10:05.284591Z","end":"2026-02-25T15:10:05.659788Z","steps":["trace[862609951] 'agreement among raft nodes before linearized reading'  (duration: 374.531609ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:05.659974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:05.284567Z","time spent":"375.374792ms","remote":"127.0.0.1:50118","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-02-25T15:10:06.837026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.018442142s","expected-duration":"100ms","prefix":"","request":"header:<ID:9602409520740271745 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:927 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:10:06.837143Z","caller":"traceutil/trace.go:171","msg":"trace[2054562816] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"1.473320432s","start":"2026-02-25T15:10:05.363795Z","end":"2026-02-25T15:10:06.837116Z","steps":["trace[2054562816] 'process raft request'  (duration: 454.697125ms)","trace[2054562816] 'compare'  (duration: 1.018088763s)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:10:06.837242Z","caller":"traceutil/trace.go:171","msg":"trace[2142981412] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"1.17334445s","start":"2026-02-25T15:10:05.663874Z","end":"2026-02-25T15:10:06.837218Z","steps":["trace[2142981412] 'process raft request'  (duration: 1.173256388s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:06.837297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:05.363768Z","time spent":"1.473451386s","remote":"127.0.0.1:40930","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:927 > 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-02-25T15:10:06.837313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:05.663851Z","time spent":"1.173426332s","remote":"127.0.0.1:40760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w.189785e6df9af8cf\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w.189785e6df9af8cf\" value_size:712 lease:379037483885495667 >> failure:<>"}
{"level":"info","ts":"2026-02-25T15:10:06.837493Z","caller":"traceutil/trace.go:171","msg":"trace[1160993911] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"1.176513905s","start":"2026-02-25T15:10:05.660969Z","end":"2026-02-25T15:10:06.837483Z","steps":["trace[1160993911] 'read index received'  (duration: 157.542779ms)","trace[1160993911] 'applied index is now lower than readState.Index'  (duration: 1.018970056s)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:10:06.837652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.17668346s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:10:06.837678Z","caller":"traceutil/trace.go:171","msg":"trace[1239979264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"1.176739761s","start":"2026-02-25T15:10:05.660929Z","end":"2026-02-25T15:10:06.837669Z","steps":["trace[1239979264] 'agreement among raft nodes before linearized reading'  (duration: 1.176625408s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:06.837704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:05.660913Z","time spent":"1.176785503s","remote":"127.0.0.1:50124","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-02-25T15:10:06.838013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.967944ms","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-02-25T15:10:06.838049Z","caller":"traceutil/trace.go:171","msg":"trace[1458139450] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:972; }","duration":"712.404635ms","start":"2026-02-25T15:10:06.125636Z","end":"2026-02-25T15:10:06.83804Z","steps":["trace[1458139450] 'agreement among raft nodes before linearized reading'  (duration: 711.936093ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:06.838046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.492725ms","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-02-25T15:10:06.838072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:06.125611Z","time spent":"712.455967ms","remote":"127.0.0.1:40930","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-02-25T15:10:06.838081Z","caller":"traceutil/trace.go:171","msg":"trace[813246818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:972; }","duration":"279.551116ms","start":"2026-02-25T15:10:06.55852Z","end":"2026-02-25T15:10:06.838071Z","steps":["trace[813246818] 'agreement among raft nodes before linearized reading'  (duration: 279.435863ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:06.838135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.534286ms","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-02-25T15:10:06.838215Z","caller":"traceutil/trace.go:171","msg":"trace[1642138430] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:972; }","duration":"279.630349ms","start":"2026-02-25T15:10:06.558561Z","end":"2026-02-25T15:10:06.838191Z","steps":["trace[1642138430] 'agreement among raft nodes before linearized reading'  (duration: 279.387282ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:06.838263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.65405ms","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-02-25T15:10:06.838338Z","caller":"traceutil/trace.go:171","msg":"trace[1821062390] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:972; }","duration":"279.742762ms","start":"2026-02-25T15:10:06.558574Z","end":"2026-02-25T15:10:06.838316Z","steps":["trace[1821062390] 'agreement among raft nodes before linearized reading'  (duration: 279.543947ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:07.119846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.254044ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:10:07.119972Z","caller":"traceutil/trace.go:171","msg":"trace[263929068] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:973; }","duration":"116.403048ms","start":"2026-02-25T15:10:07.003546Z","end":"2026-02-25T15:10:07.119949Z","steps":["trace[263929068] 'range keys from in-memory index tree'  (duration: 116.237004ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:07.120518Z","caller":"traceutil/trace.go:171","msg":"trace[1464221324] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"277.588897ms","start":"2026-02-25T15:10:06.842911Z","end":"2026-02-25T15:10:07.1205Z","steps":["trace[1464221324] 'process raft request'  (duration: 195.22718ms)","trace[1464221324] 'compare'  (duration: 82.194102ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:10:07.120839Z","caller":"traceutil/trace.go:171","msg":"trace[1917916965] linearizableReadLoop","detail":"{readStateIndex:1019; appliedIndex:1015; }","duration":"275.051929ms","start":"2026-02-25T15:10:06.845764Z","end":"2026-02-25T15:10:07.120816Z","steps":["trace[1917916965] 'read index received'  (duration: 85.889293ms)","trace[1917916965] 'applied index is now lower than readState.Index'  (duration: 189.161686ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:10:07.12094Z","caller":"traceutil/trace.go:171","msg":"trace[448606815] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"277.870914ms","start":"2026-02-25T15:10:06.843034Z","end":"2026-02-25T15:10:07.120905Z","steps":["trace[448606815] 'process raft request'  (duration: 277.649108ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:07.121014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.222483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:10:07.121097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.340426ms","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-02-25T15:10:07.121095Z","caller":"traceutil/trace.go:171","msg":"trace[1932815078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:976; }","duration":"275.329116ms","start":"2026-02-25T15:10:06.845746Z","end":"2026-02-25T15:10:07.121075Z","steps":["trace[1932815078] 'agreement among raft nodes before linearized reading'  (duration: 275.162271ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:07.121132Z","caller":"traceutil/trace.go:171","msg":"trace[2131783104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:976; }","duration":"231.447379ms","start":"2026-02-25T15:10:06.889675Z","end":"2026-02-25T15:10:07.121123Z","steps":["trace[2131783104] 'agreement among raft nodes before linearized reading'  (duration: 231.260264ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:07.121334Z","caller":"traceutil/trace.go:171","msg":"trace[1244946021] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"277.869254ms","start":"2026-02-25T15:10:06.842999Z","end":"2026-02-25T15:10:07.120868Z","steps":["trace[1244946021] 'process raft request'  (duration: 277.461163ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:09.133418Z","caller":"traceutil/trace.go:171","msg":"trace[626549299] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"175.589359ms","start":"2026-02-25T15:10:08.957113Z","end":"2026-02-25T15:10:09.132702Z","steps":["trace[626549299] 'process raft request'  (duration: 175.324241ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:09.380177Z","caller":"traceutil/trace.go:171","msg":"trace[173940224] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"240.936145ms","start":"2026-02-25T15:10:09.13921Z","end":"2026-02-25T15:10:09.380146Z","steps":["trace[173940224] 'process raft request'  (duration: 240.699069ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:09.38043Z","caller":"traceutil/trace.go:171","msg":"trace[1032173113] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"239.688101ms","start":"2026-02-25T15:10:09.140729Z","end":"2026-02-25T15:10:09.380417Z","steps":["trace[1032173113] 'process raft request'  (duration: 239.375523ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:09.38041Z","caller":"traceutil/trace.go:171","msg":"trace[1413973265] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1024; }","duration":"221.19104ms","start":"2026-02-25T15:10:09.159186Z","end":"2026-02-25T15:10:09.380377Z","steps":["trace[1413973265] 'read index received'  (duration: 12.150658ms)","trace[1413973265] 'applied index is now lower than readState.Index'  (duration: 209.033612ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:10:09.380741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.505679ms","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-02-25T15:10:09.380781Z","caller":"traceutil/trace.go:171","msg":"trace[2133753726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:982; }","duration":"221.620112ms","start":"2026-02-25T15:10:09.159149Z","end":"2026-02-25T15:10:09.380769Z","steps":["trace[2133753726] 'agreement among raft nodes before linearized reading'  (duration: 221.330234ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:12.499731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9602409520740271809,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:10:12.819526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.46868ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9602409520740271810 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.189785e87e8574c3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.189785e87e8574c3\" value_size:626 lease:379037483885495667 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:10:12.819654Z","caller":"traceutil/trace.go:171","msg":"trace[311055260] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1050; }","duration":"820.380057ms","start":"2026-02-25T15:10:11.999262Z","end":"2026-02-25T15:10:12.819642Z","steps":["trace[311055260] 'read index received'  (duration: 652.808754ms)","trace[311055260] 'applied index is now lower than readState.Index'  (duration: 167.570703ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:10:12.819752Z","caller":"traceutil/trace.go:171","msg":"trace[730803967] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"821.709143ms","start":"2026-02-25T15:10:11.998033Z","end":"2026-02-25T15:10:12.819742Z","steps":["trace[730803967] 'process raft request'  (duration: 653.969696ms)","trace[730803967] 'compare'  (duration: 167.302006ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:10:12.819787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:11.998021Z","time spent":"821.750164ms","remote":"127.0.0.1:40760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":706,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.189785e87e8574c3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.189785e87e8574c3\" value_size:626 lease:379037483885495667 >> failure:<>"}
{"level":"info","ts":"2026-02-25T15:10:12.820003Z","caller":"traceutil/trace.go:171","msg":"trace[1316494467] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"818.579518ms","start":"2026-02-25T15:10:12.001416Z","end":"2026-02-25T15:10:12.819996Z","steps":["trace[1316494467] 'process raft request'  (duration: 818.184998ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:12.820044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:12.001378Z","time spent":"818.63889ms","remote":"127.0.0.1:40930","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/rbd-csi-ceph-com\" mod_revision:1006 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-02-25T15:10:12.820143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.87622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:10:12.82017Z","caller":"traceutil/trace.go:171","msg":"trace[1087568188] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1008; }","duration":"820.915842ms","start":"2026-02-25T15:10:11.999246Z","end":"2026-02-25T15:10:12.820162Z","steps":["trace[1087568188] 'agreement among raft nodes before linearized reading'  (duration: 820.878111ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:12.820197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:11.999238Z","time spent":"820.945752ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-25T15:10:12.820326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.308742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:10:12.820348Z","caller":"traceutil/trace.go:171","msg":"trace[696966733] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1008; }","duration":"537.367454ms","start":"2026-02-25T15:10:12.282975Z","end":"2026-02-25T15:10:12.820342Z","steps":["trace[696966733] 'agreement among raft nodes before linearized reading'  (duration: 537.324073ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:12.820367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:12.28294Z","time spent":"537.422085ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-25T15:10:12.820628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.73961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w\" ","response":"range_response_count:1 size:11609"}
{"level":"info","ts":"2026-02-25T15:10:12.820648Z","caller":"traceutil/trace.go:171","msg":"trace[1369756600] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w; range_end:; response_count:1; response_revision:1008; }","duration":"159.801252ms","start":"2026-02-25T15:10:12.660842Z","end":"2026-02-25T15:10:12.820644Z","steps":["trace[1369756600] 'agreement among raft nodes before linearized reading'  (duration: 159.670648ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:12.820734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.207192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:10:12.820846Z","caller":"traceutil/trace.go:171","msg":"trace[600157958] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1008; }","duration":"309.355147ms","start":"2026-02-25T15:10:12.511462Z","end":"2026-02-25T15:10:12.820817Z","steps":["trace[600157958] 'agreement among raft nodes before linearized reading'  (duration: 309.182442ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:12.820921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:12.511438Z","time spent":"309.46259ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-25T15:10:12.821119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.550638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:10:12.821182Z","caller":"traceutil/trace.go:171","msg":"trace[919215913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"537.662142ms","start":"2026-02-25T15:10:12.2835Z","end":"2026-02-25T15:10:12.821162Z","steps":["trace[919215913] 'agreement among raft nodes before linearized reading'  (duration: 537.569669ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:10:12.82123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:10:12.283471Z","time spent":"537.749804ms","remote":"127.0.0.1:50124","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-02-25T15:10:13.010107Z","caller":"traceutil/trace.go:171","msg":"trace[1884052067] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"180.767137ms","start":"2026-02-25T15:10:12.829298Z","end":"2026-02-25T15:10:13.010065Z","steps":["trace[1884052067] 'process raft request'  (duration: 94.848864ms)","trace[1884052067] 'compare'  (duration: 85.569194ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:10:13.010335Z","caller":"traceutil/trace.go:171","msg":"trace[251746047] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"176.401861ms","start":"2026-02-25T15:10:12.833897Z","end":"2026-02-25T15:10:13.010299Z","steps":["trace[251746047] 'process raft request'  (duration: 176.151714ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:13.010766Z","caller":"traceutil/trace.go:171","msg":"trace[1110374906] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"178.756665ms","start":"2026-02-25T15:10:12.831951Z","end":"2026-02-25T15:10:13.010707Z","steps":["trace[1110374906] 'process raft request'  (duration: 178.039315ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:10:13.010842Z","caller":"traceutil/trace.go:171","msg":"trace[928880719] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"173.876593ms","start":"2026-02-25T15:10:12.836944Z","end":"2026-02-25T15:10:13.010821Z","steps":["trace[928880719] 'process raft request'  (duration: 173.166603ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:12:03.797187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.471327ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9602409520740273158 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.19.213.65\" mod_revision:1480 > success:<request_put:<key:\"/registry/masterleases/199.19.213.65\" value_size:66 lease:379037483885497348 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.65\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:12:03.797408Z","caller":"traceutil/trace.go:171","msg":"trace[1362095539] transaction","detail":"{read_only:false; response_revision:1524; number_of_response:1; }","duration":"865.471691ms","start":"2026-02-25T15:12:02.931916Z","end":"2026-02-25T15:12:03.797388Z","steps":["trace[1362095539] 'process raft request'  (duration: 543.708366ms)","trace[1362095539] 'compare'  (duration: 321.340543ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:12:03.797503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:12:02.9319Z","time spent":"865.562003ms","remote":"127.0.0.1:40714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.19.213.65\" mod_revision:1480 > success:<request_put:<key:\"/registry/masterleases/199.19.213.65\" value_size:66 lease:379037483885497348 >> failure:<request_range:<key:\"/registry/masterleases/199.19.213.65\" > >"}
{"level":"warn","ts":"2026-02-25T15:12:03.797633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.480597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"}
{"level":"info","ts":"2026-02-25T15:12:03.797703Z","caller":"traceutil/trace.go:171","msg":"trace[480136596] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1524; }","duration":"820.59521ms","start":"2026-02-25T15:12:02.977091Z","end":"2026-02-25T15:12:03.797686Z","steps":["trace[480136596] 'agreement among raft nodes before linearized reading'  (duration: 820.374604ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:12:03.797729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:12:02.977075Z","time spent":"820.648841ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":645,"request content":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" "}
{"level":"info","ts":"2026-02-25T15:12:03.797737Z","caller":"traceutil/trace.go:171","msg":"trace[1640589377] linearizableReadLoop","detail":"{readStateIndex:1591; appliedIndex:1590; }","duration":"820.184548ms","start":"2026-02-25T15:12:02.977146Z","end":"2026-02-25T15:12:03.797331Z","steps":["trace[1640589377] 'read index received'  (duration: 498.461514ms)","trace[1640589377] 'applied index is now lower than readState.Index'  (duration: 321.721654ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:12:03.798077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.232833ms","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:528"}
{"level":"info","ts":"2026-02-25T15:12:03.79814Z","caller":"traceutil/trace.go:171","msg":"trace[1348267984] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1524; }","duration":"539.316876ms","start":"2026-02-25T15:12:03.258806Z","end":"2026-02-25T15:12:03.798123Z","steps":["trace[1348267984] 'agreement among raft nodes before linearized reading'  (duration: 539.157561ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:12:03.798181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:12:03.258786Z","time spent":"539.387947ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-25T15:12:03.798189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.813866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"}
{"level":"info","ts":"2026-02-25T15:12:03.798285Z","caller":"traceutil/trace.go:171","msg":"trace[1176047408] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1524; }","duration":"540.9813ms","start":"2026-02-25T15:12:03.257276Z","end":"2026-02-25T15:12:03.798257Z","steps":["trace[1176047408] 'agreement among raft nodes before linearized reading'  (duration: 540.692432ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:12:03.798346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:12:03.257234Z","time spent":"541.099133ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-25T15:12:03.798184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.37698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-02-25T15:12:03.798547Z","caller":"traceutil/trace.go:171","msg":"trace[1608486856] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1524; }","duration":"538.77338ms","start":"2026-02-25T15:12:03.259761Z","end":"2026-02-25T15:12:03.798535Z","steps":["trace[1608486856] 'agreement among raft nodes before linearized reading'  (duration: 538.267396ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:12:03.798587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:12:03.259712Z","time spent":"538.866993ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-02-25T15:12:03.798883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.141891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-25T15:12:03.798946Z","caller":"traceutil/trace.go:171","msg":"trace[1288024774] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1524; }","duration":"729.231283ms","start":"2026-02-25T15:12:03.069689Z","end":"2026-02-25T15:12:03.79892Z","steps":["trace[1288024774] 'agreement among raft nodes before linearized reading'  (duration: 728.220206ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:12:03.798984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:12:03.069668Z","time spent":"729.307915ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"info","ts":"2026-02-25T15:13:02.326591Z","caller":"traceutil/trace.go:171","msg":"trace[194123438] transaction","detail":"{read_only:false; response_revision:1793; number_of_response:1; }","duration":"107.459626ms","start":"2026-02-25T15:13:02.21898Z","end":"2026-02-25T15:13:02.32644Z","steps":["trace[194123438] 'process raft request'  (duration: 106.966992ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:13:24.945968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.014759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"}
{"level":"info","ts":"2026-02-25T15:13:24.946059Z","caller":"traceutil/trace.go:171","msg":"trace[1199861075] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1925; }","duration":"149.168542ms","start":"2026-02-25T15:13:24.796866Z","end":"2026-02-25T15:13:24.946034Z","steps":["trace[1199861075] 'range keys from in-memory index tree'  (duration: 148.731361ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:13:32.628509Z","caller":"traceutil/trace.go:171","msg":"trace[626659647] linearizableReadLoop","detail":"{readStateIndex:2044; appliedIndex:2043; }","duration":"341.212523ms","start":"2026-02-25T15:13:32.287266Z","end":"2026-02-25T15:13:32.628479Z","steps":["trace[626659647] 'read index received'  (duration: 340.997367ms)","trace[626659647] 'applied index is now lower than readState.Index'  (duration: 213.816µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:13:32.628636Z","caller":"traceutil/trace.go:171","msg":"trace[967657862] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"499.250694ms","start":"2026-02-25T15:13:32.129347Z","end":"2026-02-25T15:13:32.628598Z","steps":["trace[967657862] 'process raft request'  (duration: 498.925306ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:13:32.628712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.421879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:13:32.629279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:13:32.129309Z","time spent":"499.409049ms","remote":"127.0.0.1:40930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1903 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-25T15:13:32.628755Z","caller":"traceutil/trace.go:171","msg":"trace[1432200293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1959; }","duration":"341.513311ms","start":"2026-02-25T15:13:32.287228Z","end":"2026-02-25T15:13:32.628741Z","steps":["trace[1432200293] 'agreement among raft nodes before linearized reading'  (duration: 341.429389ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:13:32.629404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:13:32.287208Z","time spent":"342.18308ms","remote":"127.0.0.1:50118","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-02-25T15:13:40.843534Z","caller":"traceutil/trace.go:171","msg":"trace[1318900592] linearizableReadLoop","detail":"{readStateIndex:2092; appliedIndex:2089; }","duration":"125.077681ms","start":"2026-02-25T15:13:40.718432Z","end":"2026-02-25T15:13:40.843509Z","steps":["trace[1318900592] 'read index received'  (duration: 11.830526ms)","trace[1318900592] 'applied index is now lower than readState.Index'  (duration: 113.245885ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:13:40.843573Z","caller":"traceutil/trace.go:171","msg":"trace[1952484224] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"127.29422ms","start":"2026-02-25T15:13:40.716241Z","end":"2026-02-25T15:13:40.843535Z","steps":["trace[1952484224] 'process raft request'  (duration: 105.749814ms)","trace[1952484224] 'compare'  (duration: 21.007872ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:13:40.843682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.232305ms","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-02-25T15:13:40.843582Z","caller":"traceutil/trace.go:171","msg":"trace[1083609772] transaction","detail":"{read_only:false; response_revision:2005; number_of_response:1; }","duration":"126.281163ms","start":"2026-02-25T15:13:40.717273Z","end":"2026-02-25T15:13:40.843554Z","steps":["trace[1083609772] 'process raft request'  (duration: 126.133549ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:13:40.843713Z","caller":"traceutil/trace.go:171","msg":"trace[2048457107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2005; }","duration":"125.303917ms","start":"2026-02-25T15:13:40.7184Z","end":"2026-02-25T15:13:40.843703Z","steps":["trace[2048457107] 'agreement among raft nodes before linearized reading'  (duration: 125.197434ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:14:03.517466Z","caller":"traceutil/trace.go:171","msg":"trace[1425226083] linearizableReadLoop","detail":"{readStateIndex:2202; appliedIndex:2201; }","duration":"192.877341ms","start":"2026-02-25T15:14:03.324553Z","end":"2026-02-25T15:14:03.51743Z","steps":["trace[1425226083] 'read index received'  (duration: 192.618784ms)","trace[1425226083] 'applied index is now lower than readState.Index'  (duration: 256.707µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:14:03.517532Z","caller":"traceutil/trace.go:171","msg":"trace[1592609508] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"194.774732ms","start":"2026-02-25T15:14:03.322719Z","end":"2026-02-25T15:14:03.517494Z","steps":["trace[1592609508] 'process raft request'  (duration: 194.497785ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:14:03.517747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.16906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-02-25T15:14:03.51785Z","caller":"traceutil/trace.go:171","msg":"trace[1841410295] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:1; response_revision:2110; }","duration":"193.313943ms","start":"2026-02-25T15:14:03.324512Z","end":"2026-02-25T15:14:03.517826Z","steps":["trace[1841410295] 'agreement among raft nodes before linearized reading'  (duration: 193.082917ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:14:03.529543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.485765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-02-25T15:14:03.529666Z","caller":"traceutil/trace.go:171","msg":"trace[1807974701] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:2111; }","duration":"142.677181ms","start":"2026-02-25T15:14:03.386958Z","end":"2026-02-25T15:14:03.529635Z","steps":["trace[1807974701] 'agreement among raft nodes before linearized reading'  (duration: 142.423254ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:14:03.796436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.768642ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9602409520740275613 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:2103 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:449 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:14:03.796521Z","caller":"traceutil/trace.go:171","msg":"trace[1612514051] linearizableReadLoop","detail":"{readStateIndex:2205; appliedIndex:2204; }","duration":"188.173336ms","start":"2026-02-25T15:14:03.608335Z","end":"2026-02-25T15:14:03.796508Z","steps":["trace[1612514051] 'read index received'  (duration: 69.28384ms)","trace[1612514051] 'applied index is now lower than readState.Index'  (duration: 118.888406ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:14:03.796687Z","caller":"traceutil/trace.go:171","msg":"trace[678243488] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"222.476342ms","start":"2026-02-25T15:14:03.5742Z","end":"2026-02-25T15:14:03.796676Z","steps":["trace[678243488] 'process raft request'  (duration: 103.402962ms)","trace[678243488] 'compare'  (duration: 118.68439ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:14:03.796866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.434064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"}
{"level":"warn","ts":"2026-02-25T15:14:03.796858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.518906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-02-25T15:14:03.796894Z","caller":"traceutil/trace.go:171","msg":"trace[585691684] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:2113; }","duration":"142.520477ms","start":"2026-02-25T15:14:03.654366Z","end":"2026-02-25T15:14:03.796887Z","steps":["trace[585691684] 'agreement among raft nodes before linearized reading'  (duration: 142.442905ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:14:03.796909Z","caller":"traceutil/trace.go:171","msg":"trace[2143055268] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:2113; }","duration":"188.624578ms","start":"2026-02-25T15:14:03.608269Z","end":"2026-02-25T15:14:03.796894Z","steps":["trace[2143055268] 'agreement among raft nodes before linearized reading'  (duration: 188.525405ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:14:04.268893Z","caller":"traceutil/trace.go:171","msg":"trace[1224556226] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2207; }","duration":"135.146101ms","start":"2026-02-25T15:14:04.133723Z","end":"2026-02-25T15:14:04.268869Z","steps":["trace[1224556226] 'read index received'  (duration: 135.006737ms)","trace[1224556226] 'applied index is now lower than readState.Index'  (duration: 137.984µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:14:04.269018Z","caller":"traceutil/trace.go:171","msg":"trace[1603701857] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"135.722545ms","start":"2026-02-25T15:14:04.133284Z","end":"2026-02-25T15:14:04.269006Z","steps":["trace[1603701857] 'process raft request'  (duration: 135.417187ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:14:04.269235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.48861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-controller\" ","response":"range_response_count:1 size:201"}
{"level":"info","ts":"2026-02-25T15:14:04.269344Z","caller":"traceutil/trace.go:171","msg":"trace[227624326] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-controller; range_end:; response_count:1; response_revision:2116; }","duration":"135.632694ms","start":"2026-02-25T15:14:04.133687Z","end":"2026-02-25T15:14:04.269319Z","steps":["trace[227624326] 'agreement among raft nodes before linearized reading'  (duration: 135.453789ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:14:04.270726Z","caller":"traceutil/trace.go:171","msg":"trace[853806688] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"135.987612ms","start":"2026-02-25T15:14:04.134704Z","end":"2026-02-25T15:14:04.270692Z","steps":["trace[853806688] 'process raft request'  (duration: 135.90091ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:14:04.270748Z","caller":"traceutil/trace.go:171","msg":"trace[625950686] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"136.575358ms","start":"2026-02-25T15:14:04.134116Z","end":"2026-02-25T15:14:04.270692Z","steps":["trace[625950686] 'process raft request'  (duration: 136.359673ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:14:09.122213Z","caller":"traceutil/trace.go:171","msg":"trace[1709096839] linearizableReadLoop","detail":"{readStateIndex:2228; appliedIndex:2227; }","duration":"112.897514ms","start":"2026-02-25T15:14:09.009288Z","end":"2026-02-25T15:14:09.122186Z","steps":["trace[1709096839] 'read index received'  (duration: 112.669568ms)","trace[1709096839] 'applied index is now lower than readState.Index'  (duration: 226.986µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:14:09.122269Z","caller":"traceutil/trace.go:171","msg":"trace[740922737] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"115.476614ms","start":"2026-02-25T15:14:09.006766Z","end":"2026-02-25T15:14:09.122243Z","steps":["trace[740922737] 'process raft request'  (duration: 115.255198ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:14:09.180667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.351476ms","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-02-25T15:14:09.180743Z","caller":"traceutil/trace.go:171","msg":"trace[1586034075] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2135; }","duration":"171.48238ms","start":"2026-02-25T15:14:09.009242Z","end":"2026-02-25T15:14:09.180725Z","steps":["trace[1586034075] 'agreement among raft nodes before linearized reading'  (duration: 113.255995ms)","trace[1586034075] 'range keys from in-memory index tree'  (duration: 58.05739ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:14:09.180796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.546958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w\" ","response":"range_response_count:1 size:12535"}
{"level":"warn","ts":"2026-02-25T15:14:09.180667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.354576ms","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-02-25T15:14:09.180856Z","caller":"traceutil/trace.go:171","msg":"trace[685774476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2135; }","duration":"159.593562ms","start":"2026-02-25T15:14:09.021257Z","end":"2026-02-25T15:14:09.180851Z","steps":["trace[685774476] 'agreement among raft nodes before linearized reading'  (duration: 101.288715ms)","trace[685774476] 'range keys from in-memory index tree'  (duration: 57.963748ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:14:09.18087Z","caller":"traceutil/trace.go:171","msg":"trace[603469756] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w; range_end:; response_count:1; response_revision:2135; }","duration":"169.65592ms","start":"2026-02-25T15:14:09.01119Z","end":"2026-02-25T15:14:09.180846Z","steps":["trace[603469756] 'agreement among raft nodes before linearized reading'  (duration: 111.351973ms)","trace[603469756] 'range keys from in-memory index tree'  (duration: 58.078841ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:14:09.440678Z","caller":"traceutil/trace.go:171","msg":"trace[1482173201] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"255.743901ms","start":"2026-02-25T15:14:09.184909Z","end":"2026-02-25T15:14:09.440653Z","steps":["trace[1482173201] 'process raft request'  (duration: 192.602954ms)","trace[1482173201] 'compare'  (duration: 63.012583ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:14:09.440976Z","caller":"traceutil/trace.go:171","msg":"trace[851692102] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"255.431463ms","start":"2026-02-25T15:14:09.185536Z","end":"2026-02-25T15:14:09.440967Z","steps":["trace[851692102] 'process raft request'  (duration: 255.090284ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:14:09.440943Z","caller":"traceutil/trace.go:171","msg":"trace[434461599] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2228; }","duration":"251.065246ms","start":"2026-02-25T15:14:09.189831Z","end":"2026-02-25T15:14:09.440896Z","steps":["trace[434461599] 'read index received'  (duration: 77.207862ms)","trace[434461599] 'applied index is now lower than readState.Index'  (duration: 173.854144ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:14:09.441251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.156063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"}
{"level":"info","ts":"2026-02-25T15:14:09.441282Z","caller":"traceutil/trace.go:171","msg":"trace[1454745764] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2138; }","duration":"137.245276ms","start":"2026-02-25T15:14:09.304027Z","end":"2026-02-25T15:14:09.441273Z","steps":["trace[1454745764] 'agreement among raft nodes before linearized reading'  (duration: 137.111372ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:14:09.441269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.770213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-02-25T15:14:09.441331Z","caller":"traceutil/trace.go:171","msg":"trace[1907111667] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2138; }","duration":"136.868226ms","start":"2026-02-25T15:14:09.30444Z","end":"2026-02-25T15:14:09.441309Z","steps":["trace[1907111667] 'agreement among raft nodes before linearized reading'  (duration: 136.714552ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:14:09.441365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.503877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w\" ","response":"range_response_count:1 size:12535"}
{"level":"info","ts":"2026-02-25T15:14:09.441412Z","caller":"traceutil/trace.go:171","msg":"trace[2034304582] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-5d8ff44fc9-ht25w; range_end:; response_count:1; response_revision:2138; }","duration":"251.62584ms","start":"2026-02-25T15:14:09.189773Z","end":"2026-02-25T15:14:09.441398Z","steps":["trace[2034304582] 'agreement among raft nodes before linearized reading'  (duration: 251.347823ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:14:09.441605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.089292ms","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:528"}
{"level":"info","ts":"2026-02-25T15:14:09.44178Z","caller":"traceutil/trace.go:171","msg":"trace[382778684] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2138; }","duration":"137.239105ms","start":"2026-02-25T15:14:09.304452Z","end":"2026-02-25T15:14:09.441691Z","steps":["trace[382778684] 'agreement among raft nodes before linearized reading'  (duration: 136.724201ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:14:09.442859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.997152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:14:09.442992Z","caller":"traceutil/trace.go:171","msg":"trace[1752211572] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2138; }","duration":"136.165837ms","start":"2026-02-25T15:14:09.306794Z","end":"2026-02-25T15:14:09.44296Z","steps":["trace[1752211572] 'agreement among raft nodes before linearized reading'  (duration: 134.317988ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:14:12.056376Z","caller":"traceutil/trace.go:171","msg":"trace[855955436] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"159.87144ms","start":"2026-02-25T15:14:11.896475Z","end":"2026-02-25T15:14:12.056346Z","steps":["trace[855955436] 'process raft request'  (duration: 159.732636ms)"],"step_count":1}