{"level":"warn","ts":"2026-03-20T10:07:42.895455Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T10:07:42.895548Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-20T10:07:42.895603Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T10:07:42.89561Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]}
{"level":"info","ts":"2026-03-20T10:07:42.895628Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-20T10:07:42.896191Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]}
{"level":"info","ts":"2026-03-20T10:07:42.89625Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-20T10:07:42.953959Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"57.525673ms"}
{"level":"info","ts":"2026-03-20T10:07:42.991139Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"}
{"level":"info","ts":"2026-03-20T10:07:42.991271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"}
{"level":"info","ts":"2026-03-20T10:07:42.991307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"}
{"level":"info","ts":"2026-03-20T10:07:42.991327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-20T10:07:42.991349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"}
{"level":"info","ts":"2026-03-20T10:07:42.991486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"}
{"level":"warn","ts":"2026-03-20T10:07:43.003193Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-20T10:07:43.005622Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-20T10:07:43.008417Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-03-20T10:07:43.012567Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-20T10:07:43.012721Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-20T10:07:43.012893Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-20T10:07:43.013051Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-20T10:07:43.013067Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-20T10:07:43.01355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"}
{"level":"info","ts":"2026-03-20T10:07:43.013638Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]}
{"level":"info","ts":"2026-03-20T10:07:43.018661Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-20T10:07:43.018882Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"}
{"level":"info","ts":"2026-03-20T10:07:43.018933Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"}
{"level":"info","ts":"2026-03-20T10:07:43.019893Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-20T10:07:43.019938Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-20T10:07:43.992581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"}
{"level":"info","ts":"2026-03-20T10:07:43.992647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-20T10:07:43.992685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"}
{"level":"info","ts":"2026-03-20T10:07:43.992705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"}
{"level":"info","ts":"2026-03-20T10:07:43.992716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"}
{"level":"info","ts":"2026-03-20T10:07:43.992732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"}
{"level":"info","ts":"2026-03-20T10:07:43.992752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"}
{"level":"info","ts":"2026-03-20T10:07:43.993885Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-20T10:07:43.993928Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:07:43.993941Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T10:07:43.994216Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:07:43.99468Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-20T10:07:43.99475Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-20T10:07:43.995412Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:07:43.9955Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:07:43.995537Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T10:07:43.996863Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"}
{"level":"info","ts":"2026-03-20T10:07:43.998218Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-20T10:07:56.246858Z","caller":"traceutil/trace.go:171","msg":"trace[1151147271] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"175.2039ms","start":"2026-03-20T10:07:56.071619Z","end":"2026-03-20T10:07:56.246823Z","steps":["trace[1151147271] 'process raft request'  (duration: 174.844657ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:01.571925Z","caller":"traceutil/trace.go:171","msg":"trace[1040481920] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"136.815346ms","start":"2026-03-20T10:08:01.435093Z","end":"2026-03-20T10:08:01.571908Z","steps":["trace[1040481920] 'process raft request'  (duration: 136.714203ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:02.768171Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565819822936801,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:08:03.144393Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.119332095s","expected-duration":"1s"}
{"level":"warn","ts":"2026-03-20T10:08:03.624963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.761235707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"}
{"level":"info","ts":"2026-03-20T10:08:03.625088Z","caller":"traceutil/trace.go:171","msg":"trace[1220377733] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:449; }","duration":"1.761421434s","start":"2026-03-20T10:08:01.863644Z","end":"2026-03-20T10:08:03.625065Z","steps":["trace[1220377733] 'range keys from in-memory index tree'  (duration: 1.761052751s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:03.625139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:01.86359Z","time spent":"1.761537687s","remote":"127.0.0.1:38644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4345,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"warn","ts":"2026-03-20T10:08:04.06324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.555042ms","expected-duration":"100ms","prefix":"","request":"header:<ID:296565819822936802 > lease_revoke:<id:041d9d0ab71190e6>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:08:04.063411Z","caller":"traceutil/trace.go:171","msg":"trace[1940684006] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:466; }","duration":"1.796071589s","start":"2026-03-20T10:08:02.2673Z","end":"2026-03-20T10:08:04.063371Z","steps":["trace[1940684006] 'read index received'  (duration: 877.212466ms)","trace[1940684006] 'applied index is now lower than readState.Index'  (duration: 918.857683ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:08:04.06366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.796300776s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-03-20T10:08:04.063776Z","caller":"traceutil/trace.go:171","msg":"trace[1438578152] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:449; }","duration":"1.796482542s","start":"2026-03-20T10:08:02.267268Z","end":"2026-03-20T10:08:04.063751Z","steps":["trace[1438578152] 'agreement among raft nodes before linearized reading'  (duration: 1.796195903s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:04.063827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:02.267252Z","time spent":"1.796568185s","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-20T10:08:04.55949Z","caller":"traceutil/trace.go:171","msg":"trace[1612528880] linearizableReadLoop","detail":"{readStateIndex:468; appliedIndex:467; }","duration":"495.958996ms","start":"2026-03-20T10:08:04.063503Z","end":"2026-03-20T10:08:04.559462Z","steps":["trace[1612528880] 'read index received'  (duration: 495.771149ms)","trace[1612528880] 'applied index is now lower than readState.Index'  (duration: 186.807µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:08:04.55972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.283239182s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-20T10:08:04.559762Z","caller":"traceutil/trace.go:171","msg":"trace[1467604081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:450; }","duration":"2.283368196s","start":"2026-03-20T10:08:02.276384Z","end":"2026-03-20T10:08:04.559753Z","steps":["trace[1467604081] 'agreement among raft nodes before linearized reading'  (duration: 2.283173589s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:04.559738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.154329592s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:08:04.559798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:02.276353Z","time spent":"2.283437688s","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:08:04.559785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135756947s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:08:04.559817Z","caller":"traceutil/trace.go:171","msg":"trace[846792841] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:450; }","duration":"1.154463406s","start":"2026-03-20T10:08:03.405334Z","end":"2026-03-20T10:08:04.559797Z","steps":["trace[846792841] 'agreement among raft nodes before linearized reading'  (duration: 1.154296491s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:04.559874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:03.405313Z","time spent":"1.15455345s","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:08:04.560265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.525936548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-03-20T10:08:04.563335Z","caller":"traceutil/trace.go:171","msg":"trace[169621121] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:450; }","duration":"1.529449097s","start":"2026-03-20T10:08:03.033847Z","end":"2026-03-20T10:08:04.563296Z","steps":["trace[169621121] 'agreement among raft nodes before linearized reading'  (duration: 1.525867885s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:04.563418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:03.033827Z","time spent":"1.529552909s","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-20T10:08:04.563603Z","caller":"traceutil/trace.go:171","msg":"trace[835941906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:450; }","duration":"1.135900892s","start":"2026-03-20T10:08:03.42395Z","end":"2026-03-20T10:08:04.559851Z","steps":["trace[835941906] 'agreement among raft nodes before linearized reading'  (duration: 1.135729056s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:04.563707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:03.423928Z","time spent":"1.139740853s","remote":"127.0.0.1:38416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-20T10:08:04.5638Z","caller":"traceutil/trace.go:171","msg":"trace[1150702125] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"927.364662ms","start":"2026-03-20T10:08:03.632565Z","end":"2026-03-20T10:08:04.559929Z","steps":["trace[1150702125] 'process raft request'  (duration: 926.7221ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:04.564003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.844608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:08:04.564074Z","caller":"traceutil/trace.go:171","msg":"trace[189979108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:450; }","duration":"987.993444ms","start":"2026-03-20T10:08:03.576049Z","end":"2026-03-20T10:08:04.564042Z","steps":["trace[189979108] 'agreement among raft nodes before linearized reading'  (duration: 983.48391ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:04.56411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:03.576014Z","time spent":"988.086547ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-20T10:08:04.564901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:03.632538Z","time spent":"931.330486ms","remote":"127.0.0.1:38644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:311 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4249 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}
{"level":"warn","ts":"2026-03-20T10:08:05.070739Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565819822936806,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:08:05.197051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.290171ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:08:05.197178Z","caller":"traceutil/trace.go:171","msg":"trace[1510576999] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:450; }","duration":"605.444756ms","start":"2026-03-20T10:08:04.591712Z","end":"2026-03-20T10:08:05.197157Z","steps":["trace[1510576999] 'range keys from in-memory index tree'  (duration: 605.272311ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:05.362131Z","caller":"traceutil/trace.go:171","msg":"trace[1778240291] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"1.295097217s","start":"2026-03-20T10:08:04.067017Z","end":"2026-03-20T10:08:05.362114Z","steps":["trace[1778240291] 'process raft request'  (duration: 1.29486511s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:05.362255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:04.066987Z","time spent":"1.295200122s","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:416 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-20T10:08:05.372674Z","caller":"traceutil/trace.go:171","msg":"trace[1910574346] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"802.268275ms","start":"2026-03-20T10:08:04.570384Z","end":"2026-03-20T10:08:05.372652Z","steps":["trace[1910574346] 'process raft request'  (duration: 802.057828ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:05.372677Z","caller":"traceutil/trace.go:171","msg":"trace[1330242416] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"802.167252ms","start":"2026-03-20T10:08:04.570486Z","end":"2026-03-20T10:08:05.372653Z","steps":["trace[1330242416] 'process raft request'  (duration: 802.09036ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:05.372803Z","caller":"traceutil/trace.go:171","msg":"trace[896137942] linearizableReadLoop","detail":"{readStateIndex:472; appliedIndex:468; }","duration":"802.98317ms","start":"2026-03-20T10:08:04.569803Z","end":"2026-03-20T10:08:05.372786Z","steps":["trace[896137942] 'read index received'  (duration: 792.134104ms)","trace[896137942] 'applied index is now lower than readState.Index'  (duration: 10.848156ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:08:05.37283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:04.570482Z","time spent":"802.294306ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:418 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:08:05.372854Z","caller":"traceutil/trace.go:171","msg":"trace[1377050186] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"798.019461ms","start":"2026-03-20T10:08:04.574827Z","end":"2026-03-20T10:08:05.372847Z","steps":["trace[1377050186] 'process raft request'  (duration: 797.788964ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:05.372903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:04.574813Z","time spent":"798.067372ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:449 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-20T10:08:05.37295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.136865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"}
{"level":"info","ts":"2026-03-20T10:08:05.37299Z","caller":"traceutil/trace.go:171","msg":"trace[1455262304] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:454; }","duration":"803.193747ms","start":"2026-03-20T10:08:04.569787Z","end":"2026-03-20T10:08:05.372981Z","steps":["trace[1455262304] 'agreement among raft nodes before linearized reading'  (duration: 803.097604ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:05.373025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:04.569775Z","time spent":"803.243228ms","remote":"127.0.0.1:38644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4345,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"warn","ts":"2026-03-20T10:08:05.372799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:04.570374Z","time spent":"802.358229ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:448 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-20T10:08:05.373025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.700084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:08:05.373139Z","caller":"traceutil/trace.go:171","msg":"trace[825912284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:454; }","duration":"798.823368ms","start":"2026-03-20T10:08:04.5743Z","end":"2026-03-20T10:08:05.373124Z","steps":["trace[825912284] 'agreement among raft nodes before linearized reading'  (duration: 798.690724ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:05.37318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:04.574294Z","time spent":"798.87722ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-20T10:08:11.561208Z","caller":"traceutil/trace.go:171","msg":"trace[1540673714] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"160.002013ms","start":"2026-03-20T10:08:11.401182Z","end":"2026-03-20T10:08:11.561184Z","steps":["trace[1540673714] 'process raft request'  (duration: 159.860139ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:11.66301Z","caller":"traceutil/trace.go:171","msg":"trace[1834409697] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:485; }","duration":"245.958844ms","start":"2026-03-20T10:08:11.417008Z","end":"2026-03-20T10:08:11.662967Z","steps":["trace[1834409697] 'read index received'  (duration: 144.025658ms)","trace[1834409697] 'applied index is now lower than readState.Index'  (duration: 101.931816ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:08:11.663146Z","caller":"traceutil/trace.go:171","msg":"trace[1801967579] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"258.675675ms","start":"2026-03-20T10:08:11.404456Z","end":"2026-03-20T10:08:11.663132Z","steps":["trace[1801967579] 'process raft request'  (duration: 182.446709ms)","trace[1801967579] 'compare'  (duration: 75.814192ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:08:11.663251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.014426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T10:08:11.663326Z","caller":"traceutil/trace.go:171","msg":"trace[360907264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:468; }","duration":"246.123109ms","start":"2026-03-20T10:08:11.417184Z","end":"2026-03-20T10:08:11.663307Z","steps":["trace[360907264] 'agreement among raft nodes before linearized reading'  (duration: 245.986694ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:11.663457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.761226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:08:11.663489Z","caller":"traceutil/trace.go:171","msg":"trace[1240046870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:468; }","duration":"240.813948ms","start":"2026-03-20T10:08:11.422666Z","end":"2026-03-20T10:08:11.66348Z","steps":["trace[1240046870] 'agreement among raft nodes before linearized reading'  (duration: 240.769177ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:11.663443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.430919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-20T10:08:11.663597Z","caller":"traceutil/trace.go:171","msg":"trace[1631232580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:468; }","duration":"246.634055ms","start":"2026-03-20T10:08:11.416951Z","end":"2026-03-20T10:08:11.663585Z","steps":["trace[1631232580] 'agreement among raft nodes before linearized reading'  (duration: 246.394117ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:11.920419Z","caller":"traceutil/trace.go:171","msg":"trace[846134758] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"251.771332ms","start":"2026-03-20T10:08:11.668614Z","end":"2026-03-20T10:08:11.920385Z","steps":["trace[846134758] 'process raft request'  (duration: 251.557575ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:12.224588Z","caller":"traceutil/trace.go:171","msg":"trace[1641249971] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"203.880529ms","start":"2026-03-20T10:08:12.020681Z","end":"2026-03-20T10:08:12.224561Z","steps":["trace[1641249971] 'process raft request'  (duration: 203.548628ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:12.62594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.067365ms","expected-duration":"100ms","prefix":"","request":"header:<ID:296565819822936868 > lease_revoke:<id:041d9d0ab711928c>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:08:12.62627Z","caller":"traceutil/trace.go:171","msg":"trace[794552836] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"372.045071ms","start":"2026-03-20T10:08:12.254204Z","end":"2026-03-20T10:08:12.626249Z","steps":["trace[794552836] 'process raft request'  (duration: 371.833964ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:12.626397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:12.254185Z","time spent":"372.141335ms","remote":"127.0.0.1:38664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/cilium-operator\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/cilium-operator\" value_size:462 >> failure:<>"}
{"level":"info","ts":"2026-03-20T10:08:12.627458Z","caller":"traceutil/trace.go:171","msg":"trace[1959865726] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:492; }","duration":"202.796594ms","start":"2026-03-20T10:08:12.424636Z","end":"2026-03-20T10:08:12.627433Z","steps":["trace[1959865726] 'read index received'  (duration: 202.635448ms)","trace[1959865726] 'applied index is now lower than readState.Index'  (duration: 160.076µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:08:12.627856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.961279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:08:12.628056Z","caller":"traceutil/trace.go:171","msg":"trace[1167241480] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"373.462286ms","start":"2026-03-20T10:08:12.254293Z","end":"2026-03-20T10:08:12.627755Z","steps":["trace[1167241480] 'process raft request'  (duration: 373.044623ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:12.628139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:12.25427Z","time spent":"373.833688ms","remote":"127.0.0.1:38664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":505,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/cilium\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/cilium\" value_size:453 >> failure:<>"}
{"level":"info","ts":"2026-03-20T10:08:12.628164Z","caller":"traceutil/trace.go:171","msg":"trace[467881296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:473; }","duration":"203.357132ms","start":"2026-03-20T10:08:12.42454Z","end":"2026-03-20T10:08:12.627897Z","steps":["trace[467881296] 'agreement among raft nodes before linearized reading'  (duration: 202.986411ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:15.273995Z","caller":"traceutil/trace.go:171","msg":"trace[914909808] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"119.398271ms","start":"2026-03-20T10:08:15.154573Z","end":"2026-03-20T10:08:15.273971Z","steps":["trace[914909808] 'process raft request'  (duration: 119.260687ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:15.875288Z","caller":"traceutil/trace.go:171","msg":"trace[1341434286] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"180.784863ms","start":"2026-03-20T10:08:15.694485Z","end":"2026-03-20T10:08:15.87527Z","steps":["trace[1341434286] 'read index received'  (duration: 180.641579ms)","trace[1341434286] 'applied index is now lower than readState.Index'  (duration: 142.714µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:08:15.87533Z","caller":"traceutil/trace.go:171","msg":"trace[572567648] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"296.945832ms","start":"2026-03-20T10:08:15.578366Z","end":"2026-03-20T10:08:15.875312Z","steps":["trace[572567648] 'process raft request'  (duration: 296.800148ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:15.875407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.915908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:08:15.875443Z","caller":"traceutil/trace.go:171","msg":"trace[1015478200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"180.995891ms","start":"2026-03-20T10:08:15.694438Z","end":"2026-03-20T10:08:15.875434Z","steps":["trace[1015478200] 'agreement among raft nodes before linearized reading'  (duration: 180.927748ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:15.875469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.066473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T10:08:15.875501Z","caller":"traceutil/trace.go:171","msg":"trace[1356995422] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:510; }","duration":"141.099415ms","start":"2026-03-20T10:08:15.734395Z","end":"2026-03-20T10:08:15.875494Z","steps":["trace[1356995422] 'agreement among raft nodes before linearized reading'  (duration: 140.988822ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:22.399681Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565819822937012,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T10:08:22.81042Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.007920899s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T10:08:22.810859Z","caller":"traceutil/trace.go:171","msg":"trace[1658474295] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.008700561s","start":"2026-03-20T10:08:21.802121Z","end":"2026-03-20T10:08:22.810822Z","steps":["trace[1658474295] 'process raft request'  (duration: 1.008538807s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:22.811003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:21.802093Z","time spent":"1.008851836s","remote":"127.0.0.1:38644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-zzkdj\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-zzkdj\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-zzkdj\" > >"}
{"level":"info","ts":"2026-03-20T10:08:22.877879Z","caller":"traceutil/trace.go:171","msg":"trace[1520065468] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:570; }","duration":"979.07426ms","start":"2026-03-20T10:08:21.89878Z","end":"2026-03-20T10:08:22.877854Z","steps":["trace[1520065468] 'read index received'  (duration: 911.816222ms)","trace[1520065468] 'applied index is now lower than readState.Index'  (duration: 67.256528ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:08:22.878133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.619744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-20T10:08:22.878175Z","caller":"traceutil/trace.go:171","msg":"trace[1168447004] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:550; }","duration":"973.682827ms","start":"2026-03-20T10:08:21.90448Z","end":"2026-03-20T10:08:22.878163Z","steps":["trace[1168447004] 'agreement among raft nodes before linearized reading'  (duration: 973.510972ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:22.878148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.050275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:08:22.878216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:21.904428Z","time spent":"973.77859ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-20T10:08:22.878257Z","caller":"traceutil/trace.go:171","msg":"trace[1063831365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"455.168409ms","start":"2026-03-20T10:08:22.423066Z","end":"2026-03-20T10:08:22.878234Z","steps":["trace[1063831365] 'agreement among raft nodes before linearized reading'  (duration: 454.959873ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:22.878355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:22.423027Z","time spent":"455.295344ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T10:08:22.878455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.837401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-03-20T10:08:22.878476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.636168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-20T10:08:22.878571Z","caller":"traceutil/trace.go:171","msg":"trace[2142018327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:550; }","duration":"908.987894ms","start":"2026-03-20T10:08:21.969562Z","end":"2026-03-20T10:08:22.87855Z","steps":["trace[2142018327] 'agreement among raft nodes before linearized reading'  (duration: 908.555511ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:22.878689Z","caller":"traceutil/trace.go:171","msg":"trace[725199442] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:550; }","duration":"979.837955ms","start":"2026-03-20T10:08:21.898764Z","end":"2026-03-20T10:08:22.878602Z","steps":["trace[725199442] 'agreement among raft nodes before linearized reading'  (duration: 979.215186ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:22.878816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:21.898708Z","time spent":"980.034489ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T10:08:22.879333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.808567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:08:22.879409Z","caller":"traceutil/trace.go:171","msg":"trace[1308686252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:550; }","duration":"965.865799ms","start":"2026-03-20T10:08:21.913527Z","end":"2026-03-20T10:08:22.879393Z","steps":["trace[1308686252] 'agreement among raft nodes before linearized reading'  (duration: 964.609121ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:22.879354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:21.969546Z","time spent":"909.791049ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T10:08:22.879447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:21.913513Z","time spent":"965.921051ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-20T10:08:24.888325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.549632ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:08:24.888446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.464946263s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:08:24.888523Z","caller":"traceutil/trace.go:171","msg":"trace[2126330934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"1.465061626s","start":"2026-03-20T10:08:23.423442Z","end":"2026-03-20T10:08:24.888503Z","steps":["trace[2126330934] 'range keys from in-memory index tree'  (duration: 1.464874001s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:24.888493Z","caller":"traceutil/trace.go:171","msg":"trace[285762517] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:554; }","duration":"296.744517ms","start":"2026-03-20T10:08:24.591726Z","end":"2026-03-20T10:08:24.88847Z","steps":["trace[285762517] 'range keys from in-memory index tree'  (duration: 296.528431ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:08:24.888577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:23.423426Z","time spent":"1.465142618s","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-20T10:08:28.317889Z","caller":"traceutil/trace.go:171","msg":"trace[172387610] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"151.525188ms","start":"2026-03-20T10:08:28.166336Z","end":"2026-03-20T10:08:28.317861Z","steps":["trace[172387610] 'process raft request'  (duration: 151.355593ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:28.481103Z","caller":"traceutil/trace.go:171","msg":"trace[457799244] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"115.1403ms","start":"2026-03-20T10:08:28.365939Z","end":"2026-03-20T10:08:28.481079Z","steps":["trace[457799244] 'read index received'  (duration: 101.777451ms)","trace[457799244] 'applied index is now lower than readState.Index'  (duration: 13.361839ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:08:28.481134Z","caller":"traceutil/trace.go:171","msg":"trace[1622254367] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"159.443309ms","start":"2026-03-20T10:08:28.32167Z","end":"2026-03-20T10:08:28.481113Z","steps":["trace[1622254367] 'process raft request'  (duration: 146.054429ms)","trace[1622254367] 'compare'  (duration: 13.234625ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:08:28.48129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.329345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"}
{"level":"info","ts":"2026-03-20T10:08:28.481344Z","caller":"traceutil/trace.go:171","msg":"trace[1808954929] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:607; }","duration":"115.441518ms","start":"2026-03-20T10:08:28.365879Z","end":"2026-03-20T10:08:28.48132Z","steps":["trace[1808954929] 'agreement among raft nodes before linearized reading'  (duration: 115.291063ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:28.696708Z","caller":"traceutil/trace.go:171","msg":"trace[790959558] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"121.111133ms","start":"2026-03-20T10:08:28.575576Z","end":"2026-03-20T10:08:28.696687Z","steps":["trace[790959558] 'process raft request'  (duration: 78.095792ms)","trace[790959558] 'compare'  (duration: 42.909448ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:08:29.297623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.449647ms","expected-duration":"100ms","prefix":"","request":"header:<ID:296565819822937131 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/cilium-zzkdj.189e84caa531fb12\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-zzkdj.189e84caa531fb12\" value_size:636 lease:296565819822936316 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:08:29.297773Z","caller":"traceutil/trace.go:171","msg":"trace[9213635] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"175.342753ms","start":"2026-03-20T10:08:29.122412Z","end":"2026-03-20T10:08:29.297755Z","steps":["trace[9213635] 'process raft request'  (duration: 28.68211ms)","trace[9213635] 'compare'  (duration: 146.295962ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:08:29.379733Z","caller":"traceutil/trace.go:171","msg":"trace[1921346457] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"211.518199ms","start":"2026-03-20T10:08:29.168197Z","end":"2026-03-20T10:08:29.379716Z","steps":["trace[1921346457] 'process raft request'  (duration: 211.434027ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:29.499837Z","caller":"traceutil/trace.go:171","msg":"trace[1489509225] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"113.324828ms","start":"2026-03-20T10:08:29.386489Z","end":"2026-03-20T10:08:29.499814Z","steps":["trace[1489509225] 'process raft request'  (duration: 113.152142ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:29.637174Z","caller":"traceutil/trace.go:171","msg":"trace[879117509] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"128.818436ms","start":"2026-03-20T10:08:29.508317Z","end":"2026-03-20T10:08:29.637136Z","steps":["trace[879117509] 'process raft request'  (duration: 88.130989ms)","trace[879117509] 'compare'  (duration: 40.533402ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:08:30.287166Z","caller":"traceutil/trace.go:171","msg":"trace[2006696976] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"158.185661ms","start":"2026-03-20T10:08:30.128959Z","end":"2026-03-20T10:08:30.287145Z","steps":["trace[2006696976] 'process raft request'  (duration: 154.574507ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:41.388744Z","caller":"traceutil/trace.go:171","msg":"trace[1008762018] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"209.751872ms","start":"2026-03-20T10:08:41.17897Z","end":"2026-03-20T10:08:41.388722Z","steps":["trace[1008762018] 'process raft request'  (duration: 209.643139ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:41.436679Z","caller":"traceutil/trace.go:171","msg":"trace[705573251] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"257.523569ms","start":"2026-03-20T10:08:41.179134Z","end":"2026-03-20T10:08:41.436658Z","steps":["trace[705573251] 'process raft request'  (duration: 257.100817ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:41.436915Z","caller":"traceutil/trace.go:171","msg":"trace[262135204] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"256.622605ms","start":"2026-03-20T10:08:41.180278Z","end":"2026-03-20T10:08:41.4369Z","steps":["trace[262135204] 'process raft request'  (duration: 256.022998ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:08:45.260644Z","caller":"traceutil/trace.go:171","msg":"trace[1277711477] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"172.277325ms","start":"2026-03-20T10:08:45.088327Z","end":"2026-03-20T10:08:45.260604Z","steps":["trace[1277711477] 'process raft request'  (duration: 172.09343ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:11.601164Z","caller":"traceutil/trace.go:171","msg":"trace[74217732] linearizableReadLoop","detail":"{readStateIndex:878; appliedIndex:877; }","duration":"186.376794ms","start":"2026-03-20T10:09:11.414755Z","end":"2026-03-20T10:09:11.601132Z","steps":["trace[74217732] 'read index received'  (duration: 186.357444ms)","trace[74217732] 'applied index is now lower than readState.Index'  (duration: 18.48µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:09:11.601243Z","caller":"traceutil/trace.go:171","msg":"trace[745149148] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"204.15519ms","start":"2026-03-20T10:09:11.397083Z","end":"2026-03-20T10:09:11.601238Z","steps":["trace[745149148] 'process raft request'  (duration: 203.968435ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:11.601414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.65257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:09:11.601436Z","caller":"traceutil/trace.go:171","msg":"trace[1945452345] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:845; }","duration":"186.728502ms","start":"2026-03-20T10:09:11.414701Z","end":"2026-03-20T10:09:11.601429Z","steps":["trace[1945452345] 'agreement among raft nodes before linearized reading'  (duration: 186.681251ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:11.601481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.804197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:09:11.601656Z","caller":"traceutil/trace.go:171","msg":"trace[876191564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:845; }","duration":"179.999701ms","start":"2026-03-20T10:09:11.421592Z","end":"2026-03-20T10:09:11.601592Z","steps":["trace[876191564] 'agreement among raft nodes before linearized reading'  (duration: 179.747965ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:11.751441Z","caller":"traceutil/trace.go:171","msg":"trace[675127414] linearizableReadLoop","detail":"{readStateIndex:880; appliedIndex:879; }","duration":"127.24103ms","start":"2026-03-20T10:09:11.624176Z","end":"2026-03-20T10:09:11.751417Z","steps":["trace[675127414] 'read index received'  (duration: 65.133707ms)","trace[675127414] 'applied index is now lower than readState.Index'  (duration: 62.106443ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:09:11.751518Z","caller":"traceutil/trace.go:171","msg":"trace[454330972] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"128.43472ms","start":"2026-03-20T10:09:11.62303Z","end":"2026-03-20T10:09:11.751465Z","steps":["trace[454330972] 'process raft request'  (duration: 66.260384ms)","trace[454330972] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-controller-manager; req_size:487; } (duration: 62.021202ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:09:11.751702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.508747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-20T10:09:11.75179Z","caller":"traceutil/trace.go:171","msg":"trace[1905988878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:847; }","duration":"127.605379ms","start":"2026-03-20T10:09:11.624143Z","end":"2026-03-20T10:09:11.751748Z","steps":["trace[1905988878] 'agreement among raft nodes before linearized reading'  (duration: 127.360853ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:12.521416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.283036ms","expected-duration":"100ms","prefix":"","request":"header:<ID:296565819822937662 > lease_revoke:<id:041d9d0ab71195b6>","response":"size:28"}
{"level":"info","ts":"2026-03-20T10:09:25.873913Z","caller":"traceutil/trace.go:171","msg":"trace[1514778487] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"168.475377ms","start":"2026-03-20T10:09:25.705413Z","end":"2026-03-20T10:09:25.873889Z","steps":["trace[1514778487] 'process raft request'  (duration: 168.196472ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:25.873894Z","caller":"traceutil/trace.go:171","msg":"trace[1059162167] linearizableReadLoop","detail":"{readStateIndex:919; appliedIndex:918; }","duration":"161.302104ms","start":"2026-03-20T10:09:25.712561Z","end":"2026-03-20T10:09:25.873863Z","steps":["trace[1059162167] 'read index received'  (duration: 161.050219ms)","trace[1059162167] 'applied index is now lower than readState.Index'  (duration: 250.795µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:09:25.874085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.493319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:09:25.874142Z","caller":"traceutil/trace.go:171","msg":"trace[1048376731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:883; }","duration":"161.58156ms","start":"2026-03-20T10:09:25.712547Z","end":"2026-03-20T10:09:25.874129Z","steps":["trace[1048376731] 'agreement among raft nodes before linearized reading'  (duration: 161.407136ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:26.010222Z","caller":"traceutil/trace.go:171","msg":"trace[1365623598] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"132.308721ms","start":"2026-03-20T10:09:25.877892Z","end":"2026-03-20T10:09:26.010201Z","steps":["trace[1365623598] 'process raft request'  (duration: 39.500942ms)","trace[1365623598] 'compare'  (duration: 92.615825ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:09:26.010569Z","caller":"traceutil/trace.go:171","msg":"trace[1412504648] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"131.676328ms","start":"2026-03-20T10:09:25.878825Z","end":"2026-03-20T10:09:26.010502Z","steps":["trace[1412504648] 'process raft request'  (duration: 131.557845ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:26.010572Z","caller":"traceutil/trace.go:171","msg":"trace[198755257] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"131.974663ms","start":"2026-03-20T10:09:25.878571Z","end":"2026-03-20T10:09:26.010546Z","steps":["trace[198755257] 'process raft request'  (duration: 131.585414ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:42.349796Z","caller":"traceutil/trace.go:171","msg":"trace[1115452638] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"201.719493ms","start":"2026-03-20T10:09:42.14805Z","end":"2026-03-20T10:09:42.34977Z","steps":["trace[1115452638] 'process raft request'  (duration: 181.049281ms)","trace[1115452638] 'compare'  (duration: 20.394205ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:09:42.350411Z","caller":"traceutil/trace.go:171","msg":"trace[1418672200] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"202.266544ms","start":"2026-03-20T10:09:42.148123Z","end":"2026-03-20T10:09:42.35039Z","steps":["trace[1418672200] 'process raft request'  (duration: 201.535119ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:42.350557Z","caller":"traceutil/trace.go:171","msg":"trace[1759270270] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"199.31654ms","start":"2026-03-20T10:09:42.151227Z","end":"2026-03-20T10:09:42.350544Z","steps":["trace[1759270270] 'process raft request'  (duration: 199.064855ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:44.297047Z","caller":"traceutil/trace.go:171","msg":"trace[1253462912] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1005; }","duration":"106.596986ms","start":"2026-03-20T10:09:44.19041Z","end":"2026-03-20T10:09:44.297007Z","steps":["trace[1253462912] 'read index received'  (duration: 106.267489ms)","trace[1253462912] 'applied index is now lower than readState.Index'  (duration: 327.907µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:09:44.297086Z","caller":"traceutil/trace.go:171","msg":"trace[929049298] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"127.93636ms","start":"2026-03-20T10:09:44.16911Z","end":"2026-03-20T10:09:44.297047Z","steps":["trace[929049298] 'process raft request'  (duration: 127.674655ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:44.297436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.982974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-20T10:09:44.297526Z","caller":"traceutil/trace.go:171","msg":"trace[1224060264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:964; }","duration":"107.104836ms","start":"2026-03-20T10:09:44.190395Z","end":"2026-03-20T10:09:44.2975Z","steps":["trace[1224060264] 'agreement among raft nodes before linearized reading'  (duration: 106.766749ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:48.550368Z","caller":"traceutil/trace.go:171","msg":"trace[280856096] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"161.16789ms","start":"2026-03-20T10:09:48.389182Z","end":"2026-03-20T10:09:48.55035Z","steps":["trace[280856096] 'process raft request'  (duration: 161.051378ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:48.554222Z","caller":"traceutil/trace.go:171","msg":"trace[281404615] linearizableReadLoop","detail":"{readStateIndex:1024; appliedIndex:1022; }","duration":"162.059299ms","start":"2026-03-20T10:09:48.392148Z","end":"2026-03-20T10:09:48.554207Z","steps":["trace[281404615] 'read index received'  (duration: 158.082164ms)","trace[281404615] 'applied index is now lower than readState.Index'  (duration: 3.976405ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:09:48.554396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.220283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-20T10:09:48.554424Z","caller":"traceutil/trace.go:171","msg":"trace[1064053125] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:981; }","duration":"162.320405ms","start":"2026-03-20T10:09:48.392095Z","end":"2026-03-20T10:09:48.554416Z","steps":["trace[1064053125] 'agreement among raft nodes before linearized reading'  (duration: 162.177912ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:48.554667Z","caller":"traceutil/trace.go:171","msg":"trace[2046630812] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"164.981302ms","start":"2026-03-20T10:09:48.389633Z","end":"2026-03-20T10:09:48.554614Z","steps":["trace[2046630812] 'process raft request'  (duration: 164.512133ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:49.344787Z","caller":"traceutil/trace.go:171","msg":"trace[1468099162] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"165.551816ms","start":"2026-03-20T10:09:49.179206Z","end":"2026-03-20T10:09:49.344758Z","steps":["trace[1468099162] 'process raft request'  (duration: 165.363502ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:49.629565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.454171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:09:49.629657Z","caller":"traceutil/trace.go:171","msg":"trace[1471361303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"204.602956ms","start":"2026-03-20T10:09:49.425033Z","end":"2026-03-20T10:09:49.629636Z","steps":["trace[1471361303] 'range keys from in-memory index tree'  (duration: 204.36157ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:51.054838Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565819822938046,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T10:09:51.100126Z","caller":"traceutil/trace.go:171","msg":"trace[428247518] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1027; }","duration":"545.698644ms","start":"2026-03-20T10:09:50.554405Z","end":"2026-03-20T10:09:51.100104Z","steps":["trace[428247518] 'read index received'  (duration: 545.538971ms)","trace[428247518] 'applied index is now lower than readState.Index'  (duration: 158.223µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:09:51.100276Z","caller":"traceutil/trace.go:171","msg":"trace[1056508893] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"564.484727ms","start":"2026-03-20T10:09:50.535751Z","end":"2026-03-20T10:09:51.100236Z","steps":["trace[1056508893] 'process raft request'  (duration: 564.206011ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:51.100553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:09:50.535714Z","time spent":"564.68522ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:944 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-20T10:09:51.10057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.160723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-03-20T10:09:51.100644Z","caller":"traceutil/trace.go:171","msg":"trace[480540805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:985; }","duration":"546.280656ms","start":"2026-03-20T10:09:50.554339Z","end":"2026-03-20T10:09:51.10062Z","steps":["trace[480540805] 'agreement among raft nodes before linearized reading'  (duration: 546.052051ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:51.100684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:09:50.554321Z","time spent":"546.354528ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-20T10:09:51.100565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.768859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:09:51.100806Z","caller":"traceutil/trace.go:171","msg":"trace[474201604] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:985; }","duration":"542.101857ms","start":"2026-03-20T10:09:50.558695Z","end":"2026-03-20T10:09:51.100797Z","steps":["trace[474201604] 'agreement among raft nodes before linearized reading'  (duration: 541.724068ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:51.100835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:09:50.558663Z","time spent":"542.165417ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-20T10:09:51.266823Z","caller":"traceutil/trace.go:171","msg":"trace[101002507] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"166.630184ms","start":"2026-03-20T10:09:51.100149Z","end":"2026-03-20T10:09:51.266779Z","steps":["trace[101002507] 'process raft request'  (duration: 166.40862ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:51.327723Z","caller":"traceutil/trace.go:171","msg":"trace[292587764] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"221.593741ms","start":"2026-03-20T10:09:51.106097Z","end":"2026-03-20T10:09:51.327691Z","steps":["trace[292587764] 'process raft request'  (duration: 221.361165ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:51.327899Z","caller":"traceutil/trace.go:171","msg":"trace[1187801365] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"221.163861ms","start":"2026-03-20T10:09:51.106698Z","end":"2026-03-20T10:09:51.327862Z","steps":["trace[1187801365] 'process raft request'  (duration: 220.940086ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:51.745627Z","caller":"traceutil/trace.go:171","msg":"trace[175991626] linearizableReadLoop","detail":"{readStateIndex:1032; appliedIndex:1031; }","duration":"320.741461ms","start":"2026-03-20T10:09:51.424856Z","end":"2026-03-20T10:09:51.745598Z","steps":["trace[175991626] 'read index received'  (duration: 275.702498ms)","trace[175991626] 'applied index is now lower than readState.Index'  (duration: 45.037793ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:09:51.745776Z","caller":"traceutil/trace.go:171","msg":"trace[1542983747] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"391.681859ms","start":"2026-03-20T10:09:51.354068Z","end":"2026-03-20T10:09:51.74575Z","steps":["trace[1542983747] 'process raft request'  (duration: 346.614864ms)","trace[1542983747] 'compare'  (duration: 44.821399ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:09:51.745841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.973426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-20T10:09:51.745894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:09:51.354039Z","time spent":"391.783191ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:982 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:09:51.745894Z","caller":"traceutil/trace.go:171","msg":"trace[1480258119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:989; }","duration":"321.08727ms","start":"2026-03-20T10:09:51.424795Z","end":"2026-03-20T10:09:51.745882Z","steps":["trace[1480258119] 'agreement among raft nodes before linearized reading'  (duration: 320.970637ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:09:51.74603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:09:51.424769Z","time spent":"321.248412ms","remote":"127.0.0.1:38404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-20T10:09:52.438825Z","caller":"traceutil/trace.go:171","msg":"trace[620295879] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"199.642772ms","start":"2026-03-20T10:09:52.239159Z","end":"2026-03-20T10:09:52.438802Z","steps":["trace[620295879] 'process raft request'  (duration: 199.481758ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:58.725926Z","caller":"traceutil/trace.go:171","msg":"trace[1247925538] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"204.761068ms","start":"2026-03-20T10:09:58.521133Z","end":"2026-03-20T10:09:58.725894Z","steps":["trace[1247925538] 'process raft request'  (duration: 156.752515ms)","trace[1247925538] 'compare'  (duration: 47.87299ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:09:59.48339Z","caller":"traceutil/trace.go:171","msg":"trace[74066736] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"124.564902ms","start":"2026-03-20T10:09:59.358774Z","end":"2026-03-20T10:09:59.483339Z","steps":["trace[74066736] 'process raft request'  (duration: 124.318507ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:09:59.970992Z","caller":"traceutil/trace.go:171","msg":"trace[1774978758] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"165.35936ms","start":"2026-03-20T10:09:59.805608Z","end":"2026-03-20T10:09:59.970968Z","steps":["trace[1774978758] 'process raft request'  (duration: 165.241558ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:00.802376Z","caller":"traceutil/trace.go:171","msg":"trace[743472918] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"317.059502ms","start":"2026-03-20T10:10:00.485287Z","end":"2026-03-20T10:10:00.802347Z","steps":["trace[743472918] 'process raft request'  (duration: 316.889418ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:00.802524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:00.485252Z","time spent":"317.199665ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1013 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-20T10:10:01.245294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.603595ms","expected-duration":"100ms","prefix":"","request":"header:<ID:296565819822938142 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1014 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:10:01.245403Z","caller":"traceutil/trace.go:171","msg":"trace[717755285] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"439.995867ms","start":"2026-03-20T10:10:00.805388Z","end":"2026-03-20T10:10:01.245384Z","steps":["trace[717755285] 'process raft request'  (duration: 132.211248ms)","trace[717755285] 'compare'  (duration: 307.457722ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:01.245463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:00.805372Z","time spent":"440.064208ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1014 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:10:01.437433Z","caller":"traceutil/trace.go:171","msg":"trace[636907676] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"115.82184ms","start":"2026-03-20T10:10:01.321539Z","end":"2026-03-20T10:10:01.437361Z","steps":["trace[636907676] 'process raft request'  (duration: 80.788195ms)","trace[636907676] 'compare'  (duration: 34.665127ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:01.746891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.465841ms","expected-duration":"100ms","prefix":"","request":"header:<ID:296565819822938147 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1015 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:10:01.746995Z","caller":"traceutil/trace.go:171","msg":"trace[974529465] linearizableReadLoop","detail":"{readStateIndex:1066; appliedIndex:1065; }","duration":"259.811329ms","start":"2026-03-20T10:10:01.487165Z","end":"2026-03-20T10:10:01.746977Z","steps":["trace[974529465] 'read index received'  (duration: 114.079743ms)","trace[974529465] 'applied index is now lower than readState.Index'  (duration: 145.730356ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:01.747039Z","caller":"traceutil/trace.go:171","msg":"trace[1700550227] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"289.420212ms","start":"2026-03-20T10:10:01.457568Z","end":"2026-03-20T10:10:01.746988Z","steps":["trace[1700550227] 'process raft request'  (duration: 143.772526ms)","trace[1700550227] 'compare'  (duration: 145.215526ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:01.747133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.963233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T10:10:01.747173Z","caller":"traceutil/trace.go:171","msg":"trace[565402931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1021; }","duration":"260.018144ms","start":"2026-03-20T10:10:01.487144Z","end":"2026-03-20T10:10:01.747162Z","steps":["trace[565402931] 'agreement among raft nodes before linearized reading'  (duration: 259.880581ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:02.09216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.564429ms","expected-duration":"100ms","prefix":"","request":"header:<ID:296565819822938149 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1016 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T10:10:02.092265Z","caller":"traceutil/trace.go:171","msg":"trace[1102375182] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1066; }","duration":"116.937669ms","start":"2026-03-20T10:10:01.97531Z","end":"2026-03-20T10:10:02.092248Z","steps":["trace[1102375182] 'read index received'  (duration: 33.47µs)","trace[1102375182] 'applied index is now lower than readState.Index'  (duration: 116.902989ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T10:10:02.0924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.106743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T10:10:02.092408Z","caller":"traceutil/trace.go:171","msg":"trace[1070192802] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"340.311814ms","start":"2026-03-20T10:10:01.752066Z","end":"2026-03-20T10:10:02.092378Z","steps":["trace[1070192802] 'process raft request'  (duration: 184.442288ms)","trace[1070192802] 'compare'  (duration: 155.425307ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:02.092436Z","caller":"traceutil/trace.go:171","msg":"trace[814983443] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1022; }","duration":"117.180744ms","start":"2026-03-20T10:10:01.975246Z","end":"2026-03-20T10:10:02.092427Z","steps":["trace[814983443] 'agreement among raft nodes before linearized reading'  (duration: 117.049641ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:02.092547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:10:01.752044Z","time spent":"340.425006ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1016 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-20T10:10:03.301696Z","caller":"traceutil/trace.go:171","msg":"trace[2066858377] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"105.824612ms","start":"2026-03-20T10:10:03.195853Z","end":"2026-03-20T10:10:03.301677Z","steps":["trace[2066858377] 'process raft request'  (duration: 105.674098ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:03.942827Z","caller":"traceutil/trace.go:171","msg":"trace[1576618061] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"185.310073ms","start":"2026-03-20T10:10:03.757479Z","end":"2026-03-20T10:10:03.942789Z","steps":["trace[1576618061] 'process raft request'  (duration: 185.070218ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:06.281003Z","caller":"traceutil/trace.go:171","msg":"trace[1879274140] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1082; }","duration":"122.530697ms","start":"2026-03-20T10:10:06.158438Z","end":"2026-03-20T10:10:06.280969Z","steps":["trace[1879274140] 'read index received'  (duration: 122.292673ms)","trace[1879274140] 'applied index is now lower than readState.Index'  (duration: 236.374µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:06.281051Z","caller":"traceutil/trace.go:171","msg":"trace[697457089] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"126.818607ms","start":"2026-03-20T10:10:06.154196Z","end":"2026-03-20T10:10:06.281015Z","steps":["trace[697457089] 'process raft request'  (duration: 126.621213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:06.281255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.778323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver\" ","response":"range_response_count:1 size:679"}
{"level":"info","ts":"2026-03-20T10:10:06.281361Z","caller":"traceutil/trace.go:171","msg":"trace[1306311556] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver; range_end:; response_count:1; response_revision:1036; }","duration":"122.938547ms","start":"2026-03-20T10:10:06.158399Z","end":"2026-03-20T10:10:06.281337Z","steps":["trace[1306311556] 'agreement among raft nodes before linearized reading'  (duration: 122.711651ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:08.43488Z","caller":"traceutil/trace.go:171","msg":"trace[420997843] linearizableReadLoop","detail":"{readStateIndex:1091; appliedIndex:1090; }","duration":"131.446213ms","start":"2026-03-20T10:10:08.303409Z","end":"2026-03-20T10:10:08.434855Z","steps":["trace[420997843] 'read index received'  (duration: 129.763389ms)","trace[420997843] 'applied index is now lower than readState.Index'  (duration: 1.681704ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:08.434922Z","caller":"traceutil/trace.go:171","msg":"trace[792760603] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"131.956595ms","start":"2026-03-20T10:10:08.302945Z","end":"2026-03-20T10:10:08.434902Z","steps":["trace[792760603] 'process raft request'  (duration: 130.32526ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:08.435072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.645627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:1076"}
{"level":"info","ts":"2026-03-20T10:10:08.435123Z","caller":"traceutil/trace.go:171","msg":"trace[1624824906] range","detail":"{range_begin:/registry/clusterroles/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1043; }","duration":"131.736759ms","start":"2026-03-20T10:10:08.303369Z","end":"2026-03-20T10:10:08.435106Z","steps":["trace[1624824906] 'agreement among raft nodes before linearized reading'  (duration: 131.626217ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:12.550771Z","caller":"traceutil/trace.go:171","msg":"trace[1570469028] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"142.272029ms","start":"2026-03-20T10:10:12.408473Z","end":"2026-03-20T10:10:12.550745Z","steps":["trace[1570469028] 'read index received'  (duration: 142.026605ms)","trace[1570469028] 'applied index is now lower than readState.Index'  (duration: 244.084µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:12.550817Z","caller":"traceutil/trace.go:171","msg":"trace[1637294071] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"147.896405ms","start":"2026-03-20T10:10:12.402895Z","end":"2026-03-20T10:10:12.550792Z","steps":["trace[1637294071] 'process raft request'  (duration: 147.687181ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:12.550956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.465563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pv-protection-controller\" ","response":"range_response_count:1 size:771"}
{"level":"info","ts":"2026-03-20T10:10:12.550996Z","caller":"traceutil/trace.go:171","msg":"trace[41051321] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pv-protection-controller; range_end:; response_count:1; response_revision:1054; }","duration":"142.537985ms","start":"2026-03-20T10:10:12.408445Z","end":"2026-03-20T10:10:12.550983Z","steps":["trace[41051321] 'agreement among raft nodes before linearized reading'  (duration: 142.438723ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:12.551019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.709519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:10:12.551056Z","caller":"traceutil/trace.go:171","msg":"trace[1504484837] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1054; }","duration":"126.78296ms","start":"2026-03-20T10:10:12.424262Z","end":"2026-03-20T10:10:12.551045Z","steps":["trace[1504484837] 'agreement among raft nodes before linearized reading'  (duration: 126.708249ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:17.018369Z","caller":"traceutil/trace.go:171","msg":"trace[2047103933] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1115; }","duration":"155.819548ms","start":"2026-03-20T10:10:16.862507Z","end":"2026-03-20T10:10:17.018326Z","steps":["trace[2047103933] 'read index received'  (duration: 151.940448ms)","trace[2047103933] 'applied index is now lower than readState.Index'  (duration: 3.877819ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:17.018404Z","caller":"traceutil/trace.go:171","msg":"trace[1717619386] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"157.591945ms","start":"2026-03-20T10:10:16.860762Z","end":"2026-03-20T10:10:17.018354Z","steps":["trace[1717619386] 'process raft request'  (duration: 153.673225ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:17.018602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.068463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-03-20T10:10:17.018658Z","caller":"traceutil/trace.go:171","msg":"trace[1088192601] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1066; }","duration":"156.163275ms","start":"2026-03-20T10:10:16.862481Z","end":"2026-03-20T10:10:17.018644Z","steps":["trace[1088192601] 'agreement among raft nodes before linearized reading'  (duration: 156.016442ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:17.705054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.541827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-node-lease/\" range_end:\"/registry/rolebindings/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T10:10:17.70514Z","caller":"traceutil/trace.go:171","msg":"trace[1081792569] range","detail":"{range_begin:/registry/rolebindings/kube-node-lease/; range_end:/registry/rolebindings/kube-node-lease0; response_count:0; response_revision:1068; }","duration":"103.685469ms","start":"2026-03-20T10:10:17.601435Z","end":"2026-03-20T10:10:17.705121Z","steps":["trace[1081792569] 'range keys from in-memory index tree'  (duration: 103.448895ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:17.705243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.1726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/\" range_end:\"/registry/persistentvolumeclaims/default0\" limit:500 ","response":"range_response_count:1 size:1465"}
{"level":"info","ts":"2026-03-20T10:10:17.705333Z","caller":"traceutil/trace.go:171","msg":"trace[1434897476] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/; range_end:/registry/persistentvolumeclaims/default0; response_count:1; response_revision:1068; }","duration":"130.307663ms","start":"2026-03-20T10:10:17.575006Z","end":"2026-03-20T10:10:17.705314Z","steps":["trace[1434897476] 'range keys from in-memory index tree'  (duration: 129.995727ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:21.219111Z","caller":"traceutil/trace.go:171","msg":"trace[1231670193] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1127; }","duration":"145.051047ms","start":"2026-03-20T10:10:21.074044Z","end":"2026-03-20T10:10:21.219095Z","steps":["trace[1231670193] 'read index received'  (duration: 144.947675ms)","trace[1231670193] 'applied index is now lower than readState.Index'  (duration: 102.582µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T10:10:21.219205Z","caller":"traceutil/trace.go:171","msg":"trace[293164323] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"147.315924ms","start":"2026-03-20T10:10:21.071881Z","end":"2026-03-20T10:10:21.219197Z","steps":["trace[293164323] 'process raft request'  (duration: 147.114789ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T10:10:21.219454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.397484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:709"}
{"level":"info","ts":"2026-03-20T10:10:21.219481Z","caller":"traceutil/trace.go:171","msg":"trace[483497065] range","detail":"{range_begin:/registry/roles/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1078; }","duration":"145.446476ms","start":"2026-03-20T10:10:21.074026Z","end":"2026-03-20T10:10:21.219473Z","steps":["trace[483497065] 'agreement among raft nodes before linearized reading'  (duration: 145.385854ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T10:10:21.856544Z","caller":"traceutil/trace.go:171","msg":"trace[986009640] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"102.86285ms","start":"2026-03-20T10:10:21.753639Z","end":"2026-03-20T10:10:21.856501Z","steps":["trace[986009640] 'process raft request'  (duration: 102.531373ms)"],"step_count":1}