{"level":"warn","ts":"2026-02-25T14:58:43.386293Z","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-25T14:58:43.386381Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240: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.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-25T14:58:43.386439Z","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-25T14:58:43.386448Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]}
{"level":"info","ts":"2026-02-25T14:58:43.386468Z","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-25T14:58:43.387058Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]}
{"level":"info","ts":"2026-02-25T14:58:43.387127Z","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.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-25T14:58:43.474128Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"86.802206ms"}
{"level":"info","ts":"2026-02-25T14:58:43.688575Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"}
{"level":"info","ts":"2026-02-25T14:58:43.688777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T14:58:43.689063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"}
{"level":"info","ts":"2026-02-25T14:58:43.689093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T14:58:43.689158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"}
{"level":"info","ts":"2026-02-25T14:58:43.689328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"}
{"level":"warn","ts":"2026-02-25T14:58:43.703417Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T14:58:43.705813Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T14:58:43.72569Z","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-25T14:58:43.74477Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T14:58:43.745047Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T14:58:43.746349Z","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-25T14:58:43.746457Z","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-25T14:58:43.74647Z","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-25T14:58:43.749439Z","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-25T14:58:43.74971Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T14:58:43.749792Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T14:58:43.749887Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"}
{"level":"info","ts":"2026-02-25T14:58:43.749933Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"}
{"level":"info","ts":"2026-02-25T14:58:43.787679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"}
{"level":"info","ts":"2026-02-25T14:58:43.78806Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]}
{"level":"info","ts":"2026-02-25T14:58:44.289678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T14:58:44.289809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T14:58:44.28985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"}
{"level":"info","ts":"2026-02-25T14:58:44.289871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"}
{"level":"info","ts":"2026-02-25T14:58:44.289883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"}
{"level":"info","ts":"2026-02-25T14:58:44.2899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"}
{"level":"info","ts":"2026-02-25T14:58:44.289921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"}
{"level":"info","ts":"2026-02-25T14:58:44.308591Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T14:58:44.308765Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T14:58:44.309028Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T14:58:44.30935Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T14:58:44.309784Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T14:58:44.309845Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T14:58:44.312137Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"}
{"level":"info","ts":"2026-02-25T14:58:44.313697Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T14:58:44.313842Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T14:58:44.313929Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T14:58:44.315136Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T14:58:45.887264Z","caller":"traceutil/trace.go:171","msg":"trace[1302329310] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"146.506897ms","start":"2026-02-25T14:58:45.74072Z","end":"2026-02-25T14:58:45.887227Z","steps":["trace[1302329310] 'process raft request'  (duration: 146.413657ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:45.887384Z","caller":"traceutil/trace.go:171","msg":"trace[1347007062] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"145.585949ms","start":"2026-02-25T14:58:45.741758Z","end":"2026-02-25T14:58:45.887344Z","steps":["trace[1347007062] 'process raft request'  (duration: 145.511959ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:45.887424Z","caller":"traceutil/trace.go:171","msg":"trace[253548824] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"145.253486ms","start":"2026-02-25T14:58:45.74211Z","end":"2026-02-25T14:58:45.887364Z","steps":["trace[253548824] 'process raft request'  (duration: 145.173756ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:45.887469Z","caller":"traceutil/trace.go:171","msg":"trace[1579327406] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"146.705108ms","start":"2026-02-25T14:58:45.740751Z","end":"2026-02-25T14:58:45.887456Z","steps":["trace[1579327406] 'process raft request'  (duration: 146.408456ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:45.887385Z","caller":"traceutil/trace.go:171","msg":"trace[2139050738] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"128.611198ms","start":"2026-02-25T14:58:45.758759Z","end":"2026-02-25T14:58:45.88737Z","steps":["trace[2139050738] 'process raft request'  (duration: 128.585317ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:45.887529Z","caller":"traceutil/trace.go:171","msg":"trace[41417259] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"145.967663ms","start":"2026-02-25T14:58:45.74155Z","end":"2026-02-25T14:58:45.887518Z","steps":["trace[41417259] 'process raft request'  (duration: 145.706191ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:45.887637Z","caller":"traceutil/trace.go:171","msg":"trace[1761535021] linearizableReadLoop","detail":"{readStateIndex:30; appliedIndex:22; }","duration":"131.606881ms","start":"2026-02-25T14:58:45.756021Z","end":"2026-02-25T14:58:45.887627Z","steps":["trace[1761535021] 'read index received'  (duration: 104.129588ms)","trace[1761535021] 'applied index is now lower than readState.Index'  (duration: 27.476303ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:58:45.887862Z","caller":"traceutil/trace.go:171","msg":"trace[360643425] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"145.236306ms","start":"2026-02-25T14:58:45.742616Z","end":"2026-02-25T14:58:45.887852Z","steps":["trace[360643425] 'process raft request'  (duration: 144.695292ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:58:45.887913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.480275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T14:58:45.887957Z","caller":"traceutil/trace.go:171","msg":"trace[228838345] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:27; }","duration":"129.583985ms","start":"2026-02-25T14:58:45.758358Z","end":"2026-02-25T14:58:45.887942Z","steps":["trace[228838345] 'agreement among raft nodes before linearized reading'  (duration: 129.493664ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:58:45.887894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.328063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-25T14:58:45.888212Z","caller":"traceutil/trace.go:171","msg":"trace[1717494771] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:27; }","duration":"147.716147ms","start":"2026-02-25T14:58:45.740484Z","end":"2026-02-25T14:58:45.8882Z","steps":["trace[1717494771] 'agreement among raft nodes before linearized reading'  (duration: 147.354414ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:45.888259Z","caller":"traceutil/trace.go:171","msg":"trace[104016488] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"146.92142ms","start":"2026-02-25T14:58:45.74124Z","end":"2026-02-25T14:58:45.888162Z","steps":["trace[104016488] 'process raft request'  (duration: 145.944572ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:45.888463Z","caller":"traceutil/trace.go:171","msg":"trace[2008250553] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"147.748247ms","start":"2026-02-25T14:58:45.7407Z","end":"2026-02-25T14:58:45.888448Z","steps":["trace[2008250553] 'process raft request'  (duration: 119.438838ms)","trace[2008250553] 'compare'  (duration: 26.909218ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:58:46.453226Z","caller":"traceutil/trace.go:171","msg":"trace[1761284052] linearizableReadLoop","detail":"{readStateIndex:68; appliedIndex:66; }","duration":"184.174296ms","start":"2026-02-25T14:58:46.269025Z","end":"2026-02-25T14:58:46.453199Z","steps":["trace[1761284052] 'read index received'  (duration: 110.372728ms)","trace[1761284052] 'applied index is now lower than readState.Index'  (duration: 73.800328ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:58:46.453504Z","caller":"traceutil/trace.go:171","msg":"trace[1493923079] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"185.219724ms","start":"2026-02-25T14:58:46.268244Z","end":"2026-02-25T14:58:46.453464Z","steps":["trace[1493923079] 'process raft request'  (duration: 184.905271ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:58:46.453561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.508858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/endpoint-controller\" ","response":"range_response_count:1 size:1256"}
{"level":"info","ts":"2026-02-25T14:58:46.453692Z","caller":"traceutil/trace.go:171","msg":"trace[61324378] range","detail":"{range_begin:/registry/flowschemas/endpoint-controller; range_end:; response_count:1; response_revision:63; }","duration":"184.67297ms","start":"2026-02-25T14:58:46.269003Z","end":"2026-02-25T14:58:46.453676Z","steps":["trace[61324378] 'agreement among raft nodes before linearized reading'  (duration: 184.377007ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:46.453523Z","caller":"traceutil/trace.go:171","msg":"trace[1574381119] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"187.035649ms","start":"2026-02-25T14:58:46.26644Z","end":"2026-02-25T14:58:46.453476Z","steps":["trace[1574381119] 'process raft request'  (duration: 112.966579ms)","trace[1574381119] 'compare'  (duration: 73.575696ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:58:49.530383Z","caller":"traceutil/trace.go:171","msg":"trace[588237821] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"108.802766ms","start":"2026-02-25T14:58:49.421555Z","end":"2026-02-25T14:58:49.530358Z","steps":["trace[588237821] 'process raft request'  (duration: 108.623514ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:58:49.675529Z","caller":"traceutil/trace.go:171","msg":"trace[149289378] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"116.602944ms","start":"2026-02-25T14:58:49.558903Z","end":"2026-02-25T14:58:49.675506Z","steps":["trace[149289378] 'process raft request'  (duration: 73.46395ms)","trace[149289378] 'compare'  (duration: 43.005903ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:58:54.786618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.204938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-02-25T14:58:54.786704Z","caller":"traceutil/trace.go:171","msg":"trace[598650164] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:342; }","duration":"173.333808ms","start":"2026-02-25T14:58:54.613353Z","end":"2026-02-25T14:58:54.786687Z","steps":["trace[598650164] 'range keys from in-memory index tree'  (duration: 173.121126ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:58:54.786915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.587713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-02-25T14:58:54.78696Z","caller":"traceutil/trace.go:171","msg":"trace[1919364280] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:342; }","duration":"122.654873ms","start":"2026-02-25T14:58:54.664293Z","end":"2026-02-25T14:58:54.786948Z","steps":["trace[1919364280] 'range keys from in-memory index tree'  (duration: 122.501023ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:00.503141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.380487ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153697513688755339 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:273 > 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-25T14:59:00.503271Z","caller":"traceutil/trace.go:171","msg":"trace[178829507] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:420; }","duration":"605.377399ms","start":"2026-02-25T14:58:59.897853Z","end":"2026-02-25T14:59:00.50323Z","steps":["trace[178829507] 'read index received'  (duration: 1.922534ms)","trace[178829507] 'applied index is now lower than readState.Index'  (duration: 603.453695ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:00.503304Z","caller":"traceutil/trace.go:171","msg":"trace[1829512235] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"755.455383ms","start":"2026-02-25T14:58:59.747813Z","end":"2026-02-25T14:59:00.503268Z","steps":["trace[1829512235] 'process raft request'  (duration: 152.036998ms)","trace[1829512235] 'compare'  (duration: 602.237166ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:00.503376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.525531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T14:59:00.503411Z","caller":"traceutil/trace.go:171","msg":"trace[795630771] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:405; }","duration":"605.598151ms","start":"2026-02-25T14:58:59.897802Z","end":"2026-02-25T14:59:00.5034Z","steps":["trace[795630771] 'agreement among raft nodes before linearized reading'  (duration: 605.52318ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:00.503446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:58:59.747795Z","time spent":"755.577124ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:273 > 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-25T14:59:00.50345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:58:59.897781Z","time spent":"605.661341ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T14:59:00.503811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.351245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-25T14:59:00.503849Z","caller":"traceutil/trace.go:171","msg":"trace[554649498] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:405; }","duration":"443.420545ms","start":"2026-02-25T14:59:00.06042Z","end":"2026-02-25T14:59:00.50384Z","steps":["trace[554649498] 'agreement among raft nodes before linearized reading'  (duration: 443.358905ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:00.503877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:00.060402Z","time spent":"443.469296ms","remote":"127.0.0.1:45792","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-25T14:59:00.503993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.656415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4015"}
{"level":"info","ts":"2026-02-25T14:59:00.504078Z","caller":"traceutil/trace.go:171","msg":"trace[1004485412] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:405; }","duration":"327.774556ms","start":"2026-02-25T14:59:00.176281Z","end":"2026-02-25T14:59:00.504056Z","steps":["trace[1004485412] 'agreement among raft nodes before linearized reading'  (duration: 327.601584ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:00.504123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:00.176263Z","time spent":"327.852136ms","remote":"127.0.0.1:45714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4038,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-25T14:59:01.258323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.088039ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153697513688755342 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:399 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:01.258387Z","caller":"traceutil/trace.go:171","msg":"trace[514510884] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"751.229081ms","start":"2026-02-25T14:59:00.507147Z","end":"2026-02-25T14:59:01.258376Z","steps":["trace[514510884] 'process raft request'  (duration: 540.028721ms)","trace[514510884] 'compare'  (duration: 210.779817ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:01.258418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:00.50713Z","time spent":"751.274592ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:399 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T14:59:01.259245Z","caller":"traceutil/trace.go:171","msg":"trace[1253537854] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"750.891729ms","start":"2026-02-25T14:59:00.508312Z","end":"2026-02-25T14:59:01.259203Z","steps":["trace[1253537854] 'process raft request'  (duration: 750.664138ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:01.259383Z","caller":"traceutil/trace.go:171","msg":"trace[1756505417] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:421; }","duration":"413.198844ms","start":"2026-02-25T14:59:00.846166Z","end":"2026-02-25T14:59:01.259364Z","steps":["trace[1756505417] 'read index received'  (duration: 201.191099ms)","trace[1756505417] 'applied index is now lower than readState.Index'  (duration: 212.007065ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:01.25945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:00.508303Z","time spent":"751.03053ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:400 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T14:59:01.259566Z","caller":"traceutil/trace.go:171","msg":"trace[122083293] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"742.21927ms","start":"2026-02-25T14:59:00.517338Z","end":"2026-02-25T14:59:01.259557Z","steps":["trace[122083293] 'process raft request'  (duration: 741.721496ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:01.259642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:00.517324Z","time spent":"742.29098ms","remote":"127.0.0.1:45714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4007,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:360 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3973 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-02-25T14:59:01.259727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.548987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6898"}
{"level":"info","ts":"2026-02-25T14:59:01.259772Z","caller":"traceutil/trace.go:171","msg":"trace[730939891] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:408; }","duration":"413.629557ms","start":"2026-02-25T14:59:00.846131Z","end":"2026-02-25T14:59:01.25976Z","steps":["trace[730939891] 'agreement among raft nodes before linearized reading'  (duration: 413.479236ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:01.259897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:00.846114Z","time spent":"413.771598ms","remote":"127.0.0.1:45722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6921,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "}
{"level":"warn","ts":"2026-02-25T14:59:01.260159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.116872ms","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-25T14:59:01.260191Z","caller":"traceutil/trace.go:171","msg":"trace[46346786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:408; }","duration":"401.170552ms","start":"2026-02-25T14:59:00.859014Z","end":"2026-02-25T14:59:01.260184Z","steps":["trace[46346786] 'agreement among raft nodes before linearized reading'  (duration: 401.120462ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:01.260205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:00.859003Z","time spent":"401.198803ms","remote":"127.0.0.1:45792","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-25T14:59:01.260205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.184422ms","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-25T14:59:01.260268Z","caller":"traceutil/trace.go:171","msg":"trace[1372767869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:408; }","duration":"401.256773ms","start":"2026-02-25T14:59:00.858992Z","end":"2026-02-25T14:59:01.260249Z","steps":["trace[1372767869] 'agreement among raft nodes before linearized reading'  (duration: 401.133202ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:01.260327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:00.858929Z","time spent":"401.384584ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-25T14:59:15.586204Z","caller":"traceutil/trace.go:171","msg":"trace[1082267561] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"255.20373ms","start":"2026-02-25T14:59:15.330984Z","end":"2026-02-25T14:59:15.586188Z","steps":["trace[1082267561] 'process raft request'  (duration: 255.109789ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:15.58798Z","caller":"traceutil/trace.go:171","msg":"trace[1434314344] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:521; }","duration":"255.23801ms","start":"2026-02-25T14:59:15.332718Z","end":"2026-02-25T14:59:15.587956Z","steps":["trace[1434314344] 'read index received'  (duration: 253.438648ms)","trace[1434314344] 'applied index is now lower than readState.Index'  (duration: 1.798442ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:15.588192Z","caller":"traceutil/trace.go:171","msg":"trace[1127295066] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"256.185037ms","start":"2026-02-25T14:59:15.331995Z","end":"2026-02-25T14:59:15.58818Z","steps":["trace[1127295066] 'process raft request'  (duration: 255.870065ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:15.588394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.659763ms","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-25T14:59:15.588429Z","caller":"traceutil/trace.go:171","msg":"trace[263242443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:504; }","duration":"255.719192ms","start":"2026-02-25T14:59:15.332698Z","end":"2026-02-25T14:59:15.588417Z","steps":["trace[263242443] 'agreement among raft nodes before linearized reading'  (duration: 255.646563ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:15.58857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.616897ms","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-25T14:59:15.58863Z","caller":"traceutil/trace.go:171","msg":"trace[1247963736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:504; }","duration":"251.705698ms","start":"2026-02-25T14:59:15.33691Z","end":"2026-02-25T14:59:15.588616Z","steps":["trace[1247963736] 'agreement among raft nodes before linearized reading'  (duration: 251.582937ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:21.826581Z","caller":"traceutil/trace.go:171","msg":"trace[1881896349] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"204.315242ms","start":"2026-02-25T14:59:21.622242Z","end":"2026-02-25T14:59:21.826557Z","steps":["trace[1881896349] 'read index received'  (duration: 204.130832ms)","trace[1881896349] 'applied index is now lower than readState.Index'  (duration: 183.37µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:21.82668Z","caller":"traceutil/trace.go:171","msg":"trace[175620556] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"205.510342ms","start":"2026-02-25T14:59:21.62112Z","end":"2026-02-25T14:59:21.826631Z","steps":["trace[175620556] 'process raft request'  (duration: 205.296311ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:21.826749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.48131ms","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-25T14:59:21.826785Z","caller":"traceutil/trace.go:171","msg":"trace[319137254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:544; }","duration":"204.552044ms","start":"2026-02-25T14:59:21.622223Z","end":"2026-02-25T14:59:21.826775Z","steps":["trace[319137254] 'agreement among raft nodes before linearized reading'  (duration: 204.46689ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:21.826938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.60484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-02-25T14:59:21.827022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.590959ms","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-25T14:59:21.827092Z","caller":"traceutil/trace.go:171","msg":"trace[1391897584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:544; }","duration":"200.712186ms","start":"2026-02-25T14:59:21.626362Z","end":"2026-02-25T14:59:21.827074Z","steps":["trace[1391897584] 'agreement among raft nodes before linearized reading'  (duration: 200.563048ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:21.827112Z","caller":"traceutil/trace.go:171","msg":"trace[493805305] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:544; }","duration":"200.713955ms","start":"2026-02-25T14:59:21.626292Z","end":"2026-02-25T14:59:21.827006Z","steps":["trace[493805305] 'agreement among raft nodes before linearized reading'  (duration: 200.570058ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:21.827614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.219711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-z4cjb\" ","response":"range_response_count:1 size:16656"}
{"level":"info","ts":"2026-02-25T14:59:21.827723Z","caller":"traceutil/trace.go:171","msg":"trace[1777132674] range","detail":"{range_begin:/registry/pods/kube-system/cilium-z4cjb; range_end:; response_count:1; response_revision:544; }","duration":"201.347548ms","start":"2026-02-25T14:59:21.626358Z","end":"2026-02-25T14:59:21.827705Z","steps":["trace[1777132674] 'agreement among raft nodes before linearized reading'  (duration: 200.580308ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:21.98861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.407363ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153697513688755615 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:539 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:21.988704Z","caller":"traceutil/trace.go:171","msg":"trace[1855251437] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"157.454353ms","start":"2026-02-25T14:59:21.831233Z","end":"2026-02-25T14:59:21.988687Z","steps":["trace[1855251437] 'process raft request'  (duration: 35.85621ms)","trace[1855251437] 'compare'  (duration: 121.227923ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:22.289171Z","caller":"traceutil/trace.go:171","msg":"trace[766072336] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"457.240288ms","start":"2026-02-25T14:59:21.831905Z","end":"2026-02-25T14:59:22.289145Z","steps":["trace[766072336] 'process raft request'  (duration: 433.570642ms)","trace[766072336] 'compare'  (duration: 23.504778ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:22.289326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:21.831886Z","time spent":"457.358084ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:538 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T14:59:22.289488Z","caller":"traceutil/trace.go:171","msg":"trace[1933308001] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"457.188866ms","start":"2026-02-25T14:59:21.832261Z","end":"2026-02-25T14:59:22.28945Z","steps":["trace[1933308001] 'process raft request'  (duration: 456.842078ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:22.289541Z","caller":"traceutil/trace.go:171","msg":"trace[482182948] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"449.493139ms","start":"2026-02-25T14:59:21.840031Z","end":"2026-02-25T14:59:22.289524Z","steps":["trace[482182948] 'process raft request'  (duration: 449.31721ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:22.289679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:21.832252Z","time spent":"457.325212ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:537 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-25T14:59:22.289721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:21.840023Z","time spent":"449.559302ms","remote":"127.0.0.1:45722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-z4cjb\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-z4cjb\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-z4cjb\" > >"}
{"level":"warn","ts":"2026-02-25T14:59:23.546781Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688755614,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T14:59:24.047385Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688755614,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T14:59:24.097484Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.330504197s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T14:59:24.129205Z","caller":"traceutil/trace.go:171","msg":"trace[1177200446] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"1.083485808s","start":"2026-02-25T14:59:23.045693Z","end":"2026-02-25T14:59:24.129179Z","steps":["trace[1177200446] 'read index received'  (duration: 1.05216816s)","trace[1177200446] 'applied index is now lower than readState.Index'  (duration: 31.316028ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:24.1294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.128347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-25T14:59:24.129419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.187347ms","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-25T14:59:24.129442Z","caller":"traceutil/trace.go:171","msg":"trace[569354078] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:548; }","duration":"297.234192ms","start":"2026-02-25T14:59:23.832198Z","end":"2026-02-25T14:59:24.129432Z","steps":["trace[569354078] 'agreement among raft nodes before linearized reading'  (duration: 297.123227ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:24.129472Z","caller":"traceutil/trace.go:171","msg":"trace[1851397083] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:548; }","duration":"137.283502ms","start":"2026-02-25T14:59:23.992176Z","end":"2026-02-25T14:59:24.129459Z","steps":["trace[1851397083] 'agreement among raft nodes before linearized reading'  (duration: 137.168996ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:24.129576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.083626374s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T14:59:24.129771Z","caller":"traceutil/trace.go:171","msg":"trace[1526435894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"1.084044176s","start":"2026-02-25T14:59:23.045653Z","end":"2026-02-25T14:59:24.129698Z","steps":["trace[1526435894] 'agreement among raft nodes before linearized reading'  (duration: 1.083602124s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:24.129966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:23.045634Z","time spent":"1.084318019s","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T14:59:26.1204Z","caller":"traceutil/trace.go:171","msg":"trace[179256111] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"195.760174ms","start":"2026-02-25T14:59:25.924599Z","end":"2026-02-25T14:59:26.120359Z","steps":["trace[179256111] 'process raft request'  (duration: 195.529182ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:09.887917Z","caller":"traceutil/trace.go:171","msg":"trace[891824884] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"286.616862ms","start":"2026-02-25T15:01:09.601281Z","end":"2026-02-25T15:01:09.887897Z","steps":["trace[891824884] 'process raft request'  (duration: 286.49511ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:17.19839Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:17.698546Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:18.199686Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:18.700605Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:18.820257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000953034s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:18.820359Z","caller":"traceutil/trace.go:171","msg":"trace[1655571367] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001116877s","start":"2026-02-25T15:01:16.819224Z","end":"2026-02-25T15:01:18.820341Z","steps":["trace[1655571367] 'agreement among raft nodes before linearized reading'  (duration: 2.000992425s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:18.820408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:16.819202Z","time spent":"2.001196249s","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 15:01:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:19.045723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000215766s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:19.045785Z","caller":"traceutil/trace.go:171","msg":"trace[877582406] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000328338s","start":"2026-02-25T15:01:17.045442Z","end":"2026-02-25T15:01:19.045771Z","steps":["trace[877582406] 'agreement among raft nodes before linearized reading'  (duration: 2.000254097s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:19.045827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:17.045428Z","time spent":"2.000390359s","remote":"127.0.0.1:45576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 15:01:19 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:19.201326Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:19.701796Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:20.202957Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:20.703859Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:21.053932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999991497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T15:01:21.054053Z","caller":"traceutil/trace.go:171","msg":"trace[946106964] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00017677s","start":"2026-02-25T15:01:19.053853Z","end":"2026-02-25T15:01:21.054029Z","steps":["trace[946106964] 'agreement among raft nodes before linearized reading'  (duration: 2.000033637s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:21.054217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:19.053827Z","time spent":"2.000371954s","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T15:01:21.139912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:16.140682Z","time spent":"4.999227502s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/25 15:01:21 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:21.204061Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:21.697041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999363312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:21.697119Z","caller":"traceutil/trace.go:171","msg":"trace[255384640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999497213s","start":"2026-02-25T15:01:16.697603Z","end":"2026-02-25T15:01:21.6971Z","steps":["trace[255384640] 'agreement among raft nodes before linearized reading'  (duration: 4.999401762s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:21.697164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:16.69758Z","time spent":"4.999574795s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/02/25 15:01:21 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:21.70217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999171056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:21.702251Z","caller":"traceutil/trace.go:171","msg":"trace[1479772601] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999281658s","start":"2026-02-25T15:01:16.702949Z","end":"2026-02-25T15:01:21.702231Z","steps":["trace[1479772601] 'agreement among raft nodes before linearized reading'  (duration: 4.999186087s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:21.702306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:16.702939Z","time spent":"4.999357169s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/02/25 15:01:21 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:21.704329Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688756863,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:21.792419Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.651552714s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T15:01:23.054788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99966957s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:23.054871Z","caller":"traceutil/trace.go:171","msg":"trace[608675039] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999822773s","start":"2026-02-25T15:01:21.055029Z","end":"2026-02-25T15:01:23.054852Z","steps":["trace[608675039] 'agreement among raft nodes before linearized reading'  (duration: 1.99969671s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:23.054917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:21.055012Z","time spent":"1.999896344s","remote":"127.0.0.1:45576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 15:01:23 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:25.063644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000397364s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T15:01:25.063735Z","caller":"traceutil/trace.go:171","msg":"trace[614208769] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000546577s","start":"2026-02-25T15:01:23.06317Z","end":"2026-02-25T15:01:25.063717Z","steps":["trace[614208769] 'agreement among raft nodes before linearized reading'  (duration: 2.000422385s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:25.063786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:23.063153Z","time spent":"2.000623838s","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 15:01:25 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:25.824937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:18.824316Z","time spent":"7.000614567s","remote":"127.0.0.1:45644","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-25T15:01:26.135424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.992806717s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:26.135571Z","caller":"traceutil/trace.go:171","msg":"trace[1821892659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"2.993006661s","start":"2026-02-25T15:01:23.142544Z","end":"2026-02-25T15:01:26.135551Z","steps":["trace[1821892659] 'agreement among raft nodes before linearized reading'  (duration: 2.992840808s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:26.135656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:23.142525Z","time spent":"2.993118062s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/25 15:01:26 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:26.697128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.997526553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:26.697288Z","caller":"traceutil/trace.go:171","msg":"trace[1116385965] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"2.997729817s","start":"2026-02-25T15:01:23.699539Z","end":"2026-02-25T15:01:26.697269Z","steps":["trace[1116385965] 'agreement among raft nodes before linearized reading'  (duration: 2.997549704s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:26.697451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:23.699523Z","time spent":"2.997883379s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/02/25 15:01:26 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:26.702403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.998901094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:26.702464Z","caller":"traceutil/trace.go:171","msg":"trace[1885103625] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"2.999037437s","start":"2026-02-25T15:01:23.703413Z","end":"2026-02-25T15:01:26.70245Z","steps":["trace[1885103625] 'agreement among raft nodes before linearized reading'  (duration: 2.998921905s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:26.702501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:23.703396Z","time spent":"2.999096608s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/02/25 15:01:26 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:26.833837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.00008239s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:26.833941Z","caller":"traceutil/trace.go:171","msg":"trace[710539911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"10.000256353s","start":"2026-02-25T15:01:16.83367Z","end":"2026-02-25T15:01:26.833927Z","steps":["trace[710539911] 'agreement among raft nodes before linearized reading'  (duration: 10.000119381s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:26.833844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"10.000596279s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:26.834076Z","caller":"traceutil/trace.go:171","msg":"trace[1034317982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"10.000864754s","start":"2026-02-25T15:01:16.83319Z","end":"2026-02-25T15:01:26.834054Z","steps":["trace[1034317982] 'agreement among raft nodes before linearized reading'  (duration: 10.00061136s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:26.834037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:16.833647Z","time spent":"10.000378026s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
2026/02/25 15:01:26 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:26.834137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:16.833179Z","time spent":"10.000943235s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
2026/02/25 15:01:26 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:27.063996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000284956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T15:01:27.064051Z","caller":"traceutil/trace.go:171","msg":"trace[444942839] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000384298s","start":"2026-02-25T15:01:25.063655Z","end":"2026-02-25T15:01:27.064039Z","steps":["trace[444942839] 'agreement among raft nodes before linearized reading'  (duration: 2.000324177s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:27.064085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:25.063636Z","time spent":"2.000441159s","remote":"127.0.0.1:45576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 15:01:27 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:27.248181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:20.247133Z","time spent":"7.001045074s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-25T15:01:27.503671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000118096s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T15:01:27.503727Z","caller":"traceutil/trace.go:171","msg":"trace[1919594913] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000242559s","start":"2026-02-25T15:01:25.503472Z","end":"2026-02-25T15:01:27.503714Z","steps":["trace[1919594913] 'agreement among raft nodes before linearized reading'  (duration: 2.000179938s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:27.503764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:25.503453Z","time spent":"2.000303709s","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T15:01:28.818775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000095374s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T15:01:28.818869Z","caller":"traceutil/trace.go:171","msg":"trace[183059296] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000243086s","start":"2026-02-25T15:01:26.818603Z","end":"2026-02-25T15:01:28.818846Z","steps":["trace[183059296] 'agreement among raft nodes before linearized reading'  (duration: 2.000125244s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:28.81892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:26.818582Z","time spent":"2.000328718s","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T15:01:29.072261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000680258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T15:01:29.07233Z","caller":"traceutil/trace.go:171","msg":"trace[594329517] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00082059s","start":"2026-02-25T15:01:27.071494Z","end":"2026-02-25T15:01:29.072314Z","steps":["trace[594329517] 'agreement among raft nodes before linearized reading'  (duration: 2.000737229s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:29.072374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:27.071483Z","time spent":"2.000882392s","remote":"127.0.0.1:45576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T15:01:29.161158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:22.160676Z","time spent":"7.000474624s","remote":"127.0.0.1:45714","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-25T15:01:29.928584Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"47859c954f3b7230","error":"etcdserver: request timed out"}
{"level":"warn","ts":"2026-02-25T15:01:30.021243Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"8.192366189s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T15:01:30.021387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.885413058s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:30.021542Z","caller":"traceutil/trace.go:171","msg":"trace[467876153] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1050; }","duration":"1.885613801s","start":"2026-02-25T15:01:28.135902Z","end":"2026-02-25T15:01:30.021516Z","steps":["trace[467876153] 'range keys from in-memory index tree'  (duration: 1.885391508s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:30.024322Z","caller":"traceutil/trace.go:171","msg":"trace[1960327809] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1095; }","duration":"13.326651465s","start":"2026-02-25T15:01:16.697653Z","end":"2026-02-25T15:01:30.024305Z","steps":["trace[1960327809] 'read index received'  (duration: 5.095017636s)","trace[1960327809] 'applied index is now lower than readState.Index'  (duration: 8.231632519s)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:30.135232Z","caller":"traceutil/trace.go:171","msg":"trace[1746323244] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"5.865679489s","start":"2026-02-25T15:01:24.269526Z","end":"2026-02-25T15:01:30.135205Z","steps":["trace[1746323244] 'process raft request'  (duration: 5.864829125s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.135382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:24.269502Z","time spent":"5.865797661s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1042 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-25T15:01:30.174575Z","caller":"traceutil/trace.go:171","msg":"trace[1539111759] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"4.345308445s","start":"2026-02-25T15:01:25.82921Z","end":"2026-02-25T15:01:30.174519Z","steps":["trace[1539111759] 'process raft request'  (duration: 4.305971575s)","trace[1539111759] 'compare'  (duration: 39.093556ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:30.174633Z","caller":"traceutil/trace.go:171","msg":"trace[1716431427] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"3.339006399s","start":"2026-02-25T15:01:26.835599Z","end":"2026-02-25T15:01:30.174606Z","steps":["trace[1716431427] 'process raft request'  (duration: 3.338883077s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:30.174652Z","caller":"traceutil/trace.go:171","msg":"trace[1805461448] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"3.475399915s","start":"2026-02-25T15:01:26.699208Z","end":"2026-02-25T15:01:30.174608Z","steps":["trace[1805461448] 'process raft request'  (duration: 3.475219282s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.174758Z","caller":"etcdserver/util.go:123","msg":"failed to apply request","took":"128.261µs","request":"header:<ID:5153697513688756875 > lease_revoke:<id:47859c954f3b7230>","response":"size:28","error":"lease not found"}
{"level":"warn","ts":"2026-02-25T15:01:30.174788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:25.829195Z","time spent":"4.345481027s","remote":"127.0.0.1:45644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62\" value_size:672 lease:5153697513688756474 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T15:01:30.17481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:26.835579Z","time spent":"3.339113549s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":411,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1047 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:361 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T15:01:30.17486Z","caller":"traceutil/trace.go:171","msg":"trace[242545131] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1098; }","duration":"150.467018ms","start":"2026-02-25T15:01:30.024373Z","end":"2026-02-25T15:01:30.17484Z","steps":["trace[242545131] 'read index received'  (duration: 76.111808ms)","trace[242545131] 'applied index is now lower than readState.Index'  (duration: 74.35407ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:01:30.17493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.673414071s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:30.174961Z","caller":"traceutil/trace.go:171","msg":"trace[141101696] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:0; response_revision:1059; }","duration":"12.673506142s","start":"2026-02-25T15:01:17.501445Z","end":"2026-02-25T15:01:30.174951Z","steps":["trace[141101696] 'agreement among raft nodes before linearized reading'  (duration: 12.673445191s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.174968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:26.699183Z","time spent":"3.475542857s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1045 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T15:01:30.174993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:17.50142Z","time spent":"12.673565473s","remote":"127.0.0.1:45606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.240\" "}
{"level":"warn","ts":"2026-02-25T15:01:30.175121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.037199239s","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-25T15:01:30.175148Z","caller":"traceutil/trace.go:171","msg":"trace[1270437611] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1059; }","duration":"4.037264611s","start":"2026-02-25T15:01:26.137876Z","end":"2026-02-25T15:01:30.17514Z","steps":["trace[1270437611] 'agreement among raft nodes before linearized reading'  (duration: 4.037165119s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:26.137849Z","time spent":"4.037314581s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-25T15:01:30.175232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.124942667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T15:01:30.175258Z","caller":"traceutil/trace.go:171","msg":"trace[1106473008] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"3.339348223s","start":"2026-02-25T15:01:26.835901Z","end":"2026-02-25T15:01:30.175249Z","steps":["trace[1106473008] 'process raft request'  (duration: 3.338626342s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:30.175262Z","caller":"traceutil/trace.go:171","msg":"trace[1542997920] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1059; }","duration":"4.124974877s","start":"2026-02-25T15:01:26.050278Z","end":"2026-02-25T15:01:30.175253Z","steps":["trace[1542997920] 'agreement among raft nodes before linearized reading'  (duration: 4.124925147s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.17529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:26.050246Z","time spent":"4.125036188s","remote":"127.0.0.1:45904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:30.175295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:26.835879Z","time spent":"3.339394414s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1048 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:363 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-02-25T15:01:30.175296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.808507933s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T15:01:30.175329Z","caller":"traceutil/trace.go:171","msg":"trace[1413415765] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1059; }","duration":"9.808610825s","start":"2026-02-25T15:01:20.36671Z","end":"2026-02-25T15:01:30.175321Z","steps":["trace[1413415765] 'agreement among raft nodes before linearized reading'  (duration: 9.808519563s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:20.36669Z","time spent":"9.808659505s","remote":"127.0.0.1:45714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:30.175398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.713585871s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:30.175411Z","caller":"traceutil/trace.go:171","msg":"trace[1558989564] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1059; }","duration":"2.923327873s","start":"2026-02-25T15:01:27.252075Z","end":"2026-02-25T15:01:30.175403Z","steps":["trace[1558989564] 'process raft request'  (duration: 2.92249531s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:30.175434Z","caller":"traceutil/trace.go:171","msg":"trace[1829682173] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1059; }","duration":"6.713649351s","start":"2026-02-25T15:01:23.461773Z","end":"2026-02-25T15:01:30.175422Z","steps":["trace[1829682173] 'agreement among raft nodes before linearized reading'  (duration: 6.71359362s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:27.252061Z","time spent":"2.923366583s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":720,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1027 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-25T15:01:30.175457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:23.461759Z","time spent":"6.713692192s","remote":"127.0.0.1:44434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:30.175463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"11.858801142s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:5 size:1780"}
{"level":"info","ts":"2026-02-25T15:01:30.175491Z","caller":"traceutil/trace.go:171","msg":"trace[2023590489] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:5; response_revision:1059; }","duration":"11.858861853s","start":"2026-02-25T15:01:18.316621Z","end":"2026-02-25T15:01:30.175483Z","steps":["trace[2023590489] 'agreement among raft nodes before linearized reading'  (duration: 11.858785952s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.800881995s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:30.175518Z","caller":"etcdserver/server.go:1165","msg":"failed to revoke lease","lease-id":"47859c954f3b7230","error":"lease not found"}
{"level":"warn","ts":"2026-02-25T15:01:30.175521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:18.316599Z","time spent":"11.858911684s","remote":"127.0.0.1:45682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":5,"response size":1803,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 "}
{"level":"warn","ts":"2026-02-25T15:01:30.175578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.186854257s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T15:01:30.175601Z","caller":"traceutil/trace.go:171","msg":"trace[854770750] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1059; }","duration":"4.186919288s","start":"2026-02-25T15:01:25.988675Z","end":"2026-02-25T15:01:30.175594Z","steps":["trace[854770750] 'agreement among raft nodes before linearized reading'  (duration: 4.186878167s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.094124679s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:30.17562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:25.988654Z","time spent":"4.186960929s","remote":"127.0.0.1:45722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "}
{"level":"info","ts":"2026-02-25T15:01:30.175626Z","caller":"traceutil/trace.go:171","msg":"trace[1672446365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"1.09417573s","start":"2026-02-25T15:01:29.081444Z","end":"2026-02-25T15:01:30.17562Z","steps":["trace[1672446365] 'agreement among raft nodes before linearized reading'  (duration: 1.094149639s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:29.081416Z","time spent":"1.094225781s","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T15:01:30.175581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010556602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5234"}
{"level":"info","ts":"2026-02-25T15:01:30.175713Z","caller":"traceutil/trace.go:171","msg":"trace[881579728] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1059; }","duration":"1.010717785s","start":"2026-02-25T15:01:29.164987Z","end":"2026-02-25T15:01:30.175705Z","steps":["trace[881579728] 'agreement among raft nodes before linearized reading'  (duration: 1.010548942s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.214419756s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:30.175734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:29.164967Z","time spent":"1.010761355s","remote":"127.0.0.1:45714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5257,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-25T15:01:30.175745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.949055759s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T15:01:30.175753Z","caller":"traceutil/trace.go:171","msg":"trace[1220866498] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1059; }","duration":"12.214504378s","start":"2026-02-25T15:01:17.96124Z","end":"2026-02-25T15:01:30.175744Z","steps":["trace[1220866498] 'agreement among raft nodes before linearized reading'  (duration: 12.214463307s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:30.175764Z","caller":"traceutil/trace.go:171","msg":"trace[525223402] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1059; }","duration":"1.94911622s","start":"2026-02-25T15:01:28.226642Z","end":"2026-02-25T15:01:30.175758Z","steps":["trace[525223402] 'agreement among raft nodes before linearized reading'  (duration: 1.949077219s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:28.226621Z","time spent":"1.94915663s","remote":"127.0.0.1:55956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:30.175784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:17.961212Z","time spent":"12.214563349s","remote":"127.0.0.1:44444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:30.175684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"12.150099645s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:30.175861Z","caller":"traceutil/trace.go:171","msg":"trace[1381242763] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1059; }","duration":"12.150319627s","start":"2026-02-25T15:01:18.025534Z","end":"2026-02-25T15:01:30.175854Z","steps":["trace[1381242763] 'agreement among raft nodes before linearized reading'  (duration: 12.150124794s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:18.025515Z","time spent":"12.150361149s","remote":"127.0.0.1:45992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-02-25T15:01:30.175524Z","caller":"traceutil/trace.go:171","msg":"trace[709866754] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1059; }","duration":"6.800949165s","start":"2026-02-25T15:01:23.374566Z","end":"2026-02-25T15:01:30.175515Z","steps":["trace[709866754] 'agreement among raft nodes before linearized reading'  (duration: 6.800901704s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.108921269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7045"}
{"level":"info","ts":"2026-02-25T15:01:30.175922Z","caller":"traceutil/trace.go:171","msg":"trace[255777201] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:1059; }","duration":"3.10896789s","start":"2026-02-25T15:01:27.066948Z","end":"2026-02-25T15:01:30.175916Z","steps":["trace[255777201] 'agreement among raft nodes before linearized reading'  (duration: 3.108914429s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.175921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:23.374542Z","time spent":"6.801367732s","remote":"127.0.0.1:55996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:30.175938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:27.066936Z","time spent":"3.108998401s","remote":"127.0.0.1:45722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7068,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "}
{"level":"warn","ts":"2026-02-25T15:01:30.520915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.496488ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153697513688756880 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:47859c954f3b728f>","response":"size:40"}
{"level":"info","ts":"2026-02-25T15:01:30.521011Z","caller":"traceutil/trace.go:171","msg":"trace[1931041138] linearizableReadLoop","detail":"{readStateIndex:1108; appliedIndex:1107; }","duration":"340.276897ms","start":"2026-02-25T15:01:30.180718Z","end":"2026-02-25T15:01:30.520995Z","steps":["trace[1931041138] 'read index received'  (duration: 170.596176ms)","trace[1931041138] 'applied index is now lower than readState.Index'  (duration: 169.679141ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:01:30.52119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.46117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:1 size:686"}
{"level":"warn","ts":"2026-02-25T15:01:30.52113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:30.17878Z","time spent":"342.32527ms","remote":"127.0.0.1:45606","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-25T15:01:30.521218Z","caller":"traceutil/trace.go:171","msg":"trace[1093829231] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:1; response_revision:1059; }","duration":"340.538292ms","start":"2026-02-25T15:01:30.180672Z","end":"2026-02-25T15:01:30.52121Z","steps":["trace[1093829231] 'agreement among raft nodes before linearized reading'  (duration: 340.404809ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.521254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:30.180652Z","time spent":"340.595862ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":709,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "}
{"level":"info","ts":"2026-02-25T15:01:30.670581Z","caller":"traceutil/trace.go:171","msg":"trace[350536324] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"149.524461ms","start":"2026-02-25T15:01:30.521029Z","end":"2026-02-25T15:01:30.670553Z","steps":["trace[350536324] 'read index received'  (duration: 111.246709ms)","trace[350536324] 'applied index is now lower than readState.Index'  (duration: 38.276832ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:01:30.670697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.678093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/default/\" range_end:\"/registry/secrets/default0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:30.67077Z","caller":"traceutil/trace.go:171","msg":"trace[2146167074] range","detail":"{range_begin:/registry/secrets/default/; range_end:/registry/secrets/default0; response_count:0; response_revision:1060; }","duration":"439.816506ms","start":"2026-02-25T15:01:30.230935Z","end":"2026-02-25T15:01:30.670752Z","steps":["trace[2146167074] 'agreement among raft nodes before linearized reading'  (duration: 439.685843ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.670778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.294505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:30.670811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:30.230905Z","time spent":"439.897377ms","remote":"127.0.0.1:45662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/default/\" range_end:\"/registry/secrets/default0\" "}
{"level":"info","ts":"2026-02-25T15:01:30.670846Z","caller":"traceutil/trace.go:171","msg":"trace[2028190096] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1060; }","duration":"469.397156ms","start":"2026-02-25T15:01:30.201416Z","end":"2026-02-25T15:01:30.670813Z","steps":["trace[2028190096] 'agreement among raft nodes before linearized reading'  (duration: 469.315954ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.670883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:30.201395Z","time spent":"469.478188ms","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T15:01:30.671013Z","caller":"traceutil/trace.go:171","msg":"trace[117914151] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"469.64174ms","start":"2026-02-25T15:01:30.201354Z","end":"2026-02-25T15:01:30.670995Z","steps":["trace[117914151] 'process raft request'  (duration: 430.9198ms)","trace[117914151] 'compare'  (duration: 38.15014ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:01:30.670941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.402902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62\" ","response":"range_response_count:1 size:774"}
{"level":"warn","ts":"2026-02-25T15:01:30.671111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:30.20132Z","time spent":"469.731602ms","remote":"127.0.0.1:45722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7222,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:436 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7164 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"info","ts":"2026-02-25T15:01:30.671101Z","caller":"traceutil/trace.go:171","msg":"trace[282855939] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62; range_end:; response_count:1; response_revision:1060; }","duration":"489.580105ms","start":"2026-02-25T15:01:30.181504Z","end":"2026-02-25T15:01:30.671084Z","steps":["trace[282855939] 'agreement among raft nodes before linearized reading'  (duration: 489.158348ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.671178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:30.181493Z","time spent":"489.662986ms","remote":"127.0.0.1:45644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62\" "}
{"level":"info","ts":"2026-02-25T15:01:30.673193Z","caller":"traceutil/trace.go:171","msg":"trace[1286742278] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"147.184334ms","start":"2026-02-25T15:01:30.525993Z","end":"2026-02-25T15:01:30.673178Z","steps":["trace[1286742278] 'process raft request'  (duration: 147.136643ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:30.673414Z","caller":"traceutil/trace.go:171","msg":"trace[1035903238] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"150.825704ms","start":"2026-02-25T15:01:30.522577Z","end":"2026-02-25T15:01:30.673402Z","steps":["trace[1035903238] 'process raft request'  (duration: 150.479688ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:30.838174Z","caller":"traceutil/trace.go:171","msg":"trace[1251991849] linearizableReadLoop","detail":"{readStateIndex:1113; appliedIndex:1112; }","duration":"142.421588ms","start":"2026-02-25T15:01:30.695727Z","end":"2026-02-25T15:01:30.838149Z","steps":["trace[1251991849] 'read index received'  (duration: 111.107898ms)","trace[1251991849] 'applied index is now lower than readState.Index'  (duration: 31.31229ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:30.838511Z","caller":"traceutil/trace.go:171","msg":"trace[964827523] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"154.239909ms","start":"2026-02-25T15:01:30.684231Z","end":"2026-02-25T15:01:30.838471Z","steps":["trace[964827523] 'process raft request'  (duration: 122.741978ms)","trace[964827523] 'compare'  (duration: 31.067825ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:01:30.838536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.773863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T15:01:30.838618Z","caller":"traceutil/trace.go:171","msg":"trace[1806590101] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1064; }","duration":"142.921105ms","start":"2026-02-25T15:01:30.695676Z","end":"2026-02-25T15:01:30.838597Z","steps":["trace[1806590101] 'agreement among raft nodes before linearized reading'  (duration: 142.687881ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.838606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.948622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-node-lease/\" range_end:\"/registry/secrets/kube-node-lease0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:30.838687Z","caller":"traceutil/trace.go:171","msg":"trace[1410602237] range","detail":"{range_begin:/registry/secrets/kube-node-lease/; range_end:/registry/secrets/kube-node-lease0; response_count:0; response_revision:1064; }","duration":"117.067775ms","start":"2026-02-25T15:01:30.721598Z","end":"2026-02-25T15:01:30.838665Z","steps":["trace[1410602237] 'agreement among raft nodes before linearized reading'  (duration: 116.930282ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:30.838904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.866607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-25T15:01:30.839069Z","caller":"traceutil/trace.go:171","msg":"trace[809901211] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62; range_end:; response_count:1; response_revision:1064; }","duration":"142.080641ms","start":"2026-02-25T15:01:30.696955Z","end":"2026-02-25T15:01:30.839036Z","steps":["trace[809901211] 'agreement among raft nodes before linearized reading'  (duration: 141.547292ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:35.805536Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757098,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T15:01:36.163619Z","caller":"traceutil/trace.go:171","msg":"trace[2096727243] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"858.409516ms","start":"2026-02-25T15:01:35.305189Z","end":"2026-02-25T15:01:36.163598Z","steps":["trace[2096727243] 'read index received'  (duration: 858.129722ms)","trace[2096727243] 'applied index is now lower than readState.Index'  (duration: 278.704µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:36.163735Z","caller":"traceutil/trace.go:171","msg":"trace[476856695] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"859.412773ms","start":"2026-02-25T15:01:35.304289Z","end":"2026-02-25T15:01:36.163702Z","steps":["trace[476856695] 'process raft request'  (duration: 859.123638ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:36.163934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.895292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:36.163944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.383801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:expand-controller\" ","response":"range_response_count:1 size:882"}
{"level":"info","ts":"2026-02-25T15:01:36.163985Z","caller":"traceutil/trace.go:171","msg":"trace[1684842825] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1103; }","duration":"117.983602ms","start":"2026-02-25T15:01:36.045987Z","end":"2026-02-25T15:01:36.16397Z","steps":["trace[1684842825] 'agreement among raft nodes before linearized reading'  (duration: 117.905721ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:36.163991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.765499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-02-25T15:01:36.164017Z","caller":"traceutil/trace.go:171","msg":"trace[218669043] range","detail":"{range_begin:/registry/clusterroles/system:controller:expand-controller; range_end:; response_count:1; response_revision:1103; }","duration":"806.484704ms","start":"2026-02-25T15:01:35.357511Z","end":"2026-02-25T15:01:36.163995Z","steps":["trace[218669043] 'agreement among raft nodes before linearized reading'  (duration: 806.345032ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:36.164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:35.304272Z","time spent":"859.599416ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:1100 > 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-25T15:01:36.164048Z","caller":"traceutil/trace.go:171","msg":"trace[295226162] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1103; }","duration":"854.843131ms","start":"2026-02-25T15:01:35.309186Z","end":"2026-02-25T15:01:36.164029Z","steps":["trace[295226162] 'agreement among raft nodes before linearized reading'  (duration: 854.649788ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:36.164085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:35.30918Z","time spent":"854.894172ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T15:01:36.164086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:35.357499Z","time spent":"806.560725ms","remote":"127.0.0.1:45858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":905,"request content":"key:\"/registry/clusterroles/system:controller:expand-controller\" "}
{"level":"warn","ts":"2026-02-25T15:01:36.163845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"858.631551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T15:01:36.16429Z","caller":"traceutil/trace.go:171","msg":"trace[1419729742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1103; }","duration":"859.096178ms","start":"2026-02-25T15:01:35.305159Z","end":"2026-02-25T15:01:36.164255Z","steps":["trace[1419729742] 'agreement among raft nodes before linearized reading'  (duration: 858.57134ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:36.16433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:35.305145Z","time spent":"859.173849ms","remote":"127.0.0.1:45792","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-25T15:01:36.164309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.855713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:generic-garbage-collector\" ","response":"range_response_count:1 size:695"}
{"level":"info","ts":"2026-02-25T15:01:36.165844Z","caller":"traceutil/trace.go:171","msg":"trace[1716878247] range","detail":"{range_begin:/registry/clusterroles/system:controller:generic-garbage-collector; range_end:; response_count:1; response_revision:1103; }","duration":"812.447417ms","start":"2026-02-25T15:01:35.353347Z","end":"2026-02-25T15:01:36.165795Z","steps":["trace[1716878247] 'agreement among raft nodes before linearized reading'  (duration: 810.806261ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:36.16597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:35.353323Z","time spent":"812.63066ms","remote":"127.0.0.1:45858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":718,"request content":"key:\"/registry/clusterroles/system:controller:generic-garbage-collector\" "}
{"level":"warn","ts":"2026-02-25T15:01:36.71457Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:37.215587Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:37.715933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:38.216414Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:38.717031Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:39.217685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:39.71787Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:40.045672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000179291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T15:01:40.045761Z","caller":"traceutil/trace.go:171","msg":"trace[290031357] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000364543s","start":"2026-02-25T15:01:38.045375Z","end":"2026-02-25T15:01:40.04574Z","steps":["trace[290031357] 'agreement among raft nodes before linearized reading'  (duration: 2.000216321s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:40.045811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:38.045353Z","time spent":"2.000447864s","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T15:01:40.218885Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:40.719024Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:41.213924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999668057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T15:01:41.214021Z","caller":"traceutil/trace.go:171","msg":"trace[1113732742] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999814499s","start":"2026-02-25T15:01:36.214182Z","end":"2026-02-25T15:01:41.213997Z","steps":["trace[1113732742] 'agreement among raft nodes before linearized reading'  (duration: 4.999690307s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:41.214072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:36.214165Z","time spent":"4.99989706s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T15:01:41.219797Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:41.720277Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153697513688757102,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:01:41.901548Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"5.732385692s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T15:01:42.046977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00070396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T15:01:42.047066Z","caller":"traceutil/trace.go:171","msg":"trace[1249898377] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000873762s","start":"2026-02-25T15:01:40.046173Z","end":"2026-02-25T15:01:42.047047Z","steps":["trace[1249898377] 'agreement among raft nodes before linearized reading'  (duration: 2.00072961s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:42.047131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:40.046156Z","time spent":"2.000965003s","remote":"127.0.0.1:45576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 15:01:42 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:42.696173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999114627s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T15:01:42.696283Z","caller":"traceutil/trace.go:171","msg":"trace[1888632946] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999281219s","start":"2026-02-25T15:01:37.696979Z","end":"2026-02-25T15:01:42.69626Z","steps":["trace[1888632946] 'agreement among raft nodes before linearized reading'  (duration: 4.999148227s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:42.696345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:37.696956Z","time spent":"4.99937661s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/25 15:01:42 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T15:01:42.87796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.741648254s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:42.878082Z","caller":"traceutil/trace.go:171","msg":"trace[367151751] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1103; }","duration":"4.741783156s","start":"2026-02-25T15:01:38.136283Z","end":"2026-02-25T15:01:42.878066Z","steps":["trace[367151751] 'range keys from in-memory index tree'  (duration: 4.741632184s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:42.880527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.497519ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5153697513688757103 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1101 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:01:42.880738Z","caller":"traceutil/trace.go:171","msg":"trace[708442646] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"6.711656853s","start":"2026-02-25T15:01:36.169055Z","end":"2026-02-25T15:01:42.880711Z","steps":["trace[708442646] 'process raft request'  (duration: 5.73288249s)","trace[708442646] 'compare'  (duration: 977.9682ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:01:42.881803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:36.16903Z","time spent":"6.712692367s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1101 > 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-25T15:01:43.433073Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.531253514s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T15:01:43.434958Z","caller":"traceutil/trace.go:171","msg":"trace[478761174] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"3.12690032s","start":"2026-02-25T15:01:40.308033Z","end":"2026-02-25T15:01:43.434933Z","steps":["trace[478761174] 'process raft request'  (duration: 3.125420057s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.435194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:40.308012Z","time spent":"3.127049373s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1055 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-25T15:01:43.43555Z","caller":"traceutil/trace.go:171","msg":"trace[798022786] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1153; }","duration":"7.221310706s","start":"2026-02-25T15:01:36.214214Z","end":"2026-02-25T15:01:43.435525Z","steps":["trace[798022786] 'read index received'  (duration: 5.687688905s)","trace[798022786] 'applied index is now lower than readState.Index'  (duration: 1.533620391s)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:43.435838Z","caller":"traceutil/trace.go:171","msg":"trace[1909066222] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"2.369204196s","start":"2026-02-25T15:01:41.066485Z","end":"2026-02-25T15:01:43.435689Z","steps":["trace[1909066222] 'process raft request'  (duration: 2.368766919s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.435913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.581259637s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T15:01:43.43599Z","caller":"traceutil/trace.go:171","msg":"trace[633478507] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:1106; }","duration":"2.581389249s","start":"2026-02-25T15:01:40.854584Z","end":"2026-02-25T15:01:43.435973Z","steps":["trace[633478507] 'agreement among raft nodes before linearized reading'  (duration: 2.581165376s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.436012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.686666112s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:43.436037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:40.854552Z","time spent":"2.581477339s","remote":"127.0.0.1:45606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.240\" "}
{"level":"info","ts":"2026-02-25T15:01:43.436066Z","caller":"traceutil/trace.go:171","msg":"trace[562945520] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1106; }","duration":"1.686748252s","start":"2026-02-25T15:01:41.749299Z","end":"2026-02-25T15:01:43.436047Z","steps":["trace[562945520] 'agreement among raft nodes before linearized reading'  (duration: 1.686664971s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.436069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:41.06644Z","time spent":"2.36945017s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1062 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-25T15:01:43.436113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:41.749281Z","time spent":"1.686823933s","remote":"127.0.0.1:45782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:43.436197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.056568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:43.43625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.996444407s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:43.436349Z","caller":"traceutil/trace.go:171","msg":"trace[1211165172] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1106; }","duration":"187.22125ms","start":"2026-02-25T15:01:43.249063Z","end":"2026-02-25T15:01:43.436284Z","steps":["trace[1211165172] 'agreement among raft nodes before linearized reading'  (duration: 187.026437ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.436457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.678475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:43.436534Z","caller":"traceutil/trace.go:171","msg":"trace[1404714964] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1106; }","duration":"952.809107ms","start":"2026-02-25T15:01:42.483702Z","end":"2026-02-25T15:01:43.436511Z","steps":["trace[1404714964] 'agreement among raft nodes before linearized reading'  (duration: 952.697045ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.436593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:42.483676Z","time spent":"952.899888ms","remote":"127.0.0.1:45764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:43.436611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.197678273s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:expand-controller\" ","response":"range_response_count:1 size:882"}
{"level":"info","ts":"2026-02-25T15:01:43.436679Z","caller":"traceutil/trace.go:171","msg":"trace[729181291] range","detail":"{range_begin:/registry/clusterroles/system:controller:expand-controller; range_end:; response_count:1; response_revision:1106; }","duration":"7.197803354s","start":"2026-02-25T15:01:36.238858Z","end":"2026-02-25T15:01:43.436661Z","steps":["trace[729181291] 'agreement among raft nodes before linearized reading'  (duration: 7.196877031s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.43673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:36.238843Z","time spent":"7.197878776s","remote":"127.0.0.1:45858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":905,"request content":"key:\"/registry/clusterroles/system:controller:expand-controller\" "}
{"level":"info","ts":"2026-02-25T15:01:43.436383Z","caller":"traceutil/trace.go:171","msg":"trace[1519815578] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1106; }","duration":"1.99662055s","start":"2026-02-25T15:01:41.439749Z","end":"2026-02-25T15:01:43.436369Z","steps":["trace[1519815578] 'agreement among raft nodes before linearized reading'  (duration: 1.996471007s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.436917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:41.439723Z","time spent":"1.997154009s","remote":"127.0.0.1:44460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:43.436931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.9678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-25T15:01:43.43698Z","caller":"traceutil/trace.go:171","msg":"trace[380035233] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1106; }","duration":"220.059162ms","start":"2026-02-25T15:01:43.216907Z","end":"2026-02-25T15:01:43.436966Z","steps":["trace[380035233] 'agreement among raft nodes before linearized reading'  (duration: 219.892379ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.437037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.197366808s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:generic-garbage-collector\" ","response":"range_response_count:1 size:695"}
{"level":"info","ts":"2026-02-25T15:01:43.437083Z","caller":"traceutil/trace.go:171","msg":"trace[478724318] range","detail":"{range_begin:/registry/clusterroles/system:controller:generic-garbage-collector; range_end:; response_count:1; response_revision:1106; }","duration":"7.197432889s","start":"2026-02-25T15:01:36.239631Z","end":"2026-02-25T15:01:43.437064Z","steps":["trace[478724318] 'agreement among raft nodes before linearized reading'  (duration: 7.197374608s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.437112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:36.239613Z","time spent":"7.197492419s","remote":"127.0.0.1:45858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":1,"response size":718,"request content":"key:\"/registry/clusterroles/system:controller:generic-garbage-collector\" "}
{"level":"warn","ts":"2026-02-25T15:01:43.437112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177936173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:43.43701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.269242895s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-02-25T15:01:43.436468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.457478639s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:43.437152Z","caller":"traceutil/trace.go:171","msg":"trace[509740832] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1106; }","duration":"1.178023884s","start":"2026-02-25T15:01:42.259117Z","end":"2026-02-25T15:01:43.437141Z","steps":["trace[509740832] 'agreement among raft nodes before linearized reading'  (duration: 1.177956643s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.437181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:42.259094Z","time spent":"1.178078845s","remote":"127.0.0.1:45896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:43.437146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.744997477s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T15:01:43.437201Z","caller":"traceutil/trace.go:171","msg":"trace[342899347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1106; }","duration":"5.269468929s","start":"2026-02-25T15:01:38.167715Z","end":"2026-02-25T15:01:43.437184Z","steps":["trace[342899347] 'agreement among raft nodes before linearized reading'  (duration: 5.269190035s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.436985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.344149906s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T15:01:43.43726Z","caller":"traceutil/trace.go:171","msg":"trace[688787543] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1106; }","duration":"4.745173139s","start":"2026-02-25T15:01:38.692062Z","end":"2026-02-25T15:01:43.437235Z","steps":["trace[688787543] 'agreement among raft nodes before linearized reading'  (duration: 4.744965476s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.437253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.867325782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-25T15:01:43.437326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:38.692041Z","time spent":"4.745268821s","remote":"127.0.0.1:45970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "}
{"level":"info","ts":"2026-02-25T15:01:43.437355Z","caller":"traceutil/trace.go:171","msg":"trace[397252308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1106; }","duration":"3.867492685s","start":"2026-02-25T15:01:39.56985Z","end":"2026-02-25T15:01:43.437343Z","steps":["trace[397252308] 'agreement among raft nodes before linearized reading'  (duration: 3.867076988s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.43743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:39.56979Z","time spent":"3.867627386s","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T15:01:43.437293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:38.167693Z","time spent":"5.269581441s","remote":"127.0.0.1:45792","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":"info","ts":"2026-02-25T15:01:43.437183Z","caller":"traceutil/trace.go:171","msg":"trace[1137133251] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1106; }","duration":"2.45821117s","start":"2026-02-25T15:01:40.978953Z","end":"2026-02-25T15:01:43.437164Z","steps":["trace[1137133251] 'agreement among raft nodes before linearized reading'  (duration: 2.457486599s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.437595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:40.97894Z","time spent":"2.458634307s","remote":"127.0.0.1:46008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:43.436393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.381936154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62\" ","response":"range_response_count:1 size:774"}
{"level":"warn","ts":"2026-02-25T15:01:43.437654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.587293571s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:43.437303Z","caller":"traceutil/trace.go:171","msg":"trace[323638062] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1106; }","duration":"5.344494022s","start":"2026-02-25T15:01:38.092794Z","end":"2026-02-25T15:01:43.437288Z","steps":["trace[323638062] 'agreement among raft nodes before linearized reading'  (duration: 5.344157077s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.437696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.47077237s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T15:01:43.437663Z","caller":"traceutil/trace.go:171","msg":"trace[2077460641] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62; range_end:; response_count:1; response_revision:1106; }","duration":"1.383248145s","start":"2026-02-25T15:01:42.054402Z","end":"2026-02-25T15:01:43.43765Z","steps":["trace[2077460641] 'agreement among raft nodes before linearized reading'  (duration: 1.381899854s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.437731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:38.09278Z","time spent":"5.344937359s","remote":"127.0.0.1:45880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "}
{"level":"info","ts":"2026-02-25T15:01:43.437753Z","caller":"traceutil/trace.go:171","msg":"trace[2140549050] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1106; }","duration":"3.470826931s","start":"2026-02-25T15:01:39.966907Z","end":"2026-02-25T15:01:43.437734Z","steps":["trace[2140549050] 'agreement among raft nodes before linearized reading'  (duration: 3.47073653s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.437762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:42.054372Z","time spent":"1.383373366s","remote":"127.0.0.1:45644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.1897856c68553e62\" "}
{"level":"warn","ts":"2026-02-25T15:01:43.437597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.627356962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:43.437796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:39.966826Z","time spent":"3.470959953s","remote":"127.0.0.1:45930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:43.435943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.379988516s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:43.437907Z","caller":"traceutil/trace.go:171","msg":"trace[1136833869] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1106; }","duration":"1.382037927s","start":"2026-02-25T15:01:42.055858Z","end":"2026-02-25T15:01:43.437896Z","steps":["trace[1136833869] 'agreement among raft nodes before linearized reading'  (duration: 1.379951175s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:43.437827Z","caller":"traceutil/trace.go:171","msg":"trace[693102838] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1106; }","duration":"2.627636736s","start":"2026-02-25T15:01:40.810166Z","end":"2026-02-25T15:01:43.437803Z","steps":["trace[693102838] 'agreement among raft nodes before linearized reading'  (duration: 2.627385542s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.438115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:40.810137Z","time spent":"2.627954391s","remote":"127.0.0.1:45760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"info","ts":"2026-02-25T15:01:43.43771Z","caller":"traceutil/trace.go:171","msg":"trace[1130612748] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1106; }","duration":"2.587399922s","start":"2026-02-25T15:01:40.850295Z","end":"2026-02-25T15:01:43.437695Z","steps":["trace[1130612748] 'agreement among raft nodes before linearized reading'  (duration: 2.587330841s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.43831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:40.85027Z","time spent":"2.587950581s","remote":"127.0.0.1:45772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:43.438025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.816806996s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T15:01:43.438012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.77468149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:43.438529Z","caller":"traceutil/trace.go:171","msg":"trace[217371154] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1106; }","duration":"3.817425406s","start":"2026-02-25T15:01:39.621076Z","end":"2026-02-25T15:01:43.438501Z","steps":["trace[217371154] 'agreement among raft nodes before linearized reading'  (duration: 3.816711905s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:43.43875Z","caller":"traceutil/trace.go:171","msg":"trace[1280126727] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1106; }","duration":"3.775454553s","start":"2026-02-25T15:01:39.663275Z","end":"2026-02-25T15:01:43.438729Z","steps":["trace[1280126727] 'agreement among raft nodes before linearized reading'  (duration: 3.774707501s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:43.438827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:39.663253Z","time spent":"3.775551274s","remote":"127.0.0.1:55954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:43.438753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:39.621031Z","time spent":"3.81770154s","remote":"127.0.0.1:45960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T15:01:43.438029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:42.055849Z","time spent":"1.382095846s","remote":"127.0.0.1:45590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T15:02:02.711997Z","caller":"traceutil/trace.go:171","msg":"trace[2146351750] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"114.757694ms","start":"2026-02-25T15:02:02.597212Z","end":"2026-02-25T15:02:02.71197Z","steps":["trace[2146351750] 'process raft request'  (duration: 114.587152ms)"],"step_count":1}