{"level":"warn","ts":"2026-02-26T20:56:34.339233Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-26T20:56:34.339334Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-02-26T20:56:34.339415Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-26T20:56:34.339432Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]}
{"level":"info","ts":"2026-02-26T20:56:34.33946Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-26T20:56:34.340338Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]}
{"level":"info","ts":"2026-02-26T20:56:34.340496Z","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.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-02-26T20:56:34.344292Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.517079ms"}
{"level":"info","ts":"2026-02-26T20:56:34.350833Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"}
{"level":"info","ts":"2026-02-26T20:56:34.350902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"}
{"level":"info","ts":"2026-02-26T20:56:34.350921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"}
{"level":"info","ts":"2026-02-26T20:56:34.350935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-26T20:56:34.350942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"}
{"level":"info","ts":"2026-02-26T20:56:34.350972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"}
{"level":"warn","ts":"2026-02-26T20:56:34.357179Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-26T20:56:34.358568Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-26T20:56:34.362271Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-02-26T20:56:34.365194Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-26T20:56:34.365577Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-26T20:56:34.36561Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-26T20:56:34.365667Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-26T20:56:34.365682Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-26T20:56:34.369306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"}
{"level":"info","ts":"2026-02-26T20:56:34.36954Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]}
{"level":"info","ts":"2026-02-26T20:56:34.371792Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-02-26T20:56:34.372006Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-26T20:56:34.372039Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-26T20:56:34.372166Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"}
{"level":"info","ts":"2026-02-26T20:56:34.3722Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"}
{"level":"info","ts":"2026-02-26T20:56:34.8519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"}
{"level":"info","ts":"2026-02-26T20:56:34.851995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-26T20:56:34.852023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"}
{"level":"info","ts":"2026-02-26T20:56:34.852042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"}
{"level":"info","ts":"2026-02-26T20:56:34.852053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"}
{"level":"info","ts":"2026-02-26T20:56:34.85207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"}
{"level":"info","ts":"2026-02-26T20:56:34.852089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"}
{"level":"info","ts":"2026-02-26T20:56:34.879258Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-26T20:56:34.87934Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-26T20:56:34.879546Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-26T20:56:34.87983Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-26T20:56:34.880182Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-26T20:56:34.880235Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-26T20:56:34.882804Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"}
{"level":"info","ts":"2026-02-26T20:56:34.885293Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-26T20:56:34.895117Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-26T20:56:34.895251Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-26T20:56:34.8953Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-26T20:56:37.803836Z","caller":"traceutil/trace.go:171","msg":"trace[693119933] transaction","detail":"{read_only:false; response_revision:147; number_of_response:1; }","duration":"194.946383ms","start":"2026-02-26T20:56:37.60886Z","end":"2026-02-26T20:56:37.803806Z","steps":["trace[693119933] 'process raft request'  (duration: 94.959825ms)","trace[693119933] 'compare'  (duration: 99.854417ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:56:39.647707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.062948786s","expected-duration":"100ms","prefix":"","request":"header:<ID:14085742977262891128 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:cronjob-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:cronjob-controller\" value_size:658 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-26T20:56:39.647916Z","caller":"traceutil/trace.go:171","msg":"trace[746936763] transaction","detail":"{read_only:false; response_revision:151; number_of_response:1; }","duration":"1.245479073s","start":"2026-02-26T20:56:38.40242Z","end":"2026-02-26T20:56:39.647899Z","steps":["trace[746936763] 'process raft request'  (duration: 1.245417742s)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:39.647917Z","caller":"traceutil/trace.go:171","msg":"trace[1474624803] transaction","detail":"{read_only:false; response_revision:150; number_of_response:1; }","duration":"1.784122799s","start":"2026-02-26T20:56:37.863741Z","end":"2026-02-26T20:56:39.647864Z","steps":["trace[1474624803] 'process raft request'  (duration: 720.363334ms)","trace[1474624803] 'compare'  (duration: 1.062813704s)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:56:39.647976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:38.402393Z","time spent":"1.245558073s","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"warn","ts":"2026-02-26T20:56:39.648129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:37.863732Z","time spent":"1.784314051s","remote":"127.0.0.1:47418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":732,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:cronjob-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:cronjob-controller\" value_size:658 >> failure:<>"}
{"level":"info","ts":"2026-02-26T20:56:39.648213Z","caller":"traceutil/trace.go:171","msg":"trace[1472743939] linearizableReadLoop","detail":"{readStateIndex:153; appliedIndex:152; }","duration":"1.426642175s","start":"2026-02-26T20:56:38.22148Z","end":"2026-02-26T20:56:39.648122Z","steps":["trace[1472743939] 'read index received'  (duration: 362.830751ms)","trace[1472743939] 'applied index is now lower than readState.Index'  (duration: 1.063806544s)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:56:39.648479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.426941948s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:56:39.648561Z","caller":"traceutil/trace.go:171","msg":"trace[1734647994] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:151; }","duration":"1.42709991s","start":"2026-02-26T20:56:38.221438Z","end":"2026-02-26T20:56:39.648538Z","steps":["trace[1734647994] 'agreement among raft nodes before linearized reading'  (duration: 1.426877247s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:39.64862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:38.221417Z","time spent":"1.427189941s","remote":"127.0.0.1:46986","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-02-26T20:56:40.149149Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085742977262891131,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T20:56:40.254888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000137741s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-26T20:56:40.254988Z","caller":"traceutil/trace.go:171","msg":"trace[1763740003] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000281373s","start":"2026-02-26T20:56:38.254679Z","end":"2026-02-26T20:56:40.25496Z","steps":["trace[1763740003] 'agreement among raft nodes before linearized reading'  (duration: 2.000167732s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:40.255039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:38.254655Z","time spent":"2.000372134s","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/26 20:56:40 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-02-26T20:56:40.398443Z","caller":"traceutil/trace.go:171","msg":"trace[1295226892] linearizableReadLoop","detail":"{readStateIndex:155; appliedIndex:154; }","duration":"750.015289ms","start":"2026-02-26T20:56:39.648392Z","end":"2026-02-26T20:56:40.398408Z","steps":["trace[1295226892] 'read index received'  (duration: 745.695623ms)","trace[1295226892] 'applied index is now lower than readState.Index'  (duration: 4.318996ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:56:40.398513Z","caller":"traceutil/trace.go:171","msg":"trace[1704063241] transaction","detail":"{read_only:false; response_revision:152; number_of_response:1; }","duration":"780.768553ms","start":"2026-02-26T20:56:39.617725Z","end":"2026-02-26T20:56:40.398494Z","steps":["trace[1704063241] 'process raft request'  (duration: 776.403107ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:40.398614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:39.617702Z","time spent":"780.857864ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>"}
{"level":"warn","ts":"2026-02-26T20:56:40.398715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.55665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:56:40.39884Z","caller":"traceutil/trace.go:171","msg":"trace[1850430029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:152; }","duration":"815.678191ms","start":"2026-02-26T20:56:39.583108Z","end":"2026-02-26T20:56:40.398786Z","steps":["trace[1850430029] 'agreement among raft nodes before linearized reading'  (duration: 815.466358ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:40.398883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:39.583088Z","time spent":"815.784162ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-26T20:56:40.398924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.159267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-26T20:56:40.398941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.535783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:56:40.399047Z","caller":"traceutil/trace.go:171","msg":"trace[1613659019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:152; }","duration":"748.696855ms","start":"2026-02-26T20:56:39.65033Z","end":"2026-02-26T20:56:40.399027Z","steps":["trace[1613659019] 'agreement among raft nodes before linearized reading'  (duration: 748.521973ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:40.399108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:39.65031Z","time spent":"748.785156ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-26T20:56:40.399259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.33273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:daemon-set-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:56:40.399311Z","caller":"traceutil/trace.go:171","msg":"trace[2076591533] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:daemon-set-controller; range_end:; response_count:0; response_revision:152; }","duration":"747.406641ms","start":"2026-02-26T20:56:39.651891Z","end":"2026-02-26T20:56:40.399298Z","steps":["trace[2076591533] 'agreement among raft nodes before linearized reading'  (duration: 747.34249ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:40.399359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:39.651875Z","time spent":"747.467181ms","remote":"127.0.0.1:47418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/system:controller:daemon-set-controller\" "}
{"level":"info","ts":"2026-02-26T20:56:40.398962Z","caller":"traceutil/trace.go:171","msg":"trace[841596638] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:152; }","duration":"182.196237ms","start":"2026-02-26T20:56:40.216754Z","end":"2026-02-26T20:56:40.39895Z","steps":["trace[841596638] 'agreement among raft nodes before linearized reading'  (duration: 182.140167ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:40.399632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.959639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:56:40.400089Z","caller":"traceutil/trace.go:171","msg":"trace[814515616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:152; }","duration":"677.453834ms","start":"2026-02-26T20:56:39.722579Z","end":"2026-02-26T20:56:40.400033Z","steps":["trace[814515616] 'agreement among raft nodes before linearized reading'  (duration: 676.699026ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:40.400923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:39.722535Z","time spent":"678.331663ms","remote":"127.0.0.1:46986","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-02-26T20:56:41.694672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.691285ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085742977262891293 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/job-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/job-controller\" value_size:119 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-26T20:56:41.694984Z","caller":"traceutil/trace.go:171","msg":"trace[1535735674] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"208.529241ms","start":"2026-02-26T20:56:41.486366Z","end":"2026-02-26T20:56:41.694896Z","steps":["trace[1535735674] 'process raft request'  (duration: 42.524943ms)","trace[1535735674] 'compare'  (duration: 165.529653ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:56:41.695096Z","caller":"traceutil/trace.go:171","msg":"trace[857071945] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"193.364582ms","start":"2026-02-26T20:56:41.501494Z","end":"2026-02-26T20:56:41.694859Z","steps":["trace[857071945] 'process raft request'  (duration: 193.304482ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:41.815125Z","caller":"traceutil/trace.go:171","msg":"trace[1132147085] linearizableReadLoop","detail":"{readStateIndex:234; appliedIndex:233; }","duration":"114.34247ms","start":"2026-02-26T20:56:41.700762Z","end":"2026-02-26T20:56:41.815104Z","steps":["trace[1132147085] 'read index received'  (duration: 108.835993ms)","trace[1132147085] 'applied index is now lower than readState.Index'  (duration: 5.505577ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:56:41.815292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.504962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-26T20:56:41.81535Z","caller":"traceutil/trace.go:171","msg":"trace[1070746666] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:229; }","duration":"114.611484ms","start":"2026-02-26T20:56:41.700725Z","end":"2026-02-26T20:56:41.815337Z","steps":["trace[1070746666] 'agreement among raft nodes before linearized reading'  (duration: 114.480762ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:41.815173Z","caller":"traceutil/trace.go:171","msg":"trace[521491459] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"116.104219ms","start":"2026-02-26T20:56:41.699042Z","end":"2026-02-26T20:56:41.815147Z","steps":["trace[521491459] 'process raft request'  (duration: 110.629702ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.712751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.798839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"info","ts":"2026-02-26T20:56:42.712834Z","caller":"traceutil/trace.go:171","msg":"trace[1250492319] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:285; }","duration":"439.91302ms","start":"2026-02-26T20:56:42.272905Z","end":"2026-02-26T20:56:42.712818Z","steps":["trace[1250492319] 'range keys from in-memory index tree'  (duration: 439.712298ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.71278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.790937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-26T20:56:42.712857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.731863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"warn","ts":"2026-02-26T20:56:42.712874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.272888Z","time spent":"439.977051ms","remote":"127.0.0.1:47468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":686,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-02-26T20:56:42.71292Z","caller":"traceutil/trace.go:171","msg":"trace[694974584] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:285; }","duration":"540.825744ms","start":"2026-02-26T20:56:42.172079Z","end":"2026-02-26T20:56:42.712905Z","steps":["trace[694974584] 'range keys from in-memory index tree'  (duration: 540.661932ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.712908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.171343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:56:42.712951Z","caller":"traceutil/trace.go:171","msg":"trace[921592567] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:285; }","duration":"520.985759ms","start":"2026-02-26T20:56:42.191912Z","end":"2026-02-26T20:56:42.712897Z","steps":["trace[921592567] 'range keys from in-memory index tree'  (duration: 520.695806ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.712962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.172067Z","time spent":"540.884365ms","remote":"127.0.0.1:47144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-02-26T20:56:42.713003Z","caller":"traceutil/trace.go:171","msg":"trace[58708207] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:285; }","duration":"439.313284ms","start":"2026-02-26T20:56:42.273664Z","end":"2026-02-26T20:56:42.712977Z","steps":["trace[58708207] 'range keys from in-memory index tree'  (duration: 439.112211ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.713056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.273649Z","time spent":"439.397295ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "}
{"level":"warn","ts":"2026-02-26T20:56:42.713098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.191888Z","time spent":"521.191971ms","remote":"127.0.0.1:47528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "}
{"level":"info","ts":"2026-02-26T20:56:42.713781Z","caller":"traceutil/trace.go:171","msg":"trace[1075321010] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"439.656268ms","start":"2026-02-26T20:56:42.274091Z","end":"2026-02-26T20:56:42.713747Z","steps":["trace[1075321010] 'process raft request'  (duration: 437.230323ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.713879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.274082Z","time spent":"439.744479ms","remote":"127.0.0.1:47094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.1897e765ac5e06e3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.1897e765ac5e06e3\" value_size:524 lease:4862370940408115335 >> failure:<>"}
{"level":"info","ts":"2026-02-26T20:56:42.743607Z","caller":"traceutil/trace.go:171","msg":"trace[1820730440] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"352.917851ms","start":"2026-02-26T20:56:42.390664Z","end":"2026-02-26T20:56:42.743582Z","steps":["trace[1820730440] 'process raft request'  (duration: 352.785859ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:42.743654Z","caller":"traceutil/trace.go:171","msg":"trace[2142288319] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"352.553967ms","start":"2026-02-26T20:56:42.391091Z","end":"2026-02-26T20:56:42.743645Z","steps":["trace[2142288319] 'process raft request'  (duration: 352.442696ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:42.743653Z","caller":"traceutil/trace.go:171","msg":"trace[745647851] transaction","detail":"{read_only:false; number_of_response:0; response_revision:286; }","duration":"373.914268ms","start":"2026-02-26T20:56:42.369714Z","end":"2026-02-26T20:56:42.743628Z","steps":["trace[745647851] 'process raft request'  (duration: 373.647745ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.743713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.390644Z","time spent":"353.020052ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:5824 >> failure:<>"}
{"level":"info","ts":"2026-02-26T20:56:42.743736Z","caller":"traceutil/trace.go:171","msg":"trace[2000858641] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"352.177393ms","start":"2026-02-26T20:56:42.391532Z","end":"2026-02-26T20:56:42.743709Z","steps":["trace[2000858641] 'process raft request'  (duration: 352.022501ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:42.743756Z","caller":"traceutil/trace.go:171","msg":"trace[722880036] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"351.89001ms","start":"2026-02-26T20:56:42.391847Z","end":"2026-02-26T20:56:42.743737Z","steps":["trace[722880036] 'process raft request'  (duration: 351.725089ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.743752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.391078Z","time spent":"352.624958ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>"}
{"level":"info","ts":"2026-02-26T20:56:42.743763Z","caller":"traceutil/trace.go:171","msg":"trace[1936889375] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"353.055502ms","start":"2026-02-26T20:56:42.390691Z","end":"2026-02-26T20:56:42.743747Z","steps":["trace[1936889375] 'process raft request'  (duration: 352.82071ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.74379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.369696Z","time spent":"374.029559ms","remote":"127.0.0.1:47230","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3310 >> failure:<>"}
{"level":"warn","ts":"2026-02-26T20:56:42.743822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.391505Z","time spent":"352.279814ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5431 >> failure:<>"}
{"level":"warn","ts":"2026-02-26T20:56:42.743847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.391836Z","time spent":"351.963951ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"warn","ts":"2026-02-26T20:56:42.743848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.39066Z","time spent":"353.150773ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>"}
{"level":"warn","ts":"2026-02-26T20:56:42.744085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.335934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-02-26T20:56:42.744131Z","caller":"traceutil/trace.go:171","msg":"trace[1805157735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:287; }","duration":"319.407814ms","start":"2026-02-26T20:56:42.424712Z","end":"2026-02-26T20:56:42.74412Z","steps":["trace[1805157735] 'agreement among raft nodes before linearized reading'  (duration: 319.252653ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.744161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.4247Z","time spent":"319.454895ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-26T20:56:42.74361Z","caller":"traceutil/trace.go:171","msg":"trace[660475647] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:290; }","duration":"318.849789ms","start":"2026-02-26T20:56:42.424742Z","end":"2026-02-26T20:56:42.743592Z","steps":["trace[660475647] 'read index received'  (duration: 286.752767ms)","trace[660475647] 'applied index is now lower than readState.Index'  (duration: 32.096032ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:56:42.747487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.89869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-26T20:56:42.747542Z","caller":"traceutil/trace.go:171","msg":"trace[366188027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:289; }","duration":"321.98465ms","start":"2026-02-26T20:56:42.425543Z","end":"2026-02-26T20:56:42.747527Z","steps":["trace[366188027] 'agreement among raft nodes before linearized reading'  (duration: 321.892409ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.747575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.42553Z","time spent":"322.037501ms","remote":"127.0.0.1:47322","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-02-26T20:56:42.747902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.250673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-26T20:56:42.747951Z","caller":"traceutil/trace.go:171","msg":"trace[485556429] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:289; }","duration":"322.332084ms","start":"2026-02-26T20:56:42.425605Z","end":"2026-02-26T20:56:42.747937Z","steps":["trace[485556429] 'agreement among raft nodes before linearized reading'  (duration: 322.245454ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.747983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.425592Z","time spent":"322.383635ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-26T20:56:42.748147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.537617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-26T20:56:42.748186Z","caller":"traceutil/trace.go:171","msg":"trace[1431963740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:289; }","duration":"322.591017ms","start":"2026-02-26T20:56:42.425586Z","end":"2026-02-26T20:56:42.748177Z","steps":["trace[1431963740] 'agreement among raft nodes before linearized reading'  (duration: 322.529316ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:42.74822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:42.425541Z","time spent":"322.672687ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-26T20:56:43.546244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.679209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"}
{"level":"info","ts":"2026-02-26T20:56:43.546329Z","caller":"traceutil/trace.go:171","msg":"trace[816474685] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:320; }","duration":"114.81526ms","start":"2026-02-26T20:56:43.431493Z","end":"2026-02-26T20:56:43.546308Z","steps":["trace[816474685] 'range keys from in-memory index tree'  (duration: 114.593568ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:43.804186Z","caller":"traceutil/trace.go:171","msg":"trace[1377171046] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"251.070362ms","start":"2026-02-26T20:56:43.553061Z","end":"2026-02-26T20:56:43.804131Z","steps":["trace[1377171046] 'process raft request'  (duration: 250.733758ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:43.804925Z","caller":"traceutil/trace.go:171","msg":"trace[991124360] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"251.595267ms","start":"2026-02-26T20:56:43.553061Z","end":"2026-02-26T20:56:43.804657Z","steps":["trace[991124360] 'process raft request'  (duration: 250.89831ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:43.931053Z","caller":"traceutil/trace.go:171","msg":"trace[1932962180] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"116.042954ms","start":"2026-02-26T20:56:43.81482Z","end":"2026-02-26T20:56:43.930863Z","steps":["trace[1932962180] 'process raft request'  (duration: 41.113203ms)","trace[1932962180] 'compare'  (duration: 74.803789ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:56:43.955085Z","caller":"traceutil/trace.go:171","msg":"trace[1762080930] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"139.501735ms","start":"2026-02-26T20:56:43.815552Z","end":"2026-02-26T20:56:43.955054Z","steps":["trace[1762080930] 'process raft request'  (duration: 138.931709ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:44.121911Z","caller":"traceutil/trace.go:171","msg":"trace[951819783] linearizableReadLoop","detail":"{readStateIndex:339; appliedIndex:338; }","duration":"155.922976ms","start":"2026-02-26T20:56:43.965968Z","end":"2026-02-26T20:56:44.121891Z","steps":["trace[951819783] 'read index received'  (duration: 110.296049ms)","trace[951819783] 'applied index is now lower than readState.Index'  (duration: 45.625747ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:56:44.122101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.066077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-26T20:56:44.122133Z","caller":"traceutil/trace.go:171","msg":"trace[1386568758] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"156.158339ms","start":"2026-02-26T20:56:43.965923Z","end":"2026-02-26T20:56:44.122081Z","steps":["trace[1386568758] 'process raft request'  (duration: 110.369261ms)","trace[1386568758] 'compare'  (duration: 45.497225ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:56:44.12222Z","caller":"traceutil/trace.go:171","msg":"trace[159105648] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:325; }","duration":"156.202079ms","start":"2026-02-26T20:56:43.965934Z","end":"2026-02-26T20:56:44.122136Z","steps":["trace[159105648] 'agreement among raft nodes before linearized reading'  (duration: 156.046318ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:44.477205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.94457ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085742977262891487 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:320 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7230 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T20:56:44.477397Z","caller":"traceutil/trace.go:171","msg":"trace[32481947] linearizableReadLoop","detail":"{readStateIndex:342; appliedIndex:340; }","duration":"240.030023ms","start":"2026-02-26T20:56:44.237351Z","end":"2026-02-26T20:56:44.477381Z","steps":["trace[32481947] 'read index received'  (duration: 10.676639ms)","trace[32481947] 'applied index is now lower than readState.Index'  (duration: 229.352484ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:56:44.47749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.139724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:56:44.477476Z","caller":"traceutil/trace.go:171","msg":"trace[953005290] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"315.768907ms","start":"2026-02-26T20:56:44.161675Z","end":"2026-02-26T20:56:44.477444Z","steps":["trace[953005290] 'process raft request'  (duration: 86.352252ms)","trace[953005290] 'compare'  (duration: 228.777908ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:56:44.477519Z","caller":"traceutil/trace.go:171","msg":"trace[2133276531] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:328; }","duration":"240.207785ms","start":"2026-02-26T20:56:44.2373Z","end":"2026-02-26T20:56:44.477508Z","steps":["trace[2133276531] 'agreement among raft nodes before linearized reading'  (duration: 240.128795ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:44.477516Z","caller":"traceutil/trace.go:171","msg":"trace[1855579577] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"314.354433ms","start":"2026-02-26T20:56:44.163118Z","end":"2026-02-26T20:56:44.477472Z","steps":["trace[1855579577] 'process raft request'  (duration: 314.200971ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:44.47762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:44.161635Z","time spent":"315.905459ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:320 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7230 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"warn","ts":"2026-02-26T20:56:44.477675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:56:44.163108Z","time spent":"314.491234ms","remote":"127.0.0.1:47250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" value_size:121 >> failure:<>"}
{"level":"info","ts":"2026-02-26T20:56:52.977236Z","caller":"traceutil/trace.go:171","msg":"trace[1285474013] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"153.108802ms","start":"2026-02-26T20:56:52.824095Z","end":"2026-02-26T20:56:52.977204Z","steps":["trace[1285474013] 'process raft request'  (duration: 56.425094ms)","trace[1285474013] 'compare'  (duration: 96.579107ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:56:53.054429Z","caller":"traceutil/trace.go:171","msg":"trace[1419662722] linearizableReadLoop","detail":"{readStateIndex:433; appliedIndex:431; }","duration":"210.818085ms","start":"2026-02-26T20:56:52.843589Z","end":"2026-02-26T20:56:53.054408Z","steps":["trace[1419662722] 'read index received'  (duration: 36.914951ms)","trace[1419662722] 'applied index is now lower than readState.Index'  (duration: 173.902364ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:56:53.054541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.933426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-26T20:56:53.054575Z","caller":"traceutil/trace.go:171","msg":"trace[1155975746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:417; }","duration":"211.001587ms","start":"2026-02-26T20:56:52.843557Z","end":"2026-02-26T20:56:53.054559Z","steps":["trace[1155975746] 'agreement among raft nodes before linearized reading'  (duration: 210.932597ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:53.054564Z","caller":"traceutil/trace.go:171","msg":"trace[341183525] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"228.263147ms","start":"2026-02-26T20:56:52.826257Z","end":"2026-02-26T20:56:53.05452Z","steps":["trace[341183525] 'process raft request'  (duration: 228.032955ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:53.067938Z","caller":"traceutil/trace.go:171","msg":"trace[1361478763] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"166.382459ms","start":"2026-02-26T20:56:52.90153Z","end":"2026-02-26T20:56:53.067912Z","steps":["trace[1361478763] 'process raft request'  (duration: 166.235087ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:56:53.758745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.500049ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085742977262891713 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/coredns-67659f764b-xsq9x.1897e7684d68a8e5\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-67659f764b-xsq9x.1897e7684d68a8e5\" value_size:742 lease:4862370940408115335 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-26T20:56:53.758889Z","caller":"traceutil/trace.go:171","msg":"trace[639268246] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"199.330036ms","start":"2026-02-26T20:56:53.559549Z","end":"2026-02-26T20:56:53.758879Z","steps":["trace[639268246] 'process raft request'  (duration: 199.302616ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:53.759055Z","caller":"traceutil/trace.go:171","msg":"trace[2052177423] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"200.988612ms","start":"2026-02-26T20:56:53.55799Z","end":"2026-02-26T20:56:53.758979Z","steps":["trace[2052177423] 'process raft request'  (duration: 89.211041ms)","trace[2052177423] 'compare'  (duration: 111.384688ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:56:53.759097Z","caller":"traceutil/trace.go:171","msg":"trace[204516794] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"199.937612ms","start":"2026-02-26T20:56:53.559143Z","end":"2026-02-26T20:56:53.759081Z","steps":["trace[204516794] 'process raft request'  (duration: 199.66964ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:56:53.759213Z","caller":"traceutil/trace.go:171","msg":"trace[1845696172] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"198.019254ms","start":"2026-02-26T20:56:53.561188Z","end":"2026-02-26T20:56:53.759208Z","steps":["trace[1845696172] 'process raft request'  (duration: 197.828842ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:06.227576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.410714ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085742977262891855 > lease_revoke:<id:437a9c9bbd353285>","response":"size:27"}
{"level":"info","ts":"2026-02-26T20:57:06.227656Z","caller":"traceutil/trace.go:171","msg":"trace[1280581925] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"251.133518ms","start":"2026-02-26T20:57:05.976508Z","end":"2026-02-26T20:57:06.227641Z","steps":["trace[1280581925] 'read index received'  (duration: 39.582µs)","trace[1280581925] 'applied index is now lower than readState.Index'  (duration: 251.093006ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:57:06.227711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.201962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:57:06.227727Z","caller":"traceutil/trace.go:171","msg":"trace[518422263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"251.252945ms","start":"2026-02-26T20:57:05.976467Z","end":"2026-02-26T20:57:06.22772Z","steps":["trace[518422263] 'agreement among raft nodes before linearized reading'  (duration: 251.206072ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:06.227673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.949265ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:57:06.227792Z","caller":"traceutil/trace.go:171","msg":"trace[370128757] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:510; }","duration":"232.088573ms","start":"2026-02-26T20:57:05.995684Z","end":"2026-02-26T20:57:06.227772Z","steps":["trace[370128757] 'range keys from in-memory index tree'  (duration: 231.927584ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:07.115452Z","caller":"traceutil/trace.go:171","msg":"trace[1969146434] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"491.628293ms","start":"2026-02-26T20:57:06.623796Z","end":"2026-02-26T20:57:07.115424Z","steps":["trace[1969146434] 'process raft request'  (duration: 491.37929ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:07.115694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:06.623779Z","time spent":"491.777052ms","remote":"127.0.0.1:47230","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:413 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4533 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-26T20:57:07.116065Z","caller":"traceutil/trace.go:171","msg":"trace[857233277] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:530; }","duration":"222.343231ms","start":"2026-02-26T20:57:06.89369Z","end":"2026-02-26T20:57:07.116033Z","steps":["trace[857233277] 'read index received'  (duration: 221.544247ms)","trace[857233277] 'applied index is now lower than readState.Index'  (duration: 798.004µs)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:57:07.11615Z","caller":"traceutil/trace.go:171","msg":"trace[1899096630] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"316.942378ms","start":"2026-02-26T20:57:06.799181Z","end":"2026-02-26T20:57:07.116123Z","steps":["trace[1899096630] 'process raft request'  (duration: 316.672893ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:07.116267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:06.799156Z","time spent":"317.047094ms","remote":"127.0.0.1:47322","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:454 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-26T20:57:07.116331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.643358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-02-26T20:57:07.116314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.157589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:57:07.116396Z","caller":"traceutil/trace.go:171","msg":"trace[633111181] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:512; }","duration":"222.774165ms","start":"2026-02-26T20:57:06.893608Z","end":"2026-02-26T20:57:07.116382Z","steps":["trace[633111181] 'agreement among raft nodes before linearized reading'  (duration: 222.578164ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:07.116423Z","caller":"traceutil/trace.go:171","msg":"trace[505104018] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"137.342289ms","start":"2026-02-26T20:57:06.979057Z","end":"2026-02-26T20:57:07.116399Z","steps":["trace[505104018] 'agreement among raft nodes before linearized reading'  (duration: 137.197011ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:13.688777Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085742977262891940,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T20:57:14.189623Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085742977262891940,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-26T20:57:14.375905Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.188281431s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-26T20:57:14.37631Z","caller":"traceutil/trace.go:171","msg":"trace[2040500364] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"1.188820008s","start":"2026-02-26T20:57:13.187461Z","end":"2026-02-26T20:57:14.376281Z","steps":["trace[2040500364] 'process raft request'  (duration: 1.188642489s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:14.376483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:13.187444Z","time spent":"1.188958295s","remote":"127.0.0.1:47322","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:544 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-26T20:57:15.393563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.980483ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085742977262891942 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:472 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T20:57:15.393659Z","caller":"traceutil/trace.go:171","msg":"trace[563085055] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"2.204976606s","start":"2026-02-26T20:57:13.188666Z","end":"2026-02-26T20:57:15.393642Z","steps":["trace[563085055] 'read index received'  (duration: 1.187513931s)","trace[563085055] 'applied index is now lower than readState.Index'  (duration: 1.017461645s)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:57:15.39368Z","caller":"traceutil/trace.go:171","msg":"trace[668430969] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.886411871s","start":"2026-02-26T20:57:13.507249Z","end":"2026-02-26T20:57:15.393661Z","steps":["trace[668430969] 'process raft request'  (duration: 1.477254379s)","trace[668430969] 'compare'  (duration: 408.873168ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:57:15.393746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:13.507193Z","time spent":"1.886524987s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:472 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-26T20:57:15.39384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.205161276s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-02-26T20:57:15.393875Z","caller":"traceutil/trace.go:171","msg":"trace[1497923598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:552; }","duration":"2.20524578s","start":"2026-02-26T20:57:13.18862Z","end":"2026-02-26T20:57:15.393866Z","steps":["trace[1497923598] 'agreement among raft nodes before linearized reading'  (duration: 2.205103213s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:15.39391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:13.188601Z","time spent":"2.205302543s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-26T20:57:15.393921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.204390356s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-02-26T20:57:15.394008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.0129578s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gbghd\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-02-26T20:57:15.394006Z","caller":"traceutil/trace.go:171","msg":"trace[59691389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"2.204517982s","start":"2026-02-26T20:57:13.189469Z","end":"2026-02-26T20:57:15.393987Z","steps":["trace[59691389] 'agreement among raft nodes before linearized reading'  (duration: 2.204345894s)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:15.394039Z","caller":"traceutil/trace.go:171","msg":"trace[1473416746] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gbghd; range_end:; response_count:1; response_revision:552; }","duration":"2.013025774s","start":"2026-02-26T20:57:13.381006Z","end":"2026-02-26T20:57:15.394031Z","steps":["trace[1473416746] 'agreement among raft nodes before linearized reading'  (duration: 2.01295067s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:15.394056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:13.189458Z","time spent":"2.204587986s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-26T20:57:15.394092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.415508931s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:57:15.394112Z","caller":"traceutil/trace.go:171","msg":"trace[1215836762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"1.415553422s","start":"2026-02-26T20:57:13.978552Z","end":"2026-02-26T20:57:15.394106Z","steps":["trace[1215836762] 'agreement among raft nodes before linearized reading'  (duration: 1.415525451s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:15.394134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:13.978535Z","time spent":"1.415594875s","remote":"127.0.0.1:46986","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-02-26T20:57:15.394175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.201174031s","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-02-26T20:57:15.394221Z","caller":"traceutil/trace.go:171","msg":"trace[164493555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"2.201232743s","start":"2026-02-26T20:57:13.192973Z","end":"2026-02-26T20:57:15.394206Z","steps":["trace[164493555] 'agreement among raft nodes before linearized reading'  (duration: 2.20117058s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:15.394253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:13.192911Z","time spent":"2.201286386s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-26T20:57:15.394066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:13.380987Z","time spent":"2.013071865s","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-gbghd\" "}
{"level":"warn","ts":"2026-02-26T20:57:15.856556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.306513ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085742977262891946 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:545 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T20:57:15.856665Z","caller":"traceutil/trace.go:171","msg":"trace[312074313] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"459.623838ms","start":"2026-02-26T20:57:15.397022Z","end":"2026-02-26T20:57:15.856646Z","steps":["trace[312074313] 'process raft request'  (duration: 142.150847ms)","trace[312074313] 'compare'  (duration: 317.139364ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:57:15.856723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:15.397001Z","time spent":"459.695032ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:545 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-26T20:57:16.531741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.057943ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:57:16.531912Z","caller":"traceutil/trace.go:171","msg":"trace[1651415483] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:553; }","duration":"536.251373ms","start":"2026-02-26T20:57:15.995633Z","end":"2026-02-26T20:57:16.531885Z","steps":["trace[1651415483] 'range keys from in-memory index tree'  (duration: 536.032642ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:16.697999Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.158786177s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-26T20:57:16.698548Z","caller":"traceutil/trace.go:171","msg":"trace[2008116677] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:573; }","duration":"1.296582245s","start":"2026-02-26T20:57:15.401942Z","end":"2026-02-26T20:57:16.698525Z","steps":["trace[2008116677] 'read index received'  (duration: 137.24352ms)","trace[2008116677] 'applied index is now lower than readState.Index'  (duration: 1.159337925s)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:57:16.698622Z","caller":"traceutil/trace.go:171","msg":"trace[500784126] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"1.300584395s","start":"2026-02-26T20:57:15.398029Z","end":"2026-02-26T20:57:16.698613Z","steps":["trace[500784126] 'process raft request'  (duration: 1.3002902s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:16.698731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:15.398017Z","time spent":"1.300637428s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:547 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-26T20:57:16.698849Z","caller":"traceutil/trace.go:171","msg":"trace[1245093757] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"1.300753303s","start":"2026-02-26T20:57:15.398089Z","end":"2026-02-26T20:57:16.698842Z","steps":["trace[1245093757] 'process raft request'  (duration: 1.300344463s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:16.6989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:15.398071Z","time spent":"1.300799346s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:546 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-26T20:57:16.700482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.298533031s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:57:16.70054Z","caller":"traceutil/trace.go:171","msg":"trace[2068292873] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"1.290218723s","start":"2026-02-26T20:57:15.410231Z","end":"2026-02-26T20:57:16.70045Z","steps":["trace[2068292873] 'process raft request'  (duration: 1.288235655s)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:16.700579Z","caller":"traceutil/trace.go:171","msg":"trace[409852091] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"1.298636337s","start":"2026-02-26T20:57:15.401903Z","end":"2026-02-26T20:57:16.700539Z","steps":["trace[409852091] 'agreement among raft nodes before linearized reading'  (duration: 1.298516151s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:16.70063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:15.401891Z","time spent":"1.298728941s","remote":"127.0.0.1:46986","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-02-26T20:57:16.70073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:15.410221Z","time spent":"1.290405352s","remote":"127.0.0.1:47240","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-gbghd\" mod_revision:503 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-gbghd\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-gbghd\" > >"}
{"level":"warn","ts":"2026-02-26T20:57:16.777812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.948261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-26T20:57:16.777883Z","caller":"traceutil/trace.go:171","msg":"trace[14113695] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:556; }","duration":"398.071227ms","start":"2026-02-26T20:57:16.379794Z","end":"2026-02-26T20:57:16.777865Z","steps":["trace[14113695] 'agreement among raft nodes before linearized reading'  (duration: 397.909729ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:16.777912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:16.379775Z","time spent":"398.131891ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-26T20:57:18.896749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037878108s","expected-duration":"100ms","prefix":"","request":"header:<ID:14085742977262891956 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:512 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-26T20:57:18.896881Z","caller":"traceutil/trace.go:171","msg":"trace[589746326] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"1.036342592s","start":"2026-02-26T20:57:17.860516Z","end":"2026-02-26T20:57:18.896858Z","steps":["trace[589746326] 'read index received'  (duration: 31.131µs)","trace[589746326] 'applied index is now lower than readState.Index'  (duration: 1.036309111s)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:57:18.897094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036572244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-02-26T20:57:18.897155Z","caller":"traceutil/trace.go:171","msg":"trace[2059887430] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:558; }","duration":"1.036655047s","start":"2026-02-26T20:57:17.860484Z","end":"2026-02-26T20:57:18.897139Z","steps":["trace[2059887430] 'agreement among raft nodes before linearized reading'  (duration: 1.036532601s)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:18.897207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:17.86047Z","time spent":"1.036722171s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-26T20:57:18.897097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.643527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:57:18.897358Z","caller":"traceutil/trace.go:171","msg":"trace[1889285308] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"918.946211ms","start":"2026-02-26T20:57:17.978395Z","end":"2026-02-26T20:57:18.897341Z","steps":["trace[1889285308] 'agreement among raft nodes before linearized reading'  (duration: 918.656297ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:18.897407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:17.978375Z","time spent":"919.018635ms","remote":"127.0.0.1:46986","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-02-26T20:57:18.897452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.804507ms","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-02-26T20:57:18.897507Z","caller":"traceutil/trace.go:171","msg":"trace[1376911426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:558; }","duration":"188.904842ms","start":"2026-02-26T20:57:18.708584Z","end":"2026-02-26T20:57:18.897488Z","steps":["trace[1376911426] 'agreement among raft nodes before linearized reading'  (duration: 188.794037ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:18.897516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.493862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-02-26T20:57:18.897585Z","caller":"traceutil/trace.go:171","msg":"trace[1824553377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:558; }","duration":"188.637889ms","start":"2026-02-26T20:57:18.708926Z","end":"2026-02-26T20:57:18.897564Z","steps":["trace[1824553377] 'agreement among raft nodes before linearized reading'  (duration: 188.398657ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:18.897008Z","caller":"traceutil/trace.go:171","msg":"trace[250994525] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"1.494557936s","start":"2026-02-26T20:57:17.402398Z","end":"2026-02-26T20:57:18.896956Z","steps":["trace[250994525] 'process raft request'  (duration: 456.300479ms)","trace[250994525] 'compare'  (duration: 1.037568573s)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:57:18.897983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:57:17.402369Z","time spent":"1.4954908s","remote":"127.0.0.1:47322","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:512 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-26T20:57:19.116328Z","caller":"traceutil/trace.go:171","msg":"trace[2133425161] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"214.717676ms","start":"2026-02-26T20:57:18.901583Z","end":"2026-02-26T20:57:19.116301Z","steps":["trace[2133425161] 'process raft request'  (duration: 147.018692ms)","trace[2133425161] 'compare'  (duration: 67.544717ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:57:19.116696Z","caller":"traceutil/trace.go:171","msg":"trace[311273375] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"214.654454ms","start":"2026-02-26T20:57:18.902034Z","end":"2026-02-26T20:57:19.116688Z","steps":["trace[311273375] 'process raft request'  (duration: 214.383581ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:19.116665Z","caller":"traceutil/trace.go:171","msg":"trace[1197157535] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"214.854023ms","start":"2026-02-26T20:57:18.901776Z","end":"2026-02-26T20:57:19.11663Z","steps":["trace[1197157535] 'process raft request'  (duration: 214.494266ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:19.11718Z","caller":"traceutil/trace.go:171","msg":"trace[1396631399] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"197.293839ms","start":"2026-02-26T20:57:18.919864Z","end":"2026-02-26T20:57:19.117157Z","steps":["trace[1396631399] 'process raft request'  (duration: 196.605196ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:19.57241Z","caller":"traceutil/trace.go:171","msg":"trace[799252024] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"161.670901ms","start":"2026-02-26T20:57:19.410714Z","end":"2026-02-26T20:57:19.572385Z","steps":["trace[799252024] 'process raft request'  (duration: 161.518874ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:21.047261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.430877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-26T20:57:21.047406Z","caller":"traceutil/trace.go:171","msg":"trace[1357408971] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:573; }","duration":"163.610785ms","start":"2026-02-26T20:57:20.883768Z","end":"2026-02-26T20:57:21.047379Z","steps":["trace[1357408971] 'range keys from in-memory index tree'  (duration: 163.334272ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:21.047618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.777197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-26T20:57:21.047668Z","caller":"traceutil/trace.go:171","msg":"trace[1297290436] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:573; }","duration":"291.877972ms","start":"2026-02-26T20:57:20.755778Z","end":"2026-02-26T20:57:21.047656Z","steps":["trace[1297290436] 'range keys from in-memory index tree'  (duration: 291.688653ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:23.834361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.30716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-02-26T20:57:23.83444Z","caller":"traceutil/trace.go:171","msg":"trace[120121326] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:629; }","duration":"133.419965ms","start":"2026-02-26T20:57:23.701001Z","end":"2026-02-26T20:57:23.834421Z","steps":["trace[120121326] 'range keys from in-memory index tree'  (duration: 133.177374ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:24.601509Z","caller":"traceutil/trace.go:171","msg":"trace[1210079012] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"144.954314ms","start":"2026-02-26T20:57:24.456521Z","end":"2026-02-26T20:57:24.601475Z","steps":["trace[1210079012] 'process raft request'  (duration: 86.481054ms)","trace[1210079012] 'compare'  (duration: 58.254751ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:57:24.629691Z","caller":"traceutil/trace.go:171","msg":"trace[679361957] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"101.037516ms","start":"2026-02-26T20:57:24.528636Z","end":"2026-02-26T20:57:24.629674Z","steps":["trace[679361957] 'process raft request'  (duration: 100.875128ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:24.88555Z","caller":"traceutil/trace.go:171","msg":"trace[1719253463] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"166.340017ms","start":"2026-02-26T20:57:24.719182Z","end":"2026-02-26T20:57:24.885522Z","steps":["trace[1719253463] 'process raft request'  (duration: 164.320575ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:24.88548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.680559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"info","ts":"2026-02-26T20:57:24.886074Z","caller":"traceutil/trace.go:171","msg":"trace[1373928737] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:632; }","duration":"179.333309ms","start":"2026-02-26T20:57:24.706715Z","end":"2026-02-26T20:57:24.886048Z","steps":["trace[1373928737] 'range keys from in-memory index tree'  (duration: 178.479429ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:25.223575Z","caller":"traceutil/trace.go:171","msg":"trace[1520890713] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"294.692369ms","start":"2026-02-26T20:57:24.928849Z","end":"2026-02-26T20:57:25.223542Z","steps":["trace[1520890713] 'process raft request'  (duration: 219.709765ms)","trace[1520890713] 'compare'  (duration: 74.558525ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:57:25.223886Z","caller":"traceutil/trace.go:171","msg":"trace[1413769021] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"251.888462ms","start":"2026-02-26T20:57:24.971981Z","end":"2026-02-26T20:57:25.223869Z","steps":["trace[1413769021] 'process raft request'  (duration: 251.529576ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:25.22404Z","caller":"traceutil/trace.go:171","msg":"trace[1229749260] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:656; }","duration":"248.022296ms","start":"2026-02-26T20:57:24.975998Z","end":"2026-02-26T20:57:25.22402Z","steps":["trace[1229749260] 'read index received'  (duration: 172.486466ms)","trace[1229749260] 'applied index is now lower than readState.Index'  (duration: 75.53413ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:57:25.224117Z","caller":"traceutil/trace.go:171","msg":"trace[2089311937] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"163.735169ms","start":"2026-02-26T20:57:25.060351Z","end":"2026-02-26T20:57:25.224086Z","steps":["trace[2089311937] 'process raft request'  (duration: 163.482607ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:25.22447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.942143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"}
{"level":"info","ts":"2026-02-26T20:57:25.224554Z","caller":"traceutil/trace.go:171","msg":"trace[1474774764] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:636; }","duration":"123.079259ms","start":"2026-02-26T20:57:25.101455Z","end":"2026-02-26T20:57:25.224535Z","steps":["trace[1474774764] 'agreement among raft nodes before linearized reading'  (duration: 122.820157ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:25.224541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.543509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-26T20:57:25.224727Z","caller":"traceutil/trace.go:171","msg":"trace[1384394655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"248.724548ms","start":"2026-02-26T20:57:24.975942Z","end":"2026-02-26T20:57:25.224666Z","steps":["trace[1384394655] 'agreement among raft nodes before linearized reading'  (duration: 248.164393ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:35.409695Z","caller":"traceutil/trace.go:171","msg":"trace[230571302] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:769; }","duration":"126.151079ms","start":"2026-02-26T20:57:35.283523Z","end":"2026-02-26T20:57:35.409674Z","steps":["trace[230571302] 'read index received'  (duration: 84.341346ms)","trace[230571302] 'applied index is now lower than readState.Index'  (duration: 41.808983ms)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:57:35.409797Z","caller":"traceutil/trace.go:171","msg":"trace[154172552] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"126.668611ms","start":"2026-02-26T20:57:35.283115Z","end":"2026-02-26T20:57:35.409784Z","steps":["trace[154172552] 'process raft request'  (duration: 100.626206ms)","trace[154172552] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:461; } (duration: 25.838056ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-26T20:57:35.410006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.476603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-26T20:57:35.410029Z","caller":"traceutil/trace.go:171","msg":"trace[86186046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"126.536885ms","start":"2026-02-26T20:57:35.283485Z","end":"2026-02-26T20:57:35.410022Z","steps":["trace[86186046] 'agreement among raft nodes before linearized reading'  (duration: 126.40593ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:57:35.41019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.515203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-02-26T20:57:35.410227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.290373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-26T20:57:35.410271Z","caller":"traceutil/trace.go:171","msg":"trace[1918233858] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:744; }","duration":"123.622967ms","start":"2026-02-26T20:57:35.286628Z","end":"2026-02-26T20:57:35.410251Z","steps":["trace[1918233858] 'agreement among raft nodes before linearized reading'  (duration: 123.420798ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:57:35.410283Z","caller":"traceutil/trace.go:171","msg":"trace[283652568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:744; }","duration":"123.373787ms","start":"2026-02-26T20:57:35.286894Z","end":"2026-02-26T20:57:35.410268Z","steps":["trace[283652568] 'agreement among raft nodes before linearized reading'  (duration: 123.208331ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:58:20.027635Z","caller":"traceutil/trace.go:171","msg":"trace[1525493090] linearizableReadLoop","detail":"{readStateIndex:911; appliedIndex:910; }","duration":"296.164552ms","start":"2026-02-26T20:58:19.731452Z","end":"2026-02-26T20:58:20.027617Z","steps":["trace[1525493090] 'read index received'  (duration: 296.10508ms)","trace[1525493090] 'applied index is now lower than readState.Index'  (duration: 58.532µs)"],"step_count":2}
{"level":"info","ts":"2026-02-26T20:58:20.027714Z","caller":"traceutil/trace.go:171","msg":"trace[1366760324] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"320.681381ms","start":"2026-02-26T20:58:19.707026Z","end":"2026-02-26T20:58:20.027708Z","steps":["trace[1366760324] 'process raft request'  (duration: 320.457665ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:58:20.027818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:58:19.707006Z","time spent":"320.724222ms","remote":"127.0.0.1:47322","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:869 > 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-02-26T20:58:20.027961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.48842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-26T20:58:20.028037Z","caller":"traceutil/trace.go:171","msg":"trace[217547278] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:874; }","duration":"296.632774ms","start":"2026-02-26T20:58:19.731391Z","end":"2026-02-26T20:58:20.028023Z","steps":["trace[217547278] 'agreement among raft nodes before linearized reading'  (duration: 296.47501ms)"],"step_count":1}
{"level":"info","ts":"2026-02-26T20:58:20.049991Z","caller":"traceutil/trace.go:171","msg":"trace[579601216] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"231.032858ms","start":"2026-02-26T20:58:19.818939Z","end":"2026-02-26T20:58:20.049972Z","steps":["trace[579601216] 'process raft request'  (duration: 230.872714ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:58:20.05011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.225424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-02-26T20:58:20.050199Z","caller":"traceutil/trace.go:171","msg":"trace[458013168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:875; }","duration":"279.314466ms","start":"2026-02-26T20:58:19.770831Z","end":"2026-02-26T20:58:20.050145Z","steps":["trace[458013168] 'agreement among raft nodes before linearized reading'  (duration: 279.188293ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:58:20.049984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.891667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-26T20:58:20.050383Z","caller":"traceutil/trace.go:171","msg":"trace[960706124] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:875; }","duration":"308.312298ms","start":"2026-02-26T20:58:19.742038Z","end":"2026-02-26T20:58:20.05035Z","steps":["trace[960706124] 'agreement among raft nodes before linearized reading'  (duration: 307.864776ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:58:20.050495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:58:19.742027Z","time spent":"308.430061ms","remote":"127.0.0.1:47406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":13,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-02-26T20:58:20.05056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.703358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-26T20:58:20.050631Z","caller":"traceutil/trace.go:171","msg":"trace[1767638347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:875; }","duration":"286.793661ms","start":"2026-02-26T20:58:19.763823Z","end":"2026-02-26T20:58:20.050617Z","steps":["trace[1767638347] 'agreement among raft nodes before linearized reading'  (duration: 286.569595ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:58:52.768985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.056341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-26T20:58:52.769048Z","caller":"traceutil/trace.go:171","msg":"trace[987065077] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1004; }","duration":"497.176203ms","start":"2026-02-26T20:58:52.271859Z","end":"2026-02-26T20:58:52.769036Z","steps":["trace[987065077] 'range keys from in-memory index tree'  (duration: 496.877337ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:58:52.769075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:58:52.271839Z","time spent":"497.230945ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-26T20:58:52.76924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.969727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-02-26T20:58:52.769292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.175481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-26T20:58:52.76933Z","caller":"traceutil/trace.go:171","msg":"trace[921351893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1004; }","duration":"363.069879ms","start":"2026-02-26T20:58:52.40624Z","end":"2026-02-26T20:58:52.76931Z","steps":["trace[921351893] 'range keys from in-memory index tree'  (duration: 362.756403ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:58:52.769371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:58:52.406209Z","time spent":"363.153511ms","remote":"127.0.0.1:47322","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-02-26T20:58:52.769369Z","caller":"traceutil/trace.go:171","msg":"trace[460324079] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1004; }","duration":"465.304674ms","start":"2026-02-26T20:58:52.304046Z","end":"2026-02-26T20:58:52.769351Z","steps":["trace[460324079] 'range keys from in-memory index tree'  (duration: 464.954816ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:58:52.769408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:58:52.304025Z","time spent":"465.374125ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-26T20:58:52.769548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.714963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-02-26T20:58:52.769585Z","caller":"traceutil/trace.go:171","msg":"trace[2006036189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1004; }","duration":"429.792424ms","start":"2026-02-26T20:58:52.339782Z","end":"2026-02-26T20:58:52.769575Z","steps":["trace[2006036189] 'range keys from in-memory index tree'  (duration: 429.59241ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-26T20:58:52.769616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T20:58:52.339761Z","time spent":"429.848876ms","remote":"127.0.0.1:47322","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\" "}