{"level":"warn","ts":"2026-03-11T21:37:46.168757Z","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-11T21:37:46.168843Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116: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-11T21:37:46.168919Z","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-11T21:37:46.168973Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]}
{"level":"info","ts":"2026-03-11T21:37:46.169008Z","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-11T21:37:46.169647Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]}
{"level":"info","ts":"2026-03-11T21:37:46.169746Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116: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-11T21:37:46.175005Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.027736ms"}
{"level":"info","ts":"2026-03-11T21:37:46.181178Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"}
{"level":"info","ts":"2026-03-11T21:37:46.181322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-11T21:37:46.18136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"}
{"level":"info","ts":"2026-03-11T21:37:46.181382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-11T21:37:46.181405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"}
{"level":"info","ts":"2026-03-11T21:37:46.181459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"}
{"level":"warn","ts":"2026-03-11T21:37:46.194125Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-11T21:37:46.19687Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-11T21:37:46.198263Z","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-11T21:37:46.200828Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-11T21:37:46.201071Z","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-11T21:37:46.201207Z","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-11T21:37:46.201224Z","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-11T21:37:46.201178Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-11T21:37:46.202686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"}
{"level":"info","ts":"2026-03-11T21:37:46.202909Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]}
{"level":"info","ts":"2026-03-11T21:37:46.207839Z","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-11T21:37:46.208027Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-11T21:37:46.208061Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-11T21:37:46.20814Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"}
{"level":"info","ts":"2026-03-11T21:37:46.208153Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"}
{"level":"info","ts":"2026-03-11T21:37:47.082461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-11T21:37:47.082528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-11T21:37:47.082575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"}
{"level":"info","ts":"2026-03-11T21:37:47.082602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"}
{"level":"info","ts":"2026-03-11T21:37:47.082628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"}
{"level":"info","ts":"2026-03-11T21:37:47.082656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"}
{"level":"info","ts":"2026-03-11T21:37:47.082674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"}
{"level":"info","ts":"2026-03-11T21:37:47.083755Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T21:37:47.084512Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-11T21:37:47.084525Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-11T21:37:47.084559Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-11T21:37:47.084772Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-11T21:37:47.084813Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-11T21:37:47.085413Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T21:37:47.08556Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T21:37:47.085611Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-11T21:37:47.087988Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-11T21:37:47.089056Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"}
{"level":"info","ts":"2026-03-11T21:37:48.556365Z","caller":"traceutil/trace.go:171","msg":"trace[557365013] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"198.898723ms","start":"2026-03-11T21:37:48.357445Z","end":"2026-03-11T21:37:48.556344Z","steps":["trace[557365013] 'process raft request'  (duration: 198.724599ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.560395Z","caller":"traceutil/trace.go:171","msg":"trace[1495580532] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"152.775493ms","start":"2026-03-11T21:37:48.407598Z","end":"2026-03-11T21:37:48.560374Z","steps":["trace[1495580532] 'process raft request'  (duration: 152.62146ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.560563Z","caller":"traceutil/trace.go:171","msg":"trace[1129719007] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"202.840504ms","start":"2026-03-11T21:37:48.357715Z","end":"2026-03-11T21:37:48.560556Z","steps":["trace[1129719007] 'process raft request'  (duration: 202.354413ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.560549Z","caller":"traceutil/trace.go:171","msg":"trace[238147344] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"151.614416ms","start":"2026-03-11T21:37:48.408904Z","end":"2026-03-11T21:37:48.560518Z","steps":["trace[238147344] 'process raft request'  (duration: 151.477723ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.560622Z","caller":"traceutil/trace.go:171","msg":"trace[1368566774] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"151.842441ms","start":"2026-03-11T21:37:48.408659Z","end":"2026-03-11T21:37:48.560502Z","steps":["trace[1368566774] 'process raft request'  (duration: 151.672677ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.560774Z","caller":"traceutil/trace.go:171","msg":"trace[602675608] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"152.64932ms","start":"2026-03-11T21:37:48.408114Z","end":"2026-03-11T21:37:48.560763Z","steps":["trace[602675608] 'process raft request'  (duration: 152.139988ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.560852Z","caller":"traceutil/trace.go:171","msg":"trace[1544061115] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"152.328073ms","start":"2026-03-11T21:37:48.408512Z","end":"2026-03-11T21:37:48.56084Z","steps":["trace[1544061115] 'process raft request'  (duration: 151.78946ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.5608Z","caller":"traceutil/trace.go:171","msg":"trace[1186868488] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"151.77996ms","start":"2026-03-11T21:37:48.408791Z","end":"2026-03-11T21:37:48.560571Z","steps":["trace[1186868488] 'process raft request'  (duration: 151.563085ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.561055Z","caller":"traceutil/trace.go:171","msg":"trace[1637543478] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"142.126076ms","start":"2026-03-11T21:37:48.418789Z","end":"2026-03-11T21:37:48.560915Z","steps":["trace[1637543478] 'process raft request'  (duration: 141.617034ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.561159Z","caller":"traceutil/trace.go:171","msg":"trace[887302242] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"202.627559ms","start":"2026-03-11T21:37:48.357842Z","end":"2026-03-11T21:37:48.56047Z","steps":["trace[887302242] 'read index received'  (duration: 198.463253ms)","trace[887302242] 'applied index is now lower than readState.Index'  (duration: 4.163336ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:37:48.561359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.033189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-11T21:37:48.561329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.393627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-11T21:37:48.561403Z","caller":"traceutil/trace.go:171","msg":"trace[1332552973] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"150.121542ms","start":"2026-03-11T21:37:48.41127Z","end":"2026-03-11T21:37:48.561392Z","steps":["trace[1332552973] 'agreement among raft nodes before linearized reading'  (duration: 150.03146ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:37:48.561551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.839541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-11T21:37:48.561417Z","caller":"traceutil/trace.go:171","msg":"trace[1148418331] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:10; }","duration":"203.569551ms","start":"2026-03-11T21:37:48.357831Z","end":"2026-03-11T21:37:48.561401Z","steps":["trace[1148418331] 'agreement among raft nodes before linearized reading'  (duration: 203.260884ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.561586Z","caller":"traceutil/trace.go:171","msg":"trace[1960341742] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"101.899383ms","start":"2026-03-11T21:37:48.459678Z","end":"2026-03-11T21:37:48.561578Z","steps":["trace[1960341742] 'agreement among raft nodes before linearized reading'  (duration: 101.853592ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:37:48.561701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.647621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-11T21:37:48.561733Z","caller":"traceutil/trace.go:171","msg":"trace[2091301996] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"149.691071ms","start":"2026-03-11T21:37:48.412035Z","end":"2026-03-11T21:37:48.561726Z","steps":["trace[2091301996] 'agreement among raft nodes before linearized reading'  (duration: 149.64908ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:37:48.56189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.425914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-11T21:37:48.561958Z","caller":"traceutil/trace.go:171","msg":"trace[1553891363] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:0; response_revision:10; }","duration":"155.514707ms","start":"2026-03-11T21:37:48.406436Z","end":"2026-03-11T21:37:48.56195Z","steps":["trace[1553891363] 'agreement among raft nodes before linearized reading'  (duration: 155.436635ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:37:48.562192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.796852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-11T21:37:48.562226Z","caller":"traceutil/trace.go:171","msg":"trace[1774219786] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"158.835674ms","start":"2026-03-11T21:37:48.403383Z","end":"2026-03-11T21:37:48.562219Z","steps":["trace[1774219786] 'agreement among raft nodes before linearized reading'  (duration: 158.784333ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:37:48.562243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.559861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-11T21:37:48.562349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.025866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-11T21:37:48.562463Z","caller":"traceutil/trace.go:171","msg":"trace[709119906] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"155.174998ms","start":"2026-03-11T21:37:48.407275Z","end":"2026-03-11T21:37:48.56245Z","steps":["trace[709119906] 'agreement among raft nodes before linearized reading'  (duration: 154.522563ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:37:48.562461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.835395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-11T21:37:48.562496Z","caller":"traceutil/trace.go:171","msg":"trace[1425768825] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"190.892227ms","start":"2026-03-11T21:37:48.371596Z","end":"2026-03-11T21:37:48.562488Z","steps":["trace[1425768825] 'agreement among raft nodes before linearized reading'  (duration: 189.681819ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:48.562421Z","caller":"traceutil/trace.go:171","msg":"trace[84971011] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"153.754676ms","start":"2026-03-11T21:37:48.408627Z","end":"2026-03-11T21:37:48.562382Z","steps":["trace[84971011] 'agreement among raft nodes before linearized reading'  (duration: 153.556611ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:37:50.582076Z","caller":"traceutil/trace.go:171","msg":"trace[1188089966] transaction","detail":"{read_only:false; response_revision:121; number_of_response:1; }","duration":"112.260594ms","start":"2026-03-11T21:37:50.469793Z","end":"2026-03-11T21:37:50.582054Z","steps":["trace[1188089966] 'process raft request'  (duration: 24.342415ms)","trace[1188089966] 'compare'  (duration: 87.813326ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:38:10.881882Z","caller":"traceutil/trace.go:171","msg":"trace[82046387] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"108.698992ms","start":"2026-03-11T21:38:10.773164Z","end":"2026-03-11T21:38:10.881863Z","steps":["trace[82046387] 'process raft request'  (duration: 108.565578ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:38:14.092817Z","caller":"traceutil/trace.go:171","msg":"trace[580329218] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"116.345669ms","start":"2026-03-11T21:38:13.97643Z","end":"2026-03-11T21:38:14.092775Z","steps":["trace[580329218] 'process raft request'  (duration: 116.187745ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:38:20.416744Z","caller":"traceutil/trace.go:171","msg":"trace[818483377] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"201.024622ms","start":"2026-03-11T21:38:20.215693Z","end":"2026-03-11T21:38:20.416717Z","steps":["trace[818483377] 'process raft request'  (duration: 200.718695ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:38:20.851175Z","caller":"traceutil/trace.go:171","msg":"trace[1890566120] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"425.269744ms","start":"2026-03-11T21:38:20.425881Z","end":"2026-03-11T21:38:20.851151Z","steps":["trace[1890566120] 'process raft request'  (duration: 425.137481ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:20.851933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:20.42586Z","time spent":"425.387697ms","remote":"127.0.0.1:53338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4567,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:412 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4533 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-03-11T21:38:27.065862Z","caller":"traceutil/trace.go:171","msg":"trace[448208344] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"100.426309ms","start":"2026-03-11T21:38:26.965412Z","end":"2026-03-11T21:38:27.065838Z","steps":["trace[448208344] 'process raft request'  (duration: 100.281286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:27.467879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.026668ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969069131221401 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-6t6qz\" mod_revision:506 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-6t6qz\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-6t6qz\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T21:38:27.467991Z","caller":"traceutil/trace.go:171","msg":"trace[467813840] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:553; }","duration":"298.984265ms","start":"2026-03-11T21:38:27.168991Z","end":"2026-03-11T21:38:27.467975Z","steps":["trace[467813840] 'read index received'  (duration: 130.681981ms)","trace[467813840] 'applied index is now lower than readState.Index'  (duration: 168.301004ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:38:27.468212Z","caller":"traceutil/trace.go:171","msg":"trace[395114848] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"384.791166ms","start":"2026-03-11T21:38:27.083271Z","end":"2026-03-11T21:38:27.468062Z","steps":["trace[395114848] 'process raft request'  (duration: 216.342958ms)","trace[395114848] 'compare'  (duration: 167.874855ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:38:27.468257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.263281ms","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-11T21:38:27.468293Z","caller":"traceutil/trace.go:171","msg":"trace[720083084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:536; }","duration":"299.367374ms","start":"2026-03-11T21:38:27.168915Z","end":"2026-03-11T21:38:27.468282Z","steps":["trace[720083084] 'agreement among raft nodes before linearized reading'  (duration: 299.153389ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:27.468371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:27.083248Z","time spent":"385.034581ms","remote":"127.0.0.1:53340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-6t6qz\" mod_revision:506 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-6t6qz\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-6t6qz\" > >"}
{"level":"warn","ts":"2026-03-11T21:38:27.468592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.527816ms","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-11T21:38:27.468718Z","caller":"traceutil/trace.go:171","msg":"trace[1165788728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:536; }","duration":"195.773152ms","start":"2026-03-11T21:38:27.272912Z","end":"2026-03-11T21:38:27.468685Z","steps":["trace[1165788728] 'agreement among raft nodes before linearized reading'  (duration: 195.343222ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:28.080686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.429363ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969069131221405 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:530 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T21:38:28.080823Z","caller":"traceutil/trace.go:171","msg":"trace[1673687256] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:555; }","duration":"143.666902ms","start":"2026-03-11T21:38:27.937115Z","end":"2026-03-11T21:38:28.080782Z","steps":["trace[1673687256] 'read index received'  (duration: 25.471µs)","trace[1673687256] 'applied index is now lower than readState.Index'  (duration: 143.639851ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:38:28.080922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.802565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T21:38:28.081031Z","caller":"traceutil/trace.go:171","msg":"trace[1827464799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:538; }","duration":"143.937178ms","start":"2026-03-11T21:38:27.937082Z","end":"2026-03-11T21:38:28.081019Z","steps":["trace[1827464799] 'agreement among raft nodes before linearized reading'  (duration: 143.797315ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:38:28.080875Z","caller":"traceutil/trace.go:171","msg":"trace[806409158] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"605.516945ms","start":"2026-03-11T21:38:27.47531Z","end":"2026-03-11T21:38:28.080827Z","steps":["trace[806409158] 'process raft request'  (duration: 124.757644ms)","trace[806409158] 'compare'  (duration: 479.41531ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:38:28.081292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:27.475276Z","time spent":"605.870373ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:530 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-11T21:38:29.064195Z","caller":"traceutil/trace.go:171","msg":"trace[2083212227] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"608.014661ms","start":"2026-03-11T21:38:28.456156Z","end":"2026-03-11T21:38:29.064171Z","steps":["trace[2083212227] 'process raft request'  (duration: 607.874408ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:29.064382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:28.456132Z","time spent":"608.131823ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:531 > 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-11T21:38:29.064493Z","caller":"traceutil/trace.go:171","msg":"trace[1470643172] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:557; }","duration":"126.589616ms","start":"2026-03-11T21:38:28.93789Z","end":"2026-03-11T21:38:29.06448Z","steps":["trace[1470643172] 'read index received'  (duration: 126.583166ms)","trace[1470643172] 'applied index is now lower than readState.Index'  (duration: 5.68µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:38:29.064546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.665628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T21:38:29.064573Z","caller":"traceutil/trace.go:171","msg":"trace[1031323518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:539; }","duration":"126.739109ms","start":"2026-03-11T21:38:28.937827Z","end":"2026-03-11T21:38:29.064566Z","steps":["trace[1031323518] 'agreement among raft nodes before linearized reading'  (duration: 126.696628ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:38:29.661096Z","caller":"traceutil/trace.go:171","msg":"trace[161830450] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"585.928248ms","start":"2026-03-11T21:38:29.075131Z","end":"2026-03-11T21:38:29.66106Z","steps":["trace[161830450] 'process raft request'  (duration: 585.666182ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:29.661363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:29.075121Z","time spent":"586.086652ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:535 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-11T21:38:29.661487Z","caller":"traceutil/trace.go:171","msg":"trace[1300959470] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:557; }","duration":"144.291887ms","start":"2026-03-11T21:38:29.517169Z","end":"2026-03-11T21:38:29.66146Z","steps":["trace[1300959470] 'read index received'  (duration: 143.696353ms)","trace[1300959470] 'applied index is now lower than readState.Index'  (duration: 594.124µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:38:29.661939Z","caller":"traceutil/trace.go:171","msg":"trace[1837790563] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"477.760089ms","start":"2026-03-11T21:38:29.184153Z","end":"2026-03-11T21:38:29.661913Z","steps":["trace[1837790563] 'process raft request'  (duration: 477.145145ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:29.661978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.784348ms","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-11T21:38:29.66202Z","caller":"traceutil/trace.go:171","msg":"trace[2017468461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:541; }","duration":"144.88371ms","start":"2026-03-11T21:38:29.517124Z","end":"2026-03-11T21:38:29.662007Z","steps":["trace[2017468461] 'agreement among raft nodes before linearized reading'  (duration: 144.633234ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:29.662111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:29.184051Z","time spent":"477.965324ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:514 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-03-11T21:38:31.52828Z","caller":"traceutil/trace.go:171","msg":"trace[804108043] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"308.033894ms","start":"2026-03-11T21:38:31.220222Z","end":"2026-03-11T21:38:31.528256Z","steps":["trace[804108043] 'process raft request'  (duration: 307.84775ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:31.528439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:31.220182Z","time spent":"308.191688ms","remote":"127.0.0.1:53214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" value_size:8170 >> failure:<>"}
{"level":"info","ts":"2026-03-11T21:38:31.530516Z","caller":"traceutil/trace.go:171","msg":"trace[944929395] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"105.050627ms","start":"2026-03-11T21:38:31.425439Z","end":"2026-03-11T21:38:31.530489Z","steps":["trace[944929395] 'process raft request'  (duration: 104.937644ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:38:43.328811Z","caller":"traceutil/trace.go:171","msg":"trace[364412987] linearizableReadLoop","detail":"{readStateIndex:737; appliedIndex:736; }","duration":"192.623438ms","start":"2026-03-11T21:38:43.136162Z","end":"2026-03-11T21:38:43.328785Z","steps":["trace[364412987] 'read index received'  (duration: 192.486175ms)","trace[364412987] 'applied index is now lower than readState.Index'  (duration: 136.263µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:38:43.328913Z","caller":"traceutil/trace.go:171","msg":"trace[1985598455] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"241.106342ms","start":"2026-03-11T21:38:43.087776Z","end":"2026-03-11T21:38:43.328882Z","steps":["trace[1985598455] 'process raft request'  (duration: 240.824556ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:43.329095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.918345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-11T21:38:43.32913Z","caller":"traceutil/trace.go:171","msg":"trace[684779417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:713; }","duration":"193.006497ms","start":"2026-03-11T21:38:43.136113Z","end":"2026-03-11T21:38:43.329119Z","steps":["trace[684779417] 'agreement among raft nodes before linearized reading'  (duration: 192.819702ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:43.329925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.862529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-lgj5m\" ","response":"range_response_count:1 size:4884"}
{"level":"info","ts":"2026-03-11T21:38:43.329989Z","caller":"traceutil/trace.go:171","msg":"trace[157532365] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-lgj5m; range_end:; response_count:1; response_revision:714; }","duration":"151.029793ms","start":"2026-03-11T21:38:43.178943Z","end":"2026-03-11T21:38:43.329973Z","steps":["trace[157532365] 'agreement among raft nodes before linearized reading'  (duration: 150.837398ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:38:43.330154Z","caller":"traceutil/trace.go:171","msg":"trace[1759858033] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"150.318227ms","start":"2026-03-11T21:38:43.179828Z","end":"2026-03-11T21:38:43.330147Z","steps":["trace[1759858033] 'process raft request'  (duration: 149.869186ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:49.775769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.350371ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969069131221789 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:732 > 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-11T21:38:49.776133Z","caller":"traceutil/trace.go:171","msg":"trace[1931940985] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"419.382524ms","start":"2026-03-11T21:38:49.356588Z","end":"2026-03-11T21:38:49.775971Z","steps":["trace[1931940985] 'process raft request'  (duration: 315.750557ms)","trace[1931940985] 'compare'  (duration: 103.246568ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:38:49.776353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:49.35658Z","time spent":"419.680381ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:732 > 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-11T21:38:50.121394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.321604ms","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-11T21:38:50.121598Z","caller":"traceutil/trace.go:171","msg":"trace[217171211] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:737; }","duration":"177.562869ms","start":"2026-03-11T21:38:49.944006Z","end":"2026-03-11T21:38:50.121569Z","steps":["trace[217171211] 'range keys from in-memory index tree'  (duration: 177.243252ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:38:50.177938Z","caller":"traceutil/trace.go:171","msg":"trace[132584871] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"398.075525ms","start":"2026-03-11T21:38:49.779835Z","end":"2026-03-11T21:38:50.17791Z","steps":["trace[132584871] 'process raft request'  (duration: 397.901261ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:38:50.177967Z","caller":"traceutil/trace.go:171","msg":"trace[992080943] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:763; }","duration":"370.95693ms","start":"2026-03-11T21:38:49.806958Z","end":"2026-03-11T21:38:50.177915Z","steps":["trace[992080943] 'read index received'  (duration: 370.930339ms)","trace[992080943] 'applied index is now lower than readState.Index'  (duration: 23.041µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:38:50.178177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.195885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-11T21:38:50.178188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:49.779808Z","time spent":"398.27101ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:733 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-11T21:38:50.178248Z","caller":"traceutil/trace.go:171","msg":"trace[755732836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:738; }","duration":"371.321968ms","start":"2026-03-11T21:38:49.80691Z","end":"2026-03-11T21:38:50.178232Z","steps":["trace[755732836] 'agreement among raft nodes before linearized reading'  (duration: 371.094193ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:50.1783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:49.806897Z","time spent":"371.39158ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-11T21:38:50.367523Z","caller":"traceutil/trace.go:171","msg":"trace[469419344] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:763; }","duration":"171.510048ms","start":"2026-03-11T21:38:50.195974Z","end":"2026-03-11T21:38:50.367484Z","steps":["trace[469419344] 'read index received'  (duration: 3.43118ms)","trace[469419344] 'applied index is now lower than readState.Index'  (duration: 168.077248ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:38:50.367661Z","caller":"traceutil/trace.go:171","msg":"trace[1512293319] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"185.142017ms","start":"2026-03-11T21:38:50.182474Z","end":"2026-03-11T21:38:50.367616Z","steps":["trace[1512293319] 'process raft request'  (duration: 127.183669ms)","trace[1512293319] 'compare'  (duration: 57.658771ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:38:50.367902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.885786ms","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-11T21:38:50.367958Z","caller":"traceutil/trace.go:171","msg":"trace[1583399557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:740; }","duration":"172.022539ms","start":"2026-03-11T21:38:50.195922Z","end":"2026-03-11T21:38:50.367944Z","steps":["trace[1583399557] 'agreement among raft nodes before linearized reading'  (duration: 171.764213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:51.802654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.02554ms","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-11T21:38:51.802719Z","caller":"traceutil/trace.go:171","msg":"trace[1997842599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:742; }","duration":"382.145402ms","start":"2026-03-11T21:38:51.420558Z","end":"2026-03-11T21:38:51.802703Z","steps":["trace[1997842599] 'range keys from in-memory index tree'  (duration: 381.843055ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:38:51.80275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:38:51.420538Z","time spent":"382.203733ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-11T21:39:14.13722Z","caller":"traceutil/trace.go:171","msg":"trace[2067368517] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"151.829137ms","start":"2026-03-11T21:39:13.985359Z","end":"2026-03-11T21:39:14.137189Z","steps":["trace[2067368517] 'process raft request'  (duration: 139.258692ms)","trace[2067368517] 'compare'  (duration: 12.423231ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:39:15.161868Z","caller":"traceutil/trace.go:171","msg":"trace[667131428] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:845; }","duration":"219.908311ms","start":"2026-03-11T21:39:14.941932Z","end":"2026-03-11T21:39:15.16184Z","steps":["trace[667131428] 'read index received'  (duration: 219.712656ms)","trace[667131428] 'applied index is now lower than readState.Index'  (duration: 194.495µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:39:15.161918Z","caller":"traceutil/trace.go:171","msg":"trace[825515349] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"261.064386ms","start":"2026-03-11T21:39:14.900823Z","end":"2026-03-11T21:39:15.161888Z","steps":["trace[825515349] 'process raft request'  (duration: 260.8264ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:15.162009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.050185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T21:39:15.162053Z","caller":"traceutil/trace.go:171","msg":"trace[1126946784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:815; }","duration":"220.117566ms","start":"2026-03-11T21:39:14.941922Z","end":"2026-03-11T21:39:15.16204Z","steps":["trace[1126946784] 'agreement among raft nodes before linearized reading'  (duration: 220.027534ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:16.763297Z","caller":"traceutil/trace.go:171","msg":"trace[1783269903] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"110.017487ms","start":"2026-03-11T21:39:16.653258Z","end":"2026-03-11T21:39:16.763276Z","steps":["trace[1783269903] 'process raft request'  (duration: 109.918345ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:18.323382Z","caller":"traceutil/trace.go:171","msg":"trace[1810628138] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"248.055481ms","start":"2026-03-11T21:39:18.075267Z","end":"2026-03-11T21:39:18.323322Z","steps":["trace[1810628138] 'process raft request'  (duration: 247.616281ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:18.549366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.654284ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969069131222032 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:817 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T21:39:18.549493Z","caller":"traceutil/trace.go:171","msg":"trace[1971174822] linearizableReadLoop","detail":"{readStateIndex:854; appliedIndex:853; }","duration":"129.257628ms","start":"2026-03-11T21:39:18.420215Z","end":"2026-03-11T21:39:18.549473Z","steps":["trace[1971174822] 'read index received'  (duration: 70.062µs)","trace[1971174822] 'applied index is now lower than readState.Index'  (duration: 129.186256ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:39:18.549706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.470493ms","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-11T21:39:18.549896Z","caller":"traceutil/trace.go:171","msg":"trace[673023585] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"220.901144ms","start":"2026-03-11T21:39:18.328607Z","end":"2026-03-11T21:39:18.549509Z","steps":["trace[673023585] 'process raft request'  (duration: 83.002104ms)","trace[673023585] 'compare'  (duration: 137.527761ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:39:18.549952Z","caller":"traceutil/trace.go:171","msg":"trace[937580258] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:822; }","duration":"129.77799ms","start":"2026-03-11T21:39:18.420141Z","end":"2026-03-11T21:39:18.549919Z","steps":["trace[937580258] 'agreement among raft nodes before linearized reading'  (duration: 129.37999ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:31.170349Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969069131222219,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-11T21:39:31.321563Z","caller":"traceutil/trace.go:171","msg":"trace[1544573749] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"713.806471ms","start":"2026-03-11T21:39:30.607737Z","end":"2026-03-11T21:39:31.321543Z","steps":["trace[1544573749] 'process raft request'  (duration: 713.690348ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:31.32169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:30.607701Z","time spent":"713.920314ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:901 > 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-11T21:39:31.66838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.326864ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969069131222221 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:830 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T21:39:31.66848Z","caller":"traceutil/trace.go:171","msg":"trace[1321977909] linearizableReadLoop","detail":"{readStateIndex:943; appliedIndex:941; }","duration":"998.690642ms","start":"2026-03-11T21:39:30.669775Z","end":"2026-03-11T21:39:31.668466Z","steps":["trace[1321977909] 'read index received'  (duration: 651.726616ms)","trace[1321977909] 'applied index is now lower than readState.Index'  (duration: 346.962806ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:39:31.668865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.879968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-11T21:39:31.668893Z","caller":"traceutil/trace.go:171","msg":"trace[1708573000] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:907; }","duration":"493.934649ms","start":"2026-03-11T21:39:31.174951Z","end":"2026-03-11T21:39:31.668886Z","steps":["trace[1708573000] 'agreement among raft nodes before linearized reading'  (duration: 493.822807ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:31.668868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.630091ms","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-11T21:39:31.66897Z","caller":"traceutil/trace.go:171","msg":"trace[996357258] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"795.33499ms","start":"2026-03-11T21:39:30.873626Z","end":"2026-03-11T21:39:31.668961Z","steps":["trace[996357258] 'process raft request'  (duration: 690.32573ms)","trace[996357258] 'compare'  (duration: 104.099429ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:39:31.669024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:30.873599Z","time spent":"795.389781ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:830 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-03-11T21:39:31.669002Z","caller":"traceutil/trace.go:171","msg":"trace[1048597188] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:907; }","duration":"992.774184ms","start":"2026-03-11T21:39:30.676204Z","end":"2026-03-11T21:39:31.668978Z","steps":["trace[1048597188] 'agreement among raft nodes before linearized reading'  (duration: 992.497738ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:31.669054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.146016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-11T21:39:31.669113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:30.676156Z","time spent":"992.940758ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-11T21:39:31.669129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.751951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-11T21:39:31.669156Z","caller":"traceutil/trace.go:171","msg":"trace[6480028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:907; }","duration":"731.279039ms","start":"2026-03-11T21:39:30.937856Z","end":"2026-03-11T21:39:31.669135Z","steps":["trace[6480028] 'agreement among raft nodes before linearized reading'  (duration: 731.056884ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:31.669189Z","caller":"traceutil/trace.go:171","msg":"trace[584737542] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:907; }","duration":"810.859943ms","start":"2026-03-11T21:39:30.858311Z","end":"2026-03-11T21:39:31.669171Z","steps":["trace[584737542] 'agreement among raft nodes before linearized reading'  (duration: 810.690659ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:31.669211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:30.937787Z","time spent":"731.413603ms","remote":"127.0.0.1:53140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-11T21:39:31.669241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:30.858283Z","time spent":"810.946615ms","remote":"127.0.0.1:53400","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-11T21:39:31.668918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:31.174934Z","time spent":"493.97801ms","remote":"127.0.0.1:53186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.116\" "}
{"level":"warn","ts":"2026-03-11T21:39:31.669204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"999.439651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-03-11T21:39:31.669365Z","caller":"traceutil/trace.go:171","msg":"trace[1936195037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:907; }","duration":"999.639755ms","start":"2026-03-11T21:39:30.669712Z","end":"2026-03-11T21:39:31.669351Z","steps":["trace[1936195037] 'agreement among raft nodes before linearized reading'  (duration: 999.43826ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:31.66942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:30.669671Z","time spent":"999.729287ms","remote":"127.0.0.1:53400","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-11T21:39:31.669507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.480071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T21:39:31.669556Z","caller":"traceutil/trace.go:171","msg":"trace[1287376025] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:907; }","duration":"593.573104ms","start":"2026-03-11T21:39:31.075965Z","end":"2026-03-11T21:39:31.669538Z","steps":["trace[1287376025] 'agreement among raft nodes before linearized reading'  (duration: 593.481751ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:31.669598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:31.075943Z","time spent":"593.642915ms","remote":"127.0.0.1:53266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":6,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "}
{"level":"warn","ts":"2026-03-11T21:39:32.054792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.640413ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969069131222226 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:5c049cded598ccd1>","response":"size:39"}
{"level":"info","ts":"2026-03-11T21:39:32.055106Z","caller":"traceutil/trace.go:171","msg":"trace[1015428040] linearizableReadLoop","detail":"{readStateIndex:947; appliedIndex:943; }","duration":"289.85459ms","start":"2026-03-11T21:39:31.765237Z","end":"2026-03-11T21:39:32.055092Z","steps":["trace[1015428040] 'read index received'  (duration: 131.90061ms)","trace[1015428040] 'applied index is now lower than readState.Index'  (duration: 157.95318ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:39:32.055164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.922841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T21:39:32.055146Z","caller":"traceutil/trace.go:171","msg":"trace[1250784852] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"381.6456ms","start":"2026-03-11T21:39:31.673458Z","end":"2026-03-11T21:39:32.055103Z","steps":["trace[1250784852] 'process raft request'  (duration: 381.482716ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:32.055183Z","caller":"traceutil/trace.go:171","msg":"trace[1871250534] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:910; }","duration":"289.986153ms","start":"2026-03-11T21:39:31.76519Z","end":"2026-03-11T21:39:32.055176Z","steps":["trace[1871250534] 'agreement among raft nodes before linearized reading'  (duration: 289.935862ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:32.055131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:31.670575Z","time spent":"384.538467ms","remote":"127.0.0.1:53186","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-11T21:39:32.055192Z","caller":"traceutil/trace.go:171","msg":"trace[716000816] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"378.912865ms","start":"2026-03-11T21:39:31.676243Z","end":"2026-03-11T21:39:32.055155Z","steps":["trace[716000816] 'process raft request'  (duration: 378.801493ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:32.055269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:31.673427Z","time spent":"381.775783ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:903 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-11T21:39:32.055354Z","caller":"traceutil/trace.go:171","msg":"trace[588656352] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"379.227643ms","start":"2026-03-11T21:39:31.676099Z","end":"2026-03-11T21:39:32.055327Z","steps":["trace[588656352] 'process raft request'  (duration: 378.969237ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:32.05538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:31.676205Z","time spent":"379.077819ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:902 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-11T21:39:32.055486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:31.673819Z","time spent":"381.595598ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:904 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-11T21:39:48.362337Z","caller":"traceutil/trace.go:171","msg":"trace[1877486665] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1010; }","duration":"203.064677ms","start":"2026-03-11T21:39:48.159247Z","end":"2026-03-11T21:39:48.362312Z","steps":["trace[1877486665] 'read index received'  (duration: 202.807531ms)","trace[1877486665] 'applied index is now lower than readState.Index'  (duration: 256.366µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:39:48.362634Z","caller":"traceutil/trace.go:171","msg":"trace[1836926365] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"249.043634ms","start":"2026-03-11T21:39:48.113583Z","end":"2026-03-11T21:39:48.362626Z","steps":["trace[1836926365] 'process raft request'  (duration: 248.590353ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:48.362874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.603989ms","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-11T21:39:48.362913Z","caller":"traceutil/trace.go:171","msg":"trace[1922676633] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:971; }","duration":"203.704141ms","start":"2026-03-11T21:39:48.159198Z","end":"2026-03-11T21:39:48.362902Z","steps":["trace[1922676633] 'agreement among raft nodes before linearized reading'  (duration: 203.552248ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:48.362938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.870009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-11T21:39:48.362974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.92335ms","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-11T21:39:48.363002Z","caller":"traceutil/trace.go:171","msg":"trace[1605113300] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:971; }","duration":"201.94829ms","start":"2026-03-11T21:39:48.161037Z","end":"2026-03-11T21:39:48.362986Z","steps":["trace[1605113300] 'agreement among raft nodes before linearized reading'  (duration: 201.789187ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:48.363085Z","caller":"traceutil/trace.go:171","msg":"trace[88878012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:971; }","duration":"202.067754ms","start":"2026-03-11T21:39:48.160991Z","end":"2026-03-11T21:39:48.363059Z","steps":["trace[88878012] 'agreement among raft nodes before linearized reading'  (duration: 201.755567ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:48.499439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.524544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"info","ts":"2026-03-11T21:39:48.49954Z","caller":"traceutil/trace.go:171","msg":"trace[1983487273] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:971; }","duration":"129.663987ms","start":"2026-03-11T21:39:48.369852Z","end":"2026-03-11T21:39:48.499516Z","steps":["trace[1983487273] 'range keys from in-memory index tree'  (duration: 129.424782ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:48.499914Z","caller":"traceutil/trace.go:171","msg":"trace[235094779] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"129.827851ms","start":"2026-03-11T21:39:48.370073Z","end":"2026-03-11T21:39:48.499901Z","steps":["trace[235094779] 'process raft request'  (duration: 129.795531ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:48.500026Z","caller":"traceutil/trace.go:171","msg":"trace[1887918790] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"130.005745ms","start":"2026-03-11T21:39:48.370011Z","end":"2026-03-11T21:39:48.500017Z","steps":["trace[1887918790] 'process raft request'  (duration: 129.820271ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:48.49992Z","caller":"traceutil/trace.go:171","msg":"trace[1010615561] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"130.001866ms","start":"2026-03-11T21:39:48.369904Z","end":"2026-03-11T21:39:48.499906Z","steps":["trace[1010615561] 'process raft request'  (duration: 48.496566ms)","trace[1010615561] 'compare'  (duration: 81.249064ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:39:49.59331Z","caller":"traceutil/trace.go:171","msg":"trace[69046510] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"162.190619ms","start":"2026-03-11T21:39:49.431084Z","end":"2026-03-11T21:39:49.593275Z","steps":["trace[69046510] 'process raft request'  (duration: 162.014295ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:50.631604Z","caller":"traceutil/trace.go:171","msg":"trace[1928182801] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"120.520993ms","start":"2026-03-11T21:39:50.511063Z","end":"2026-03-11T21:39:50.631584Z","steps":["trace[1928182801] 'process raft request'  (duration: 120.37125ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:50.645053Z","caller":"traceutil/trace.go:171","msg":"trace[505067817] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1018; }","duration":"112.468144ms","start":"2026-03-11T21:39:50.532563Z","end":"2026-03-11T21:39:50.645031Z","steps":["trace[505067817] 'read index received'  (duration: 98.808954ms)","trace[505067817] 'applied index is now lower than readState.Index'  (duration: 13.65759ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:39:50.645342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.759532ms","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-11T21:39:50.6454Z","caller":"traceutil/trace.go:171","msg":"trace[1780755483] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:981; }","duration":"112.904025ms","start":"2026-03-11T21:39:50.532481Z","end":"2026-03-11T21:39:50.645385Z","steps":["trace[1780755483] 'agreement among raft nodes before linearized reading'  (duration: 112.637138ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:50.646332Z","caller":"traceutil/trace.go:171","msg":"trace[1150224421] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"134.710446ms","start":"2026-03-11T21:39:50.511576Z","end":"2026-03-11T21:39:50.646286Z","steps":["trace[1150224421] 'process raft request'  (duration: 133.396545ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:50.64783Z","caller":"traceutil/trace.go:171","msg":"trace[288257699] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"136.298652ms","start":"2026-03-11T21:39:50.511507Z","end":"2026-03-11T21:39:50.647806Z","steps":["trace[288257699] 'process raft request'  (duration: 133.331503ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:51.030028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.212526ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969069131222403 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:976 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T21:39:51.030308Z","caller":"traceutil/trace.go:171","msg":"trace[869320815] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"377.451372ms","start":"2026-03-11T21:39:50.652819Z","end":"2026-03-11T21:39:51.030271Z","steps":["trace[869320815] 'process raft request'  (duration: 256.894708ms)","trace[869320815] 'compare'  (duration: 120.067672ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:39:51.030507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:50.652786Z","time spent":"377.621986ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:976 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-11T21:39:51.435935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.239483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-11T21:39:51.436037Z","caller":"traceutil/trace.go:171","msg":"trace[1039822502] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:982; }","duration":"259.396776ms","start":"2026-03-11T21:39:51.176618Z","end":"2026-03-11T21:39:51.436015Z","steps":["trace[1039822502] 'range keys from in-memory index tree'  (duration: 258.887754ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:52.010868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.920042ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969069131222409 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.116\" mod_revision:934 > success:<request_put:<key:\"/registry/masterleases/199.204.45.116\" value_size:67 lease:6630597032276446599 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.116\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T21:39:52.011002Z","caller":"traceutil/trace.go:171","msg":"trace[1207296406] linearizableReadLoop","detail":"{readStateIndex:1024; appliedIndex:1023; }","duration":"413.680221ms","start":"2026-03-11T21:39:51.5973Z","end":"2026-03-11T21:39:52.01098Z","steps":["trace[1207296406] 'read index received'  (duration: 266.567225ms)","trace[1207296406] 'applied index is now lower than readState.Index'  (duration: 147.111766ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:39:52.011184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.895266ms","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-11T21:39:52.011212Z","caller":"traceutil/trace.go:171","msg":"trace[323951022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:983; }","duration":"413.979917ms","start":"2026-03-11T21:39:51.597222Z","end":"2026-03-11T21:39:52.011202Z","steps":["trace[323951022] 'agreement among raft nodes before linearized reading'  (duration: 413.810543ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:52.011251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:51.597192Z","time spent":"414.050409ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-11T21:39:52.011243Z","caller":"traceutil/trace.go:171","msg":"trace[1639612656] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"542.287733ms","start":"2026-03-11T21:39:51.468914Z","end":"2026-03-11T21:39:52.011201Z","steps":["trace[1639612656] 'process raft request'  (duration: 394.88913ms)","trace[1639612656] 'compare'  (duration: 146.680896ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:39:52.011465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:51.468887Z","time spent":"542.457647ms","remote":"127.0.0.1:53186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.116\" mod_revision:934 > success:<request_put:<key:\"/registry/masterleases/199.204.45.116\" value_size:67 lease:6630597032276446599 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.116\" > >"}
{"level":"info","ts":"2026-03-11T21:39:52.202475Z","caller":"traceutil/trace.go:171","msg":"trace[190795621] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"185.086335ms","start":"2026-03-11T21:39:52.016857Z","end":"2026-03-11T21:39:52.201943Z","steps":["trace[190795621] 'process raft request'  (duration: 114.273516ms)","trace[190795621] 'compare'  (duration: 70.40714ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:39:52.202685Z","caller":"traceutil/trace.go:171","msg":"trace[1361825460] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1025; }","duration":"174.972038ms","start":"2026-03-11T21:39:52.027702Z","end":"2026-03-11T21:39:52.202674Z","steps":["trace[1361825460] 'read index received'  (duration: 103.358631ms)","trace[1361825460] 'applied index is now lower than readState.Index'  (duration: 71.611677ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:39:52.202875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.148773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-11T21:39:52.202914Z","caller":"traceutil/trace.go:171","msg":"trace[2081570364] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:986; }","duration":"175.224084ms","start":"2026-03-11T21:39:52.027672Z","end":"2026-03-11T21:39:52.202896Z","steps":["trace[2081570364] 'agreement among raft nodes before linearized reading'  (duration: 175.091071ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:52.246585Z","caller":"traceutil/trace.go:171","msg":"trace[730430276] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"109.874324ms","start":"2026-03-11T21:39:52.136682Z","end":"2026-03-11T21:39:52.246556Z","steps":["trace[730430276] 'process raft request'  (duration: 109.69819ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:52.246761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.413633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T21:39:52.246874Z","caller":"traceutil/trace.go:171","msg":"trace[1787225980] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:987; }","duration":"147.597267ms","start":"2026-03-11T21:39:52.099249Z","end":"2026-03-11T21:39:52.246846Z","steps":["trace[1787225980] 'agreement among raft nodes before linearized reading'  (duration: 147.349161ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:52.247061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.562068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-11T21:39:52.247108Z","caller":"traceutil/trace.go:171","msg":"trace[126226401] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:987; }","duration":"127.65107ms","start":"2026-03-11T21:39:52.11944Z","end":"2026-03-11T21:39:52.247091Z","steps":["trace[126226401] 'agreement among raft nodes before linearized reading'  (duration: 127.519927ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:52.352182Z","caller":"traceutil/trace.go:171","msg":"trace[1208402559] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"100.7472ms","start":"2026-03-11T21:39:52.251394Z","end":"2026-03-11T21:39:52.352141Z","steps":["trace[1208402559] 'process raft request'  (duration: 75.710154ms)","trace[1208402559] 'compare'  (duration: 24.76871ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:39:52.490146Z","caller":"traceutil/trace.go:171","msg":"trace[1358611903] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"128.171382ms","start":"2026-03-11T21:39:52.361934Z","end":"2026-03-11T21:39:52.490105Z","steps":["trace[1358611903] 'process raft request'  (duration: 96.47902ms)","trace[1358611903] 'compare'  (duration: 31.548459ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:39:53.46616Z","caller":"traceutil/trace.go:171","msg":"trace[538489358] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"426.656374ms","start":"2026-03-11T21:39:53.039473Z","end":"2026-03-11T21:39:53.46613Z","steps":["trace[538489358] 'process raft request'  (duration: 426.377998ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:39:53.466339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:39:53.039452Z","time spent":"426.796488ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"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:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-11T21:39:53.849309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.853817ms","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-11T21:39:53.84942Z","caller":"traceutil/trace.go:171","msg":"trace[967526918] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:995; }","duration":"149.060453ms","start":"2026-03-11T21:39:53.700335Z","end":"2026-03-11T21:39:53.849396Z","steps":["trace[967526918] 'count revisions from in-memory index tree'  (duration: 148.704564ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:54.337828Z","caller":"traceutil/trace.go:171","msg":"trace[2085567023] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"120.5535ms","start":"2026-03-11T21:39:54.217243Z","end":"2026-03-11T21:39:54.337797Z","steps":["trace[2085567023] 'process raft request'  (duration: 120.354666ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:39:54.857114Z","caller":"traceutil/trace.go:171","msg":"trace[1396519951] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"118.327369ms","start":"2026-03-11T21:39:54.738747Z","end":"2026-03-11T21:39:54.857075Z","steps":["trace[1396519951] 'process raft request'  (duration: 117.996381ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:40:02.5044Z","caller":"traceutil/trace.go:171","msg":"trace[707970405] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"129.034841ms","start":"2026-03-11T21:40:02.375337Z","end":"2026-03-11T21:40:02.504372Z","steps":["trace[707970405] 'process raft request'  (duration: 128.853437ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:40:03.40278Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969069131222565,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-11T21:40:03.745458Z","caller":"traceutil/trace.go:171","msg":"trace[1105954481] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"843.402112ms","start":"2026-03-11T21:40:02.902031Z","end":"2026-03-11T21:40:03.745433Z","steps":["trace[1105954481] 'read index received'  (duration: 843.229418ms)","trace[1105954481] 'applied index is now lower than readState.Index'  (duration: 171.444µs)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:40:03.745579Z","caller":"traceutil/trace.go:171","msg":"trace[443708770] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"849.64286ms","start":"2026-03-11T21:40:02.895882Z","end":"2026-03-11T21:40:03.745525Z","steps":["trace[443708770] 'process raft request'  (duration: 849.353233ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:40:03.745713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.398292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-11T21:40:03.745747Z","caller":"traceutil/trace.go:171","msg":"trace[2108970853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1060; }","duration":"843.465525ms","start":"2026-03-11T21:40:02.902272Z","end":"2026-03-11T21:40:03.745737Z","steps":["trace[2108970853] 'agreement among raft nodes before linearized reading'  (duration: 843.309411ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:40:03.745784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:40:02.902265Z","time spent":"843.508755ms","remote":"127.0.0.1:53400","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-11T21:40:03.745823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.755261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-11T21:40:03.745861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:40:02.895858Z","time spent":"849.866655ms","remote":"127.0.0.1:53400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1050 > 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-11T21:40:03.745946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.485604ms","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-11T21:40:03.745946Z","caller":"traceutil/trace.go:171","msg":"trace[1885355018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1060; }","duration":"843.955106ms","start":"2026-03-11T21:40:02.901955Z","end":"2026-03-11T21:40:03.74591Z","steps":["trace[1885355018] 'agreement among raft nodes before linearized reading'  (duration: 843.582627ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:40:03.745971Z","caller":"traceutil/trace.go:171","msg":"trace[380862202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1060; }","duration":"237.568527ms","start":"2026-03-11T21:40:03.508395Z","end":"2026-03-11T21:40:03.745964Z","steps":["trace[380862202] 'agreement among raft nodes before linearized reading'  (duration: 237.505485ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:40:03.746007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:40:02.901924Z","time spent":"844.073009ms","remote":"127.0.0.1:53400","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-11T21:40:03.745998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.692898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-11T21:40:03.746049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.261665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T21:40:03.746056Z","caller":"traceutil/trace.go:171","msg":"trace[1738761839] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1060; }","duration":"621.810372ms","start":"2026-03-11T21:40:03.12423Z","end":"2026-03-11T21:40:03.746041Z","steps":["trace[1738761839] 'agreement among raft nodes before linearized reading'  (duration: 621.691449ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:40:03.746071Z","caller":"traceutil/trace.go:171","msg":"trace[605573951] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1060; }","duration":"808.281135ms","start":"2026-03-11T21:40:02.937783Z","end":"2026-03-11T21:40:03.746064Z","steps":["trace[605573951] 'agreement among raft nodes before linearized reading'  (duration: 808.246394ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:40:03.746095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:40:02.937748Z","time spent":"808.342817ms","remote":"127.0.0.1:53140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-11T21:40:03.746097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:40:03.124207Z","time spent":"621.881463ms","remote":"127.0.0.1:53446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "}
{"level":"warn","ts":"2026-03-11T21:40:03.74611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.966288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-11T21:40:03.746216Z","caller":"traceutil/trace.go:171","msg":"trace[1754084174] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1060; }","duration":"634.134291ms","start":"2026-03-11T21:40:03.11206Z","end":"2026-03-11T21:40:03.746195Z","steps":["trace[1754084174] 'agreement among raft nodes before linearized reading'  (duration: 633.956717ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:40:03.746266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T21:40:03.112033Z","time spent":"634.218614ms","remote":"127.0.0.1:53322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "}
{"level":"warn","ts":"2026-03-11T21:40:03.746307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.118473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-03-11T21:40:03.746453Z","caller":"traceutil/trace.go:171","msg":"trace[1848684468] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1060; }","duration":"292.337098ms","start":"2026-03-11T21:40:03.454084Z","end":"2026-03-11T21:40:03.746421Z","steps":["trace[1848684468] 'agreement among raft nodes before linearized reading'  (duration: 291.899127ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:40:03.9451Z","caller":"traceutil/trace.go:171","msg":"trace[868987122] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"181.495847ms","start":"2026-03-11T21:40:03.763566Z","end":"2026-03-11T21:40:03.945062Z","steps":["trace[868987122] 'process raft request'  (duration: 181.074547ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:40:03.94585Z","caller":"traceutil/trace.go:171","msg":"trace[654045792] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"182.161222ms","start":"2026-03-11T21:40:03.763644Z","end":"2026-03-11T21:40:03.945805Z","steps":["trace[654045792] 'process raft request'  (duration: 181.827834ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:40:03.94602Z","caller":"traceutil/trace.go:171","msg":"trace[85285805] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"182.255435ms","start":"2026-03-11T21:40:03.763736Z","end":"2026-03-11T21:40:03.945992Z","steps":["trace[85285805] 'process raft request'  (duration: 181.988048ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:40:03.946144Z","caller":"traceutil/trace.go:171","msg":"trace[354790032] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"182.341867ms","start":"2026-03-11T21:40:03.76376Z","end":"2026-03-11T21:40:03.946102Z","steps":["trace[354790032] 'process raft request'  (duration: 182.150423ms)"],"step_count":1}
{"level":"info","ts":"2026-03-11T21:43:17.851258Z","caller":"traceutil/trace.go:171","msg":"trace[2129175373] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1965; }","duration":"253.990124ms","start":"2026-03-11T21:43:17.59724Z","end":"2026-03-11T21:43:17.851231Z","steps":["trace[2129175373] 'read index received'  (duration: 189.467673ms)","trace[2129175373] 'applied index is now lower than readState.Index'  (duration: 64.521701ms)"],"step_count":2}
{"level":"info","ts":"2026-03-11T21:43:17.851386Z","caller":"traceutil/trace.go:171","msg":"trace[297986073] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"263.387161ms","start":"2026-03-11T21:43:17.587989Z","end":"2026-03-11T21:43:17.851377Z","steps":["trace[297986073] 'process raft request'  (duration: 198.762927ms)","trace[297986073] 'compare'  (duration: 64.368748ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-11T21:43:17.851746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.483826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"}
{"level":"info","ts":"2026-03-11T21:43:17.851787Z","caller":"traceutil/trace.go:171","msg":"trace[1310927990] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1883; }","duration":"254.557187ms","start":"2026-03-11T21:43:17.597219Z","end":"2026-03-11T21:43:17.851776Z","steps":["trace[1310927990] 'agreement among raft nodes before linearized reading'  (duration: 254.409574ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-11T21:43:18.076554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.569117ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15853969069131224695 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1857 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-11T21:43:18.076639Z","caller":"traceutil/trace.go:171","msg":"trace[1948118210] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"135.865256ms","start":"2026-03-11T21:43:17.940759Z","end":"2026-03-11T21:43:18.076625Z","steps":["trace[1948118210] 'process raft request'  (duration: 29.149275ms)","trace[1948118210] 'compare'  (duration: 106.215209ms)"],"step_count":2}