{"level":"warn","ts":"2026-02-19T05:58:21.217183Z","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-19T05:58:21.217311Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74: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.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-19T05:58:21.217403Z","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-19T05:58:21.217417Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-02-19T05:58:21.217448Z","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-19T05:58:21.218153Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-02-19T05:58:21.218236Z","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.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-19T05:58:21.222337Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.842203ms"} {"level":"info","ts":"2026-02-19T05:58:21.22814Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-02-19T05:58:21.228214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-02-19T05:58:21.22834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-02-19T05:58:21.228368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-19T05:58:21.228375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-02-19T05:58:21.22847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-02-19T05:58:21.233917Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-19T05:58:21.23499Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-19T05:58:21.235881Z","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-19T05:58:21.237406Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-19T05:58:21.23748Z","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-19T05:58:21.237553Z","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-19T05:58:21.237561Z","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-19T05:58:21.239179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-02-19T05:58:21.237784Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-19T05:58:21.23949Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-02-19T05:58:21.244144Z","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-19T05:58:21.244363Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-19T05:58:21.244405Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-19T05:58:21.244751Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-02-19T05:58:21.244792Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-02-19T05:58:21.328717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-02-19T05:58:21.328773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-19T05:58:21.328806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-02-19T05:58:21.328825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-02-19T05:58:21.328837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-02-19T05:58:21.328852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-02-19T05:58:21.328865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-02-19T05:58:21.32972Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-02-19T05:58:21.329754Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T05:58:21.330148Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:58:21.330256Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T05:58:21.330536Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-19T05:58:21.330707Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-19T05:58:21.331406Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:58:21.331479Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:58:21.331505Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T05:58:21.333079Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"info","ts":"2026-02-19T05:58:21.333635Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-19T05:58:43.904505Z","caller":"traceutil/trace.go:171","msg":"trace[1778152383] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"157.619496ms","start":"2026-02-19T05:58:43.746855Z","end":"2026-02-19T05:58:43.904475Z","steps":["trace[1778152383] 'process raft request' (duration: 157.465653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:49.898914Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024004,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T05:58:50.206279Z","caller":"traceutil/trace.go:171","msg":"trace[128162836] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"913.221357ms","start":"2026-02-19T05:58:49.293033Z","end":"2026-02-19T05:58:50.206255Z","steps":["trace[128162836] 'process raft request' (duration: 913.017973ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:50.206848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:49.293016Z","time spent":"913.33665ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:58:50.211623Z","caller":"traceutil/trace.go:171","msg":"trace[1872452646] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:517; }","duration":"813.717945ms","start":"2026-02-19T05:58:49.397886Z","end":"2026-02-19T05:58:50.211604Z","steps":["trace[1872452646] 'read index received' (duration: 808.232894ms)","trace[1872452646] 'applied index is now lower than readState.Index' (duration: 5.483491ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:58:50.21178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.8498ms","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-19T05:58:50.21176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.853048ms","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-19T05:58:50.211811Z","caller":"traceutil/trace.go:171","msg":"trace[212621209] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:505; }","duration":"286.945792ms","start":"2026-02-19T05:58:49.924859Z","end":"2026-02-19T05:58:50.211805Z","steps":["trace[212621209] 'agreement among raft nodes before linearized reading' (duration: 286.8548ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:58:50.211824Z","caller":"traceutil/trace.go:171","msg":"trace[249698685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:505; }","duration":"813.96502ms","start":"2026-02-19T05:58:49.397846Z","end":"2026-02-19T05:58:50.211811Z","steps":["trace[249698685] 'agreement among raft nodes before linearized reading' (duration: 813.845378ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:50.211847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:49.39782Z","time spent":"814.022211ms","remote":"127.0.0.1:48358","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-19T05:58:52.721379Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024018,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T05:58:53.14654Z","caller":"traceutil/trace.go:171","msg":"trace[1120492923] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:523; }","duration":"925.494686ms","start":"2026-02-19T05:58:52.221026Z","end":"2026-02-19T05:58:53.14652Z","steps":["trace[1120492923] 'read index received' (duration: 925.324702ms)","trace[1120492923] 'applied index is now lower than readState.Index' (duration: 169.384µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:58:53.14668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.718589ms","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-19T05:58:53.14666Z","caller":"traceutil/trace.go:171","msg":"trace[1092651032] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"932.04832ms","start":"2026-02-19T05:58:52.214577Z","end":"2026-02-19T05:58:53.146625Z","steps":["trace[1092651032] 'process raft request' (duration: 931.820425ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:58:53.146722Z","caller":"traceutil/trace.go:171","msg":"trace[12773099] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:510; }","duration":"924.770651ms","start":"2026-02-19T05:58:52.221937Z","end":"2026-02-19T05:58:53.146708Z","steps":["trace[12773099] 'agreement among raft nodes before linearized reading' (duration: 924.704529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:53.146756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:52.221931Z","time spent":"924.817002ms","remote":"127.0.0.1:48358","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-19T05:58:53.146765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.698886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:58:53.146798Z","caller":"traceutil/trace.go:171","msg":"trace[1448831791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"446.766349ms","start":"2026-02-19T05:58:52.700021Z","end":"2026-02-19T05:58:53.146788Z","steps":["trace[1448831791] 'agreement among raft nodes before linearized reading' (duration: 446.694247ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:53.14681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:52.214554Z","time spent":"932.175573ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:58:53.146821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:52.700005Z","time spent":"446.809779ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T05:58:53.146816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.121231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:58:53.146901Z","caller":"traceutil/trace.go:171","msg":"trace[1914223679] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"906.246994ms","start":"2026-02-19T05:58:52.240634Z","end":"2026-02-19T05:58:53.146881Z","steps":["trace[1914223679] 'agreement among raft nodes before linearized reading' (duration: 906.0897ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:53.146944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:52.240625Z","time spent":"906.312355ms","remote":"127.0.0.1:48098","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-19T05:58:53.14667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.627219ms","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-19T05:58:53.147181Z","caller":"traceutil/trace.go:171","msg":"trace[648624628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:510; }","duration":"926.178911ms","start":"2026-02-19T05:58:52.220991Z","end":"2026-02-19T05:58:53.14717Z","steps":["trace[648624628] 'agreement among raft nodes before linearized reading' (duration: 925.620859ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:53.147211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:52.220981Z","time spent":"926.221592ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-19T05:58:54.225156Z","caller":"traceutil/trace.go:171","msg":"trace[1559132054] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"403.397776ms","start":"2026-02-19T05:58:53.821734Z","end":"2026-02-19T05:58:54.225131Z","steps":["trace[1559132054] 'process raft request' (duration: 403.266063ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:54.225321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:53.821706Z","time spent":"403.516299ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:58:55.625123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.341945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-19T05:58:55.625202Z","caller":"traceutil/trace.go:171","msg":"trace[2105642608] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:514; }","duration":"465.502829ms","start":"2026-02-19T05:58:55.159683Z","end":"2026-02-19T05:58:55.625186Z","steps":["trace[2105642608] 'range keys from in-memory index tree' (duration: 465.184932ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:55.625244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:55.159652Z","time spent":"465.58335ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T05:58:55.625549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.883484ms","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-19T05:58:55.62558Z","caller":"traceutil/trace.go:171","msg":"trace[1054133357] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:514; }","duration":"474.922736ms","start":"2026-02-19T05:58:55.150646Z","end":"2026-02-19T05:58:55.625569Z","steps":["trace[1054133357] 'range keys from in-memory index tree' (duration: 474.818603ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:55.625606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:55.150594Z","time spent":"475.005898ms","remote":"127.0.0.1:48358","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-19T05:58:55.625612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.00565ms","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-19T05:58:55.625642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.999476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:58:55.625691Z","caller":"traceutil/trace.go:171","msg":"trace[1533706476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:514; }","duration":"466.113542ms","start":"2026-02-19T05:58:55.15956Z","end":"2026-02-19T05:58:55.625674Z","steps":["trace[1533706476] 'range keys from in-memory index tree' (duration: 465.922478ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:58:55.625685Z","caller":"traceutil/trace.go:171","msg":"trace[700508411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:514; }","duration":"469.054787ms","start":"2026-02-19T05:58:55.156616Z","end":"2026-02-19T05:58:55.625671Z","steps":["trace[700508411] 'range keys from in-memory index tree' (duration: 468.946565ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:55.625739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:55.15955Z","time spent":"466.179514ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-19T05:58:55.625762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:55.156608Z","time spent":"469.146709ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T05:58:55.625621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13085956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-19T05:58:55.625818Z","caller":"traceutil/trace.go:171","msg":"trace[971552449] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:514; }","duration":"1.131095885s","start":"2026-02-19T05:58:54.494707Z","end":"2026-02-19T05:58:55.625803Z","steps":["trace[971552449] 'range keys from in-memory index tree' (duration: 1.130771048s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:58:55.625864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:58:54.494689Z","time spent":"1.131161706s","remote":"127.0.0.1:48118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.74\" "} {"level":"info","ts":"2026-02-19T05:58:59.894797Z","caller":"traceutil/trace.go:171","msg":"trace[1881085556] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"154.345565ms","start":"2026-02-19T05:58:59.740415Z","end":"2026-02-19T05:58:59.89476Z","steps":["trace[1881085556] 'process raft request' (duration: 95.456723ms)","trace[1881085556] 'compare' (duration: 58.78201ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:58:59.895067Z","caller":"traceutil/trace.go:171","msg":"trace[990126905] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"154.387375ms","start":"2026-02-19T05:58:59.740659Z","end":"2026-02-19T05:58:59.895046Z","steps":["trace[990126905] 'process raft request' (duration: 154.213791ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:58:59.895107Z","caller":"traceutil/trace.go:171","msg":"trace[1354889440] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"153.318552ms","start":"2026-02-19T05:58:59.741781Z","end":"2026-02-19T05:58:59.895099Z","steps":["trace[1354889440] 'process raft request' (duration: 153.19347ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:00.444353Z","caller":"traceutil/trace.go:171","msg":"trace[1534769253] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:547; }","duration":"204.192038ms","start":"2026-02-19T05:59:00.240144Z","end":"2026-02-19T05:59:00.444336Z","steps":["trace[1534769253] 'read index received' (duration: 204.025105ms)","trace[1534769253] 'applied index is now lower than readState.Index' (duration: 166.343µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:00.444477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.321261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:00.444508Z","caller":"traceutil/trace.go:171","msg":"trace[305579125] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"204.406533ms","start":"2026-02-19T05:59:00.240092Z","end":"2026-02-19T05:59:00.444499Z","steps":["trace[305579125] 'agreement among raft nodes before linearized reading' (duration: 204.316341ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:00.444476Z","caller":"traceutil/trace.go:171","msg":"trace[941269610] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"310.263525ms","start":"2026-02-19T05:59:00.134179Z","end":"2026-02-19T05:59:00.444443Z","steps":["trace[941269610] 'process raft request' (duration: 310.04518ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:00.444787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:00.134166Z","time spent":"310.5251ms","remote":"127.0.0.1:48252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:02.399446Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024077,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T05:59:02.900272Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024077,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T05:59:03.40122Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024077,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T05:59:03.901835Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024077,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T05:59:03.992014Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.254384269s","expected-duration":"1s"} {"level":"info","ts":"2026-02-19T05:59:03.992411Z","caller":"traceutil/trace.go:171","msg":"trace[2054585435] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:548; }","duration":"2.093893841s","start":"2026-02-19T05:59:01.898494Z","end":"2026-02-19T05:59:03.992388Z","steps":["trace[2054585435] 'read index received' (duration: 2.093655855s)","trace[2054585435] 'applied index is now lower than readState.Index' (duration: 237.166µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:03.992504Z","caller":"traceutil/trace.go:171","msg":"trace[1875674359] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"2.254945892s","start":"2026-02-19T05:59:01.737544Z","end":"2026-02-19T05:59:03.99249Z","steps":["trace[1875674359] 'process raft request' (duration: 2.254712286s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:03.992658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:01.737525Z","time spent":"2.255050274s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:03.9927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.75230001s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T05:59:03.992738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.093823609s","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-19T05:59:03.992725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.094221208s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:59:03.992787Z","caller":"traceutil/trace.go:171","msg":"trace[1054491935] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:533; }","duration":"2.09389751s","start":"2026-02-19T05:59:01.898877Z","end":"2026-02-19T05:59:03.992775Z","steps":["trace[1054491935] 'agreement among raft nodes before linearized reading' (duration: 2.093744697s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:03.992825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:01.898866Z","time spent":"2.093952032s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T05:59:03.992822Z","caller":"traceutil/trace.go:171","msg":"trace[578954848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:533; }","duration":"2.09435671s","start":"2026-02-19T05:59:01.898452Z","end":"2026-02-19T05:59:03.992809Z","steps":["trace[578954848] 'agreement among raft nodes before linearized reading' (duration: 2.094216957s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:03.992908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:01.898433Z","time spent":"2.094464563s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-19T05:59:03.992896Z","caller":"traceutil/trace.go:171","msg":"trace[1466737689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:533; }","duration":"1.752542835s","start":"2026-02-19T05:59:02.240302Z","end":"2026-02-19T05:59:03.992845Z","steps":["trace[1466737689] 'agreement among raft nodes before linearized reading' (duration: 1.75231749s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:03.992988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:02.240279Z","time spent":"1.752693268s","remote":"127.0.0.1:48084","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-19T05:59:03.994015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.095235629s","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-19T05:59:03.994103Z","caller":"traceutil/trace.go:171","msg":"trace[1621728718] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:533; }","duration":"2.095384243s","start":"2026-02-19T05:59:01.898697Z","end":"2026-02-19T05:59:03.994082Z","steps":["trace[1621728718] 'agreement among raft nodes before linearized reading' (duration: 2.093839989s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:03.994221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:01.898673Z","time spent":"2.095533996s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-19T05:59:04.345803Z","caller":"traceutil/trace.go:171","msg":"trace[1754253669] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"348.428552ms","start":"2026-02-19T05:59:03.997354Z","end":"2026-02-19T05:59:04.345782Z","steps":["trace[1754253669] 'process raft request' (duration: 348.316849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:04.345936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:03.997338Z","time spent":"348.527013ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:04.347845Z","caller":"traceutil/trace.go:171","msg":"trace[155594666] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:549; }","duration":"345.243661ms","start":"2026-02-19T05:59:04.002576Z","end":"2026-02-19T05:59:04.34782Z","steps":["trace[155594666] 'read index received' (duration: 343.182666ms)","trace[155594666] 'applied index is now lower than readState.Index' (duration: 2.059875ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:04.34791Z","caller":"traceutil/trace.go:171","msg":"trace[1860099841] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"350.320752ms","start":"2026-02-19T05:59:03.99756Z","end":"2026-02-19T05:59:04.34788Z","steps":["trace[1860099841] 'process raft request' (duration: 350.018805ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:04.347969Z","caller":"traceutil/trace.go:171","msg":"trace[219144] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"350.335982ms","start":"2026-02-19T05:59:03.997612Z","end":"2026-02-19T05:59:04.347948Z","steps":["trace[219144] 'process raft request' (duration: 350.150328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:04.348062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:03.997595Z","time spent":"350.421555ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:04.34809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:03.997532Z","time spent":"350.442345ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:04.34854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.957917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:04.348601Z","caller":"traceutil/trace.go:171","msg":"trace[1342438464] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:536; }","duration":"346.050549ms","start":"2026-02-19T05:59:04.002534Z","end":"2026-02-19T05:59:04.348585Z","steps":["trace[1342438464] 'agreement among raft nodes before linearized reading' (duration: 345.400214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:04.348645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:04.002517Z","time spent":"346.12039ms","remote":"127.0.0.1:48084","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-19T05:59:06.683984Z","caller":"traceutil/trace.go:171","msg":"trace[1153363992] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:583; }","duration":"333.638456ms","start":"2026-02-19T05:59:06.350323Z","end":"2026-02-19T05:59:06.683961Z","steps":["trace[1153363992] 'read index received' (duration: 333.507983ms)","trace[1153363992] 'applied index is now lower than readState.Index' (duration: 129.593µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:06.684107Z","caller":"traceutil/trace.go:171","msg":"trace[1939798164] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"375.73692ms","start":"2026-02-19T05:59:06.308361Z","end":"2026-02-19T05:59:06.684098Z","steps":["trace[1939798164] 'process raft request' (duration: 375.491255ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:06.684199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:06.308346Z","time spent":"375.787011ms","remote":"127.0.0.1:48132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T05:59:06.684278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.569972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:59:06.684367Z","caller":"traceutil/trace.go:171","msg":"trace[491056725] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:567; }","duration":"332.673894ms","start":"2026-02-19T05:59:06.351675Z","end":"2026-02-19T05:59:06.684349Z","steps":["trace[491056725] 'agreement among raft nodes before linearized reading' (duration: 332.47854ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:06.684425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:06.35167Z","time spent":"332.746336ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T05:59:06.684656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.321252ms","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-19T05:59:06.684681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.852309ms","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-19T05:59:06.684697Z","caller":"traceutil/trace.go:171","msg":"trace[351282908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:567; }","duration":"334.393464ms","start":"2026-02-19T05:59:06.35029Z","end":"2026-02-19T05:59:06.684684Z","steps":["trace[351282908] 'agreement among raft nodes before linearized reading' (duration: 334.306552ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:06.68473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:06.350278Z","time spent":"334.445844ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T05:59:06.684735Z","caller":"traceutil/trace.go:171","msg":"trace[1342153395] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:567; }","duration":"332.89269ms","start":"2026-02-19T05:59:06.35181Z","end":"2026-02-19T05:59:06.684702Z","steps":["trace[1342153395] 'agreement among raft nodes before linearized reading' (duration: 332.816368ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:06.684707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.274976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:06.684828Z","caller":"traceutil/trace.go:171","msg":"trace[941298167] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:567; }","duration":"176.424659ms","start":"2026-02-19T05:59:06.508372Z","end":"2026-02-19T05:59:06.684796Z","steps":["trace[941298167] 'agreement among raft nodes before linearized reading' (duration: 176.187714ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:06.684766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:06.351806Z","time spent":"332.952751ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-19T05:59:08.63782Z","caller":"traceutil/trace.go:171","msg":"trace[1927925051] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"124.412119ms","start":"2026-02-19T05:59:08.513384Z","end":"2026-02-19T05:59:08.637796Z","steps":["trace[1927925051] 'process raft request' (duration: 124.278096ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:09.959492Z","caller":"traceutil/trace.go:171","msg":"trace[1877282552] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"127.573639ms","start":"2026-02-19T05:59:09.831889Z","end":"2026-02-19T05:59:09.959462Z","steps":["trace[1877282552] 'process raft request' (duration: 127.375233ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:10.136465Z","caller":"traceutil/trace.go:171","msg":"trace[1527531003] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"119.386739ms","start":"2026-02-19T05:59:10.017049Z","end":"2026-02-19T05:59:10.136436Z","steps":["trace[1527531003] 'process raft request' (duration: 81.902886ms)","trace[1527531003] 'compare' (duration: 37.37169ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:10.144346Z","caller":"traceutil/trace.go:171","msg":"trace[1260692485] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"118.179012ms","start":"2026-02-19T05:59:10.026155Z","end":"2026-02-19T05:59:10.144334Z","steps":["trace[1260692485] 'process raft request' (duration: 117.773992ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:10.250129Z","caller":"traceutil/trace.go:171","msg":"trace[1437035009] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"101.974356ms","start":"2026-02-19T05:59:10.148134Z","end":"2026-02-19T05:59:10.250109Z","steps":["trace[1437035009] 'process raft request' (duration: 93.176203ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:11.1498Z","caller":"traceutil/trace.go:171","msg":"trace[1097518703] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"100.444132ms","start":"2026-02-19T05:59:11.049345Z","end":"2026-02-19T05:59:11.149789Z","steps":["trace[1097518703] 'process raft request' (duration: 100.35761ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:14.884405Z","caller":"traceutil/trace.go:171","msg":"trace[637379512] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"163.017726ms","start":"2026-02-19T05:59:14.721364Z","end":"2026-02-19T05:59:14.884382Z","steps":["trace[637379512] 'read index received' (duration: 162.831942ms)","trace[637379512] 'applied index is now lower than readState.Index' (duration: 184.824µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:14.88452Z","caller":"traceutil/trace.go:171","msg":"trace[384696473] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"273.11902ms","start":"2026-02-19T05:59:14.611392Z","end":"2026-02-19T05:59:14.884511Z","steps":["trace[384696473] 'process raft request' (duration: 272.844984ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:14.88473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.349463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:59:14.884769Z","caller":"traceutil/trace.go:171","msg":"trace[301269148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"163.439645ms","start":"2026-02-19T05:59:14.721319Z","end":"2026-02-19T05:59:14.884758Z","steps":["trace[301269148] 'agreement among raft nodes before linearized reading' (duration: 163.306092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:14.884917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.450392ms","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-19T05:59:14.884951Z","caller":"traceutil/trace.go:171","msg":"trace[494217841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"162.521744ms","start":"2026-02-19T05:59:14.722422Z","end":"2026-02-19T05:59:14.884944Z","steps":["trace[494217841] 'agreement among raft nodes before linearized reading' (duration: 162.424002ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:14.885005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.140043ms","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-19T05:59:14.88509Z","caller":"traceutil/trace.go:171","msg":"trace[926787807] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"150.254946ms","start":"2026-02-19T05:59:14.734818Z","end":"2026-02-19T05:59:14.885073Z","steps":["trace[926787807] 'agreement among raft nodes before linearized reading' (duration: 150.065862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:15.246803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.977102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T05:59:15.246962Z","caller":"traceutil/trace.go:171","msg":"trace[292359564] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"359.185637ms","start":"2026-02-19T05:59:14.887756Z","end":"2026-02-19T05:59:15.246942Z","steps":["trace[292359564] 'process raft request' (duration: 67.813326ms)","trace[292359564] 'compare' (duration: 290.823839ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:15.247034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:14.887733Z","time spent":"359.266729ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:15.250035Z","caller":"traceutil/trace.go:171","msg":"trace[794035924] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"350.997937ms","start":"2026-02-19T05:59:14.899015Z","end":"2026-02-19T05:59:15.250013Z","steps":["trace[794035924] 'process raft request' (duration: 350.920475ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:15.25017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:14.898996Z","time spent":"351.10889ms","remote":"127.0.0.1:48252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18231,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:15.250231Z","caller":"traceutil/trace.go:171","msg":"trace[1912838559] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"360.880855ms","start":"2026-02-19T05:59:14.889311Z","end":"2026-02-19T05:59:15.250191Z","steps":["trace[1912838559] 'process raft request' (duration: 360.588028ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:15.25034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:14.889297Z","time spent":"360.984677ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:15.250478Z","caller":"traceutil/trace.go:171","msg":"trace[2097013161] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"362.423878ms","start":"2026-02-19T05:59:14.888045Z","end":"2026-02-19T05:59:15.250469Z","steps":["trace[2097013161] 'process raft request' (duration: 361.739363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:15.250521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:14.888015Z","time spent":"362.484599ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:17.81218Z","caller":"traceutil/trace.go:171","msg":"trace[1308909805] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"108.362787ms","start":"2026-02-19T05:59:17.703791Z","end":"2026-02-19T05:59:17.812154Z","steps":["trace[1308909805] 'process raft request' (duration: 105.873532ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:17.81234Z","caller":"traceutil/trace.go:171","msg":"trace[1818384159] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"107.510639ms","start":"2026-02-19T05:59:17.704823Z","end":"2026-02-19T05:59:17.812334Z","steps":["trace[1818384159] 'process raft request' (duration: 107.284574ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:17.812355Z","caller":"traceutil/trace.go:171","msg":"trace[609924261] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:716; }","duration":"106.936094ms","start":"2026-02-19T05:59:17.705395Z","end":"2026-02-19T05:59:17.812331Z","steps":["trace[609924261] 'read index received' (duration: 52.185813ms)","trace[609924261] 'applied index is now lower than readState.Index' (duration: 54.749321ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:17.812512Z","caller":"traceutil/trace.go:171","msg":"trace[1010463115] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"107.60404ms","start":"2026-02-19T05:59:17.704891Z","end":"2026-02-19T05:59:17.812496Z","steps":["trace[1010463115] 'process raft request' (duration: 107.388325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:17.812564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.1573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4206"} {"level":"info","ts":"2026-02-19T05:59:17.812601Z","caller":"traceutil/trace.go:171","msg":"trace[1861531558] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:699; }","duration":"107.230681ms","start":"2026-02-19T05:59:17.705358Z","end":"2026-02-19T05:59:17.812588Z","steps":["trace[1861531558] 'agreement among raft nodes before linearized reading' (duration: 107.070468ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:20.51618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.786438ms","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-19T05:59:20.516248Z","caller":"traceutil/trace.go:171","msg":"trace[707612932] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:709; }","duration":"213.899561ms","start":"2026-02-19T05:59:20.302334Z","end":"2026-02-19T05:59:20.516233Z","steps":["trace[707612932] 'range keys from in-memory index tree' (duration: 213.632555ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:20.644144Z","caller":"traceutil/trace.go:171","msg":"trace[1782396830] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"123.837837ms","start":"2026-02-19T05:59:20.520285Z","end":"2026-02-19T05:59:20.644123Z","steps":["trace[1782396830] 'process raft request' (duration: 123.672483ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:21.523215Z","caller":"traceutil/trace.go:171","msg":"trace[90505827] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:732; }","duration":"175.740493ms","start":"2026-02-19T05:59:21.347445Z","end":"2026-02-19T05:59:21.523186Z","steps":["trace[90505827] 'read index received' (duration: 175.489368ms)","trace[90505827] 'applied index is now lower than readState.Index' (duration: 249.995µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:21.523315Z","caller":"traceutil/trace.go:171","msg":"trace[2099763236] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"199.541925ms","start":"2026-02-19T05:59:21.323742Z","end":"2026-02-19T05:59:21.523284Z","steps":["trace[2099763236] 'process raft request' (duration: 199.29837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:21.523525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.059872ms","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-19T05:59:21.523578Z","caller":"traceutil/trace.go:171","msg":"trace[14598705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:711; }","duration":"176.170884ms","start":"2026-02-19T05:59:21.347393Z","end":"2026-02-19T05:59:21.523564Z","steps":["trace[14598705] 'agreement among raft nodes before linearized reading' (duration: 175.96433ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:21.523976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.241905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:59:21.524015Z","caller":"traceutil/trace.go:171","msg":"trace[2045693440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:711; }","duration":"176.312857ms","start":"2026-02-19T05:59:21.347691Z","end":"2026-02-19T05:59:21.524004Z","steps":["trace[2045693440] 'agreement among raft nodes before linearized reading' (duration: 176.174484ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:21.745495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.094299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T05:59:21.745583Z","caller":"traceutil/trace.go:171","msg":"trace[1833719307] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"216.836106ms","start":"2026-02-19T05:59:21.528733Z","end":"2026-02-19T05:59:21.745569Z","steps":["trace[1833719307] 'process raft request' (duration: 93.393049ms)","trace[1833719307] 'compare' (duration: 122.6928ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:23.256246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.875403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T05:59:23.256328Z","caller":"traceutil/trace.go:171","msg":"trace[1335717990] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:714; }","duration":"805.966315ms","start":"2026-02-19T05:59:22.450333Z","end":"2026-02-19T05:59:23.256299Z","steps":["trace[1335717990] 'count revisions from in-memory index tree' (duration: 805.773112ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:23.256316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.704869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-19T05:59:23.256372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:22.450283Z","time spent":"806.080517ms","remote":"127.0.0.1:48634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":23,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"info","ts":"2026-02-19T05:59:23.256385Z","caller":"traceutil/trace.go:171","msg":"trace[1242328735] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:714; }","duration":"608.818212ms","start":"2026-02-19T05:59:22.647553Z","end":"2026-02-19T05:59:23.256371Z","steps":["trace[1242328735] 'range keys from in-memory index tree' (duration: 608.585727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:23.256419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:22.647533Z","time spent":"608.876442ms","remote":"127.0.0.1:48358","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-19T05:59:23.256706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.709199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:23.256731Z","caller":"traceutil/trace.go:171","msg":"trace[1034047125] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:714; }","duration":"841.772829ms","start":"2026-02-19T05:59:22.414952Z","end":"2026-02-19T05:59:23.256725Z","steps":["trace[1034047125] 'count revisions from in-memory index tree' (duration: 841.599576ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:23.25692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:22.41493Z","time spent":"841.981564ms","remote":"127.0.0.1:48378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-19T05:59:24.028971Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024410,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T05:59:24.530085Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024410,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T05:59:25.030431Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024410,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T05:59:25.272598Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.012536856s","expected-duration":"1s"} {"level":"info","ts":"2026-02-19T05:59:25.272993Z","caller":"traceutil/trace.go:171","msg":"trace[1172598679] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"2.012997166s","start":"2026-02-19T05:59:23.259984Z","end":"2026-02-19T05:59:25.272981Z","steps":["trace[1172598679] 'process raft request' (duration: 2.01275879s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:25.273329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:23.259968Z","time spent":"2.013265022s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:25.273489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.745638083s","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-19T05:59:25.273573Z","caller":"traceutil/trace.go:171","msg":"trace[789570106] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:715; }","duration":"1.745775215s","start":"2026-02-19T05:59:23.527778Z","end":"2026-02-19T05:59:25.273553Z","steps":["trace[789570106] 'agreement among raft nodes before linearized reading' (duration: 1.745477779s)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:25.272935Z","caller":"traceutil/trace.go:171","msg":"trace[1877751218] linearizableReadLoop","detail":"{readStateIndex:737; appliedIndex:736; }","duration":"1.74508165s","start":"2026-02-19T05:59:23.527828Z","end":"2026-02-19T05:59:25.27291Z","steps":["trace[1877751218] 'read index received' (duration: 1.744934307s)","trace[1877751218] 'applied index is now lower than readState.Index' (duration: 144.203µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:25.273619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:23.527757Z","time spent":"1.745853037s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T05:59:25.751658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.482115ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T05:59:25.751922Z","caller":"traceutil/trace.go:171","msg":"trace[819279024] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"638.844971ms","start":"2026-02-19T05:59:25.113053Z","end":"2026-02-19T05:59:25.751898Z","steps":["trace[819279024] 'process raft request' (duration: 284.047949ms)","trace[819279024] 'compare' (duration: 354.358102ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:25.751957Z","caller":"traceutil/trace.go:171","msg":"trace[1417296213] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"475.281693ms","start":"2026-02-19T05:59:25.276645Z","end":"2026-02-19T05:59:25.751926Z","steps":["trace[1417296213] 'process raft request' (duration: 475.089209ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:25.752004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:25.113033Z","time spent":"638.933362ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:25.752111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:25.276625Z","time spent":"475.394416ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:25.752157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.256075006s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-02-19T05:59:25.752157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.408407067s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-19T05:59:25.752187Z","caller":"traceutil/trace.go:171","msg":"trace[501572730] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:717; }","duration":"1.256155308s","start":"2026-02-19T05:59:24.496023Z","end":"2026-02-19T05:59:25.752178Z","steps":["trace[501572730] 'agreement among raft nodes before linearized reading' (duration: 1.256052105s)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:25.752197Z","caller":"traceutil/trace.go:171","msg":"trace[1712340724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:717; }","duration":"1.408482679s","start":"2026-02-19T05:59:24.343704Z","end":"2026-02-19T05:59:25.752187Z","steps":["trace[1712340724] 'agreement among raft nodes before linearized reading' (duration: 1.408372216s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:25.752215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:24.496Z","time spent":"1.256206848s","remote":"127.0.0.1:48118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.74\" "} {"level":"warn","ts":"2026-02-19T05:59:25.752225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:24.343678Z","time spent":"1.40853918s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-19T05:59:25.75224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.709496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:25.752268Z","caller":"traceutil/trace.go:171","msg":"trace[1636524252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:717; }","duration":"513.764966ms","start":"2026-02-19T05:59:25.238494Z","end":"2026-02-19T05:59:25.752259Z","steps":["trace[1636524252] 'agreement among raft nodes before linearized reading' (duration: 513.717095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:25.752275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.529051ms","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-19T05:59:25.75229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:25.238476Z","time spent":"513.808488ms","remote":"127.0.0.1:48084","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-19T05:59:25.752207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.003076968s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:59:25.752311Z","caller":"traceutil/trace.go:171","msg":"trace[1450732155] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:717; }","duration":"746.588422ms","start":"2026-02-19T05:59:25.005711Z","end":"2026-02-19T05:59:25.752299Z","steps":["trace[1450732155] 'agreement among raft nodes before linearized reading' (duration: 746.534991ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:25.752323Z","caller":"traceutil/trace.go:171","msg":"trace[883144233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:717; }","duration":"2.003221271s","start":"2026-02-19T05:59:23.749091Z","end":"2026-02-19T05:59:25.752312Z","steps":["trace[883144233] 'agreement among raft nodes before linearized reading' (duration: 2.002990686s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:25.752341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:25.005696Z","time spent":"746.636413ms","remote":"127.0.0.1:48476","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-19T05:59:25.752353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:23.749072Z","time spent":"2.003272812s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T05:59:25.752529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.157925063s","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-19T05:59:25.752024Z","caller":"traceutil/trace.go:171","msg":"trace[83823666] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:737; }","duration":"478.387512ms","start":"2026-02-19T05:59:25.273618Z","end":"2026-02-19T05:59:25.752005Z","steps":["trace[83823666] 'read index received' (duration: 123.497049ms)","trace[83823666] 'applied index is now lower than readState.Index' (duration: 354.887613ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:25.752633Z","caller":"traceutil/trace.go:171","msg":"trace[209380859] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:717; }","duration":"2.158072827s","start":"2026-02-19T05:59:23.594536Z","end":"2026-02-19T05:59:25.752608Z","steps":["trace[209380859] 'agreement among raft nodes before linearized reading' (duration: 2.157798551s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:25.75273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:23.594515Z","time spent":"2.158200899s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-19T05:59:25.967902Z","caller":"traceutil/trace.go:171","msg":"trace[47567252] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"211.680802ms","start":"2026-02-19T05:59:25.756199Z","end":"2026-02-19T05:59:25.96788Z","steps":["trace[47567252] 'process raft request' (duration: 211.424887ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:25.968161Z","caller":"traceutil/trace.go:171","msg":"trace[1028704238] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"211.882666ms","start":"2026-02-19T05:59:25.756254Z","end":"2026-02-19T05:59:25.968137Z","steps":["trace[1028704238] 'process raft request' (duration: 211.581189ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:25.968161Z","caller":"traceutil/trace.go:171","msg":"trace[697976776] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"211.476368ms","start":"2026-02-19T05:59:25.756664Z","end":"2026-02-19T05:59:25.968141Z","steps":["trace[697976776] 'process raft request' (duration: 211.346705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.044119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.590833797s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T05:59:28.044329Z","caller":"traceutil/trace.go:171","msg":"trace[148423103] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"606.184424ms","start":"2026-02-19T05:59:27.438128Z","end":"2026-02-19T05:59:28.044312Z","steps":["trace[148423103] 'process raft request' (duration: 606.093862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.044395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:27.438109Z","time spent":"606.254076ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:28.044511Z","caller":"traceutil/trace.go:171","msg":"trace[621540383] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"2.075960265s","start":"2026-02-19T05:59:25.968524Z","end":"2026-02-19T05:59:28.044484Z","steps":["trace[621540383] 'process raft request' (duration: 484.675229ms)","trace[621540383] 'compare' (duration: 1.590308526s)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:28.044638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:25.968499Z","time spent":"2.076068167s","remote":"127.0.0.1:48118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:28.044711Z","caller":"traceutil/trace.go:171","msg":"trace[1331170526] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:745; }","duration":"1.804985293s","start":"2026-02-19T05:59:26.239707Z","end":"2026-02-19T05:59:28.044693Z","steps":["trace[1331170526] 'read index received' (duration: 213.477262ms)","trace[1331170526] 'applied index is now lower than readState.Index' (duration: 1.591506551s)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:28.044828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.805115635s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:28.044906Z","caller":"traceutil/trace.go:171","msg":"trace[1308856669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:723; }","duration":"1.805224458s","start":"2026-02-19T05:59:26.239666Z","end":"2026-02-19T05:59:28.044891Z","steps":["trace[1308856669] 'agreement among raft nodes before linearized reading' (duration: 1.805099925s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.044954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:26.239653Z","time spent":"1.80529268s","remote":"127.0.0.1:48084","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-19T05:59:28.360794Z","caller":"traceutil/trace.go:171","msg":"trace[1786860696] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:747; }","duration":"316.03038ms","start":"2026-02-19T05:59:28.04474Z","end":"2026-02-19T05:59:28.36077Z","steps":["trace[1786860696] 'read index received' (duration: 315.858127ms)","trace[1786860696] 'applied index is now lower than readState.Index' (duration: 171.193µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:28.361192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.273017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-19T05:59:28.361191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.279727ms","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-19T05:59:28.361209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.842846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:59:28.361285Z","caller":"traceutil/trace.go:171","msg":"trace[1128588592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:724; }","duration":"389.391219ms","start":"2026-02-19T05:59:27.971852Z","end":"2026-02-19T05:59:28.361243Z","steps":["trace[1128588592] 'agreement among raft nodes before linearized reading' (duration: 389.207395ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:28.361288Z","caller":"traceutil/trace.go:171","msg":"trace[52023948] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:724; }","duration":"389.406249ms","start":"2026-02-19T05:59:27.971849Z","end":"2026-02-19T05:59:28.361255Z","steps":["trace[52023948] 'agreement among raft nodes before linearized reading' (duration: 389.172365ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:28.361307Z","caller":"traceutil/trace.go:171","msg":"trace[1580461579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:724; }","duration":"388.967999ms","start":"2026-02-19T05:59:27.972321Z","end":"2026-02-19T05:59:28.361289Z","steps":["trace[1580461579] 'agreement among raft nodes before linearized reading' (duration: 388.722094ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.361324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:27.971834Z","time spent":"389.481601ms","remote":"127.0.0.1:48358","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-19T05:59:28.361324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:27.971816Z","time spent":"389.499782ms","remote":"127.0.0.1:48358","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-19T05:59:28.361351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:27.972315Z","time spent":"389.02735ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T05:59:28.361383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084420035s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-19T05:59:28.361252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.495919ms","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-19T05:59:28.361419Z","caller":"traceutil/trace.go:171","msg":"trace[409420977] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:724; }","duration":"1.084495697s","start":"2026-02-19T05:59:27.276911Z","end":"2026-02-19T05:59:28.361407Z","steps":["trace[409420977] 'agreement among raft nodes before linearized reading' (duration: 1.084398915s)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:28.361427Z","caller":"traceutil/trace.go:171","msg":"trace[1355111942] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:724; }","duration":"605.699963ms","start":"2026-02-19T05:59:27.755717Z","end":"2026-02-19T05:59:28.361417Z","steps":["trace[1355111942] 'agreement among raft nodes before linearized reading' (duration: 605.418627ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.361454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:27.75571Z","time spent":"605.737074ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T05:59:28.361454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:27.276888Z","time spent":"1.084558078s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-19T05:59:28.361476Z","caller":"traceutil/trace.go:171","msg":"trace[1949526184] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"611.199862ms","start":"2026-02-19T05:59:27.750265Z","end":"2026-02-19T05:59:28.361465Z","steps":["trace[1949526184] 'process raft request' (duration: 610.370604ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.361557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:27.75024Z","time spent":"611.261264ms","remote":"127.0.0.1:48246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4727,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:28.36157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.218643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:28.361616Z","caller":"traceutil/trace.go:171","msg":"trace[325286859] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:724; }","duration":"315.265114ms","start":"2026-02-19T05:59:28.046338Z","end":"2026-02-19T05:59:28.361603Z","steps":["trace[325286859] 'agreement among raft nodes before linearized reading' (duration: 315.195662ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.361648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:28.046297Z","time spent":"315.341436ms","remote":"127.0.0.1:48098","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-19T05:59:28.361775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.322065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-02-19T05:59:28.361799Z","caller":"traceutil/trace.go:171","msg":"trace[516264787] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:724; }","duration":"315.374017ms","start":"2026-02-19T05:59:28.046418Z","end":"2026-02-19T05:59:28.361792Z","steps":["trace[516264787] 'agreement among raft nodes before linearized reading' (duration: 315.320726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.361818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:28.046402Z","time spent":"315.411327ms","remote":"127.0.0.1:48238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-02-19T05:59:28.36192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.800518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:28.361968Z","caller":"traceutil/trace.go:171","msg":"trace[146530047] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:724; }","duration":"159.89374ms","start":"2026-02-19T05:59:28.202064Z","end":"2026-02-19T05:59:28.361958Z","steps":["trace[146530047] 'agreement among raft nodes before linearized reading' (duration: 159.824749ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.680403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.159333ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T05:59:28.680504Z","caller":"traceutil/trace.go:171","msg":"trace[891193561] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:748; }","duration":"311.425631ms","start":"2026-02-19T05:59:28.369061Z","end":"2026-02-19T05:59:28.680487Z","steps":["trace[891193561] 'read index received' (duration: 180.114126ms)","trace[891193561] 'applied index is now lower than readState.Index' (duration: 131.309975ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:28.680574Z","caller":"traceutil/trace.go:171","msg":"trace[1899213286] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"315.248663ms","start":"2026-02-19T05:59:28.365314Z","end":"2026-02-19T05:59:28.680563Z","steps":["trace[1899213286] 'process raft request' (duration: 183.831495ms)","trace[1899213286] 'compare' (duration: 130.821406ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:28.680656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:28.365295Z","time spent":"315.330065ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:28.680659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.577044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-19T05:59:28.680723Z","caller":"traceutil/trace.go:171","msg":"trace[723802295] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:725; }","duration":"311.667546ms","start":"2026-02-19T05:59:28.36904Z","end":"2026-02-19T05:59:28.680707Z","steps":["trace[723802295] 'agreement among raft nodes before linearized reading' (duration: 311.538134ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.680774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:28.369029Z","time spent":"311.735197ms","remote":"127.0.0.1:48364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-02-19T05:59:28.706049Z","caller":"traceutil/trace.go:171","msg":"trace[1330604319] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"335.888757ms","start":"2026-02-19T05:59:28.370131Z","end":"2026-02-19T05:59:28.70602Z","steps":["trace[1330604319] 'process raft request' (duration: 335.739904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.706223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:28.370115Z","time spent":"336.0215ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:28.706333Z","caller":"traceutil/trace.go:171","msg":"trace[49764143] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"336.02227ms","start":"2026-02-19T05:59:28.370293Z","end":"2026-02-19T05:59:28.706315Z","steps":["trace[49764143] 'process raft request' (duration: 335.687442ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.706439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:28.370271Z","time spent":"336.124323ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:28.706795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.399034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:28.706852Z","caller":"traceutil/trace.go:171","msg":"trace[1919768707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:729; }","duration":"333.477156ms","start":"2026-02-19T05:59:28.373362Z","end":"2026-02-19T05:59:28.706839Z","steps":["trace[1919768707] 'agreement among raft nodes before linearized reading' (duration: 333.381334ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.70688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:28.373354Z","time spent":"333.519927ms","remote":"127.0.0.1:48084","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-19T05:59:28.707064Z","caller":"traceutil/trace.go:171","msg":"trace[514084904] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"336.727556ms","start":"2026-02-19T05:59:28.370325Z","end":"2026-02-19T05:59:28.707053Z","steps":["trace[514084904] 'process raft request' (duration: 335.911758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.707135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:28.370307Z","time spent":"336.783586ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:28.707246Z","caller":"traceutil/trace.go:171","msg":"trace[1431835858] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"336.903829ms","start":"2026-02-19T05:59:28.370325Z","end":"2026-02-19T05:59:28.707229Z","steps":["trace[1431835858] 'process raft request' (duration: 336.336997ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:28.707284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:28.370306Z","time spent":"336.95591ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:30.302927Z","caller":"traceutil/trace.go:171","msg":"trace[30991515] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:753; }","duration":"411.435303ms","start":"2026-02-19T05:59:29.891468Z","end":"2026-02-19T05:59:30.302904Z","steps":["trace[30991515] 'read index received' (duration: 371.670737ms)","trace[30991515] 'applied index is now lower than readState.Index' (duration: 39.763206ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:30.30316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.147797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T05:59:30.303185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.673907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T05:59:30.303218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.204529ms","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-19T05:59:30.303258Z","caller":"traceutil/trace.go:171","msg":"trace[1164748536] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:729; }","duration":"410.783039ms","start":"2026-02-19T05:59:29.892457Z","end":"2026-02-19T05:59:30.30324Z","steps":["trace[1164748536] 'agreement among raft nodes before linearized reading' (duration: 410.648477ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:30.303252Z","caller":"traceutil/trace.go:171","msg":"trace[334888958] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:729; }","duration":"411.27638ms","start":"2026-02-19T05:59:29.891953Z","end":"2026-02-19T05:59:30.303229Z","steps":["trace[334888958] 'agreement among raft nodes before linearized reading' (duration: 411.103687ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:30.303274Z","caller":"traceutil/trace.go:171","msg":"trace[56591853] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:729; }","duration":"411.27737ms","start":"2026-02-19T05:59:29.891981Z","end":"2026-02-19T05:59:30.303259Z","steps":["trace[56591853] 'agreement among raft nodes before linearized reading' (duration: 411.180448ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:30.303293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:29.892449Z","time spent":"410.83734ms","remote":"127.0.0.1:53156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "} {"level":"warn","ts":"2026-02-19T05:59:30.303312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:29.891978Z","time spent":"411.324171ms","remote":"127.0.0.1:53156","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-19T05:59:30.303309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:29.891946Z","time spent":"411.348902ms","remote":"127.0.0.1:53156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "} {"level":"warn","ts":"2026-02-19T05:59:30.303658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.187429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:30.303683Z","caller":"traceutil/trace.go:171","msg":"trace[1263997804] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:729; }","duration":"412.2143ms","start":"2026-02-19T05:59:29.891462Z","end":"2026-02-19T05:59:30.303676Z","steps":["trace[1263997804] 'agreement among raft nodes before linearized reading' (duration: 411.583056ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:30.303702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:29.891416Z","time spent":"412.281001ms","remote":"127.0.0.1:48172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-02-19T05:59:30.838782Z","caller":"traceutil/trace.go:171","msg":"trace[79287624] linearizableReadLoop","detail":"{readStateIndex:755; appliedIndex:754; }","duration":"129.312522ms","start":"2026-02-19T05:59:30.709441Z","end":"2026-02-19T05:59:30.838754Z","steps":["trace[79287624] 'read index received' (duration: 129.094518ms)","trace[79287624] 'applied index is now lower than readState.Index' (duration: 216.804µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:30.838908Z","caller":"traceutil/trace.go:171","msg":"trace[1168499029] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"149.811144ms","start":"2026-02-19T05:59:30.689085Z","end":"2026-02-19T05:59:30.838896Z","steps":["trace[1168499029] 'process raft request' (duration: 149.510308ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:30.839145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.128837ms","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-19T05:59:30.839176Z","caller":"traceutil/trace.go:171","msg":"trace[807344737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:730; }","duration":"128.191818ms","start":"2026-02-19T05:59:30.710975Z","end":"2026-02-19T05:59:30.839167Z","steps":["trace[807344737] 'agreement among raft nodes before linearized reading' (duration: 128.057515ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:30.839305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.822881ms","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-19T05:59:30.839407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.974276ms","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-19T05:59:30.839437Z","caller":"traceutil/trace.go:171","msg":"trace[401935132] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:730; }","duration":"130.057948ms","start":"2026-02-19T05:59:30.709371Z","end":"2026-02-19T05:59:30.839429Z","steps":["trace[401935132] 'agreement among raft nodes before linearized reading' (duration: 129.975066ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:30.839435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.815212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:59:30.839518Z","caller":"traceutil/trace.go:171","msg":"trace[340942559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:730; }","duration":"128.928354ms","start":"2026-02-19T05:59:30.71057Z","end":"2026-02-19T05:59:30.839498Z","steps":["trace[340942559] 'agreement among raft nodes before linearized reading' (duration: 128.677879ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:30.839427Z","caller":"traceutil/trace.go:171","msg":"trace[1612152091] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:730; }","duration":"128.996536ms","start":"2026-02-19T05:59:30.710405Z","end":"2026-02-19T05:59:30.839402Z","steps":["trace[1612152091] 'agreement among raft nodes before linearized reading' (duration: 128.539226ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:31.171437Z","caller":"traceutil/trace.go:171","msg":"trace[428482689] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"324.258238ms","start":"2026-02-19T05:59:30.847156Z","end":"2026-02-19T05:59:31.171415Z","steps":["trace[428482689] 'process raft request' (duration: 324.220057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:31.171605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:30.847131Z","time spent":"324.39771ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:31.171695Z","caller":"traceutil/trace.go:171","msg":"trace[1037922040] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"325.32479ms","start":"2026-02-19T05:59:30.846336Z","end":"2026-02-19T05:59:31.171661Z","steps":["trace[1037922040] 'process raft request' (duration: 324.859289ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:31.171739Z","caller":"traceutil/trace.go:171","msg":"trace[509926464] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"325.299149ms","start":"2026-02-19T05:59:30.846426Z","end":"2026-02-19T05:59:31.171725Z","steps":["trace[509926464] 'process raft request' (duration: 324.910021ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:31.171838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:30.84642Z","time spent":"325.35243ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:31.171838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:30.846317Z","time spent":"325.450803ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:31.340043Z","caller":"traceutil/trace.go:171","msg":"trace[847931557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:734; }","duration":"100.019282ms","start":"2026-02-19T05:59:31.239996Z","end":"2026-02-19T05:59:31.340016Z","steps":["trace[847931557] 'range keys from in-memory index tree' (duration: 99.937701ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:45.269127Z","caller":"traceutil/trace.go:171","msg":"trace[1808183251] linearizableReadLoop","detail":"{readStateIndex:803; appliedIndex:802; }","duration":"300.425544ms","start":"2026-02-19T05:59:44.968675Z","end":"2026-02-19T05:59:45.2691Z","steps":["trace[1808183251] 'read index received' (duration: 300.272431ms)","trace[1808183251] 'applied index is now lower than readState.Index' (duration: 149.943µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:45.269158Z","caller":"traceutil/trace.go:171","msg":"trace[260798310] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"352.045046ms","start":"2026-02-19T05:59:44.917098Z","end":"2026-02-19T05:59:45.269143Z","steps":["trace[260798310] 'process raft request' (duration: 351.859232ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:45.269391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:44.917084Z","time spent":"352.221819ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:45.269405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.69917ms","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-19T05:59:45.269482Z","caller":"traceutil/trace.go:171","msg":"trace[695900578] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:774; }","duration":"300.818723ms","start":"2026-02-19T05:59:44.968644Z","end":"2026-02-19T05:59:45.269463Z","steps":["trace[695900578] 'agreement among raft nodes before linearized reading' (duration: 300.552447ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:45.269538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:44.968626Z","time spent":"300.903424ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T05:59:45.59438Z","caller":"traceutil/trace.go:171","msg":"trace[374191556] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:803; }","duration":"320.985426ms","start":"2026-02-19T05:59:45.273371Z","end":"2026-02-19T05:59:45.594356Z","steps":["trace[374191556] 'read index received' (duration: 289.488518ms)","trace[374191556] 'applied index is now lower than readState.Index' (duration: 31.495828ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:45.594442Z","caller":"traceutil/trace.go:171","msg":"trace[556878283] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"321.191062ms","start":"2026-02-19T05:59:45.273221Z","end":"2026-02-19T05:59:45.594412Z","steps":["trace[556878283] 'process raft request' (duration: 289.519871ms)","trace[556878283] 'compare' (duration: 31.458907ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:45.594542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:45.273196Z","time spent":"321.290944ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:45.594587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.198271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-19T05:59:45.594628Z","caller":"traceutil/trace.go:171","msg":"trace[94136273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"321.277632ms","start":"2026-02-19T05:59:45.273339Z","end":"2026-02-19T05:59:45.594616Z","steps":["trace[94136273] 'agreement among raft nodes before linearized reading' (duration: 321.126569ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:45.59467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:45.273328Z","time spent":"321.334454ms","remote":"127.0.0.1:48358","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-19T05:59:45.622177Z","caller":"traceutil/trace.go:171","msg":"trace[1786290322] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"348.308564ms","start":"2026-02-19T05:59:45.273854Z","end":"2026-02-19T05:59:45.622163Z","steps":["trace[1786290322] 'process raft request' (duration: 348.236113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:45.622273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.701614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:45.62231Z","caller":"traceutil/trace.go:171","msg":"trace[594746437] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:776; }","duration":"138.786606ms","start":"2026-02-19T05:59:45.483514Z","end":"2026-02-19T05:59:45.622301Z","steps":["trace[594746437] 'agreement among raft nodes before linearized reading' (duration: 138.677314ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:45.622305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:45.273838Z","time spent":"348.400297ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:45.622603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.619696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-19T05:59:45.622627Z","caller":"traceutil/trace.go:171","msg":"trace[1553512377] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:776; }","duration":"345.661648ms","start":"2026-02-19T05:59:45.276958Z","end":"2026-02-19T05:59:45.62262Z","steps":["trace[1553512377] 'agreement among raft nodes before linearized reading' (duration: 345.204298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:45.62267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:45.27694Z","time spent":"345.726139ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-19T05:59:45.75553Z","caller":"traceutil/trace.go:171","msg":"trace[911958745] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"129.460567ms","start":"2026-02-19T05:59:45.626043Z","end":"2026-02-19T05:59:45.755503Z","steps":["trace[911958745] 'process raft request' (duration: 90.409887ms)","trace[911958745] 'compare' (duration: 38.939397ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:47.40102Z","caller":"traceutil/trace.go:171","msg":"trace[395859098] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"123.257003ms","start":"2026-02-19T05:59:47.277739Z","end":"2026-02-19T05:59:47.400996Z","steps":["trace[395859098] 'process raft request' (duration: 123.103569ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:47.864543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.734403ms","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-19T05:59:47.864582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.333587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:59:47.864618Z","caller":"traceutil/trace.go:171","msg":"trace[1087260656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:780; }","duration":"104.873047ms","start":"2026-02-19T05:59:47.759727Z","end":"2026-02-19T05:59:47.8646Z","steps":["trace[1087260656] 'range keys from in-memory index tree' (duration: 104.57894ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:47.864644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.369362ms","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-19T05:59:47.864651Z","caller":"traceutil/trace.go:171","msg":"trace[112332378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:780; }","duration":"237.436309ms","start":"2026-02-19T05:59:47.627196Z","end":"2026-02-19T05:59:47.864632Z","steps":["trace[112332378] 'range keys from in-memory index tree' (duration: 237.156203ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:47.864698Z","caller":"traceutil/trace.go:171","msg":"trace[1092682724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:780; }","duration":"266.466384ms","start":"2026-02-19T05:59:47.598215Z","end":"2026-02-19T05:59:47.864681Z","steps":["trace[1092682724] 'range keys from in-memory index tree' (duration: 266.186437ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:47.8647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.486995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T05:59:47.864793Z","caller":"traceutil/trace.go:171","msg":"trace[1502349945] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:780; }","duration":"207.625998ms","start":"2026-02-19T05:59:47.657145Z","end":"2026-02-19T05:59:47.864771Z","steps":["trace[1502349945] 'count revisions from in-memory index tree' (duration: 207.390593ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:47.864811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.879218ms","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-19T05:59:47.864884Z","caller":"traceutil/trace.go:171","msg":"trace[294483266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:780; }","duration":"184.98844ms","start":"2026-02-19T05:59:47.679878Z","end":"2026-02-19T05:59:47.864866Z","steps":["trace[294483266] 'range keys from in-memory index tree' (duration: 184.712064ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:48.079944Z","caller":"traceutil/trace.go:171","msg":"trace[1566517107] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"211.057661ms","start":"2026-02-19T05:59:47.868862Z","end":"2026-02-19T05:59:48.079919Z","steps":["trace[1566517107] 'process raft request' (duration: 210.732464ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:48.613822Z","caller":"traceutil/trace.go:171","msg":"trace[1050128253] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"744.641333ms","start":"2026-02-19T05:59:47.869156Z","end":"2026-02-19T05:59:48.613798Z","steps":["trace[1050128253] 'process raft request' (duration: 744.564281ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:48.613853Z","caller":"traceutil/trace.go:171","msg":"trace[1771582414] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"744.737375ms","start":"2026-02-19T05:59:47.869079Z","end":"2026-02-19T05:59:48.613816Z","steps":["trace[1771582414] 'process raft request' (duration: 738.066072ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:48.613962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:47.869122Z","time spent":"744.770986ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:48.613982Z","caller":"traceutil/trace.go:171","msg":"trace[1671160677] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:810; }","duration":"415.649853ms","start":"2026-02-19T05:59:48.198313Z","end":"2026-02-19T05:59:48.613963Z","steps":["trace[1671160677] 'read index received' (duration: 408.731325ms)","trace[1671160677] 'applied index is now lower than readState.Index' (duration: 6.917688ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T05:59:48.614001Z","caller":"traceutil/trace.go:171","msg":"trace[1714491106] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"744.690494ms","start":"2026-02-19T05:59:47.86929Z","end":"2026-02-19T05:59:48.613981Z","steps":["trace[1714491106] 'process raft request' (duration: 744.476929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:48.614102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.779796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T05:59:48.614084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:47.869065Z","time spent":"744.871668ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:48.614132Z","caller":"traceutil/trace.go:171","msg":"trace[1735428631] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:784; }","duration":"415.873128ms","start":"2026-02-19T05:59:48.198252Z","end":"2026-02-19T05:59:48.614125Z","steps":["trace[1735428631] 'agreement among raft nodes before linearized reading' (duration: 415.773596ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:48.614154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:48.198224Z","time spent":"415.923959ms","remote":"127.0.0.1:48380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-19T05:59:48.614179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:47.869253Z","time spent":"744.858447ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:49.08249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.624346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T05:59:49.082618Z","caller":"traceutil/trace.go:171","msg":"trace[844246821] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"305.77546ms","start":"2026-02-19T05:59:48.776818Z","end":"2026-02-19T05:59:49.082594Z","steps":["trace[844246821] 'process raft request' (duration: 203.637653ms)","trace[844246821] 'compare' (duration: 100.079963ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:49.082704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:48.776797Z","time spent":"305.863491ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:49.69537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.746005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:49.695456Z","caller":"traceutil/trace.go:171","msg":"trace[1891811486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:785; }","duration":"454.887768ms","start":"2026-02-19T05:59:49.240548Z","end":"2026-02-19T05:59:49.695435Z","steps":["trace[1891811486] 'range keys from in-memory index tree' (duration: 454.680023ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:49.695461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.242453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-19T05:59:49.695505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:49.240529Z","time spent":"454.965479ms","remote":"127.0.0.1:48084","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-19T05:59:49.695512Z","caller":"traceutil/trace.go:171","msg":"trace[1237343683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:785; }","duration":"289.295115ms","start":"2026-02-19T05:59:49.406203Z","end":"2026-02-19T05:59:49.695498Z","steps":["trace[1237343683] 'range keys from in-memory index tree' (duration: 288.994788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:50.585253Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024607,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T05:59:51.08625Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024607,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T05:59:51.177342Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.451180416s","expected-duration":"1s"} {"level":"info","ts":"2026-02-19T05:59:51.178369Z","caller":"traceutil/trace.go:171","msg":"trace[319102644] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"1.478041534s","start":"2026-02-19T05:59:49.700298Z","end":"2026-02-19T05:59:51.17834Z","steps":["trace[319102644] 'process raft request' (duration: 1.477308458s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:51.17867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:49.700279Z","time spent":"1.478195877s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:51.637329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.077975ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-19T05:59:51.637545Z","caller":"traceutil/trace.go:171","msg":"trace[1613699274] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:814; }","duration":"1.553110619s","start":"2026-02-19T05:59:50.084292Z","end":"2026-02-19T05:59:51.637403Z","steps":["trace[1613699274] 'read index received' (duration: 1.093343476s)","trace[1613699274] 'applied index is now lower than readState.Index' (duration: 459.765853ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T05:59:51.637809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.068719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T05:59:51.637793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.553478317s","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-19T05:59:51.637851Z","caller":"traceutil/trace.go:171","msg":"trace[746602859] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:786; }","duration":"743.163661ms","start":"2026-02-19T05:59:50.894678Z","end":"2026-02-19T05:59:51.637841Z","steps":["trace[746602859] 'agreement among raft nodes before linearized reading' (duration: 743.067319ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:51.637875Z","caller":"traceutil/trace.go:171","msg":"trace[92282386] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:786; }","duration":"1.55360552s","start":"2026-02-19T05:59:50.08425Z","end":"2026-02-19T05:59:51.637855Z","steps":["trace[92282386] 'agreement among raft nodes before linearized reading' (duration: 1.553356974s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:51.637926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:50.084211Z","time spent":"1.553705842s","remote":"127.0.0.1:48358","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-19T05:59:51.637832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.39266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T05:59:51.638051Z","caller":"traceutil/trace.go:171","msg":"trace[908974558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:786; }","duration":"397.593414ms","start":"2026-02-19T05:59:51.240377Z","end":"2026-02-19T05:59:51.63797Z","steps":["trace[908974558] 'agreement among raft nodes before linearized reading' (duration: 397.38033ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:51.638141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020072631s","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-19T05:59:51.638182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:51.240358Z","time spent":"397.81231ms","remote":"127.0.0.1:48084","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-19T05:59:51.638149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.758341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-19T05:59:51.638201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020679483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-19T05:59:51.638263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020671463s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T05:59:51.638268Z","caller":"traceutil/trace.go:171","msg":"trace[1450435015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:786; }","duration":"1.020793796s","start":"2026-02-19T05:59:50.61746Z","end":"2026-02-19T05:59:51.638254Z","steps":["trace[1450435015] 'agreement among raft nodes before linearized reading' (duration: 1.02056593s)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:51.638271Z","caller":"traceutil/trace.go:171","msg":"trace[1123356590] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:786; }","duration":"642.983216ms","start":"2026-02-19T05:59:50.995258Z","end":"2026-02-19T05:59:51.638241Z","steps":["trace[1123356590] 'agreement among raft nodes before linearized reading' (duration: 642.643208ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:51.638291Z","caller":"traceutil/trace.go:171","msg":"trace[405731133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:786; }","duration":"1.020700144s","start":"2026-02-19T05:59:50.617584Z","end":"2026-02-19T05:59:51.638284Z","steps":["trace[405731133] 'agreement among raft nodes before linearized reading' (duration: 1.020361986s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:51.638327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:50.617445Z","time spent":"1.020848467s","remote":"127.0.0.1:48358","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-19T05:59:51.638337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:50.995242Z","time spent":"643.083789ms","remote":"127.0.0.1:48418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":66,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-02-19T05:59:51.63839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:50.617524Z","time spent":"1.020798146s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-19T05:59:51.638207Z","caller":"traceutil/trace.go:171","msg":"trace[1851377062] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:786; }","duration":"1.020180933s","start":"2026-02-19T05:59:50.618011Z","end":"2026-02-19T05:59:51.638192Z","steps":["trace[1851377062] 'agreement among raft nodes before linearized reading' (duration: 1.019974147s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:51.638495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:50.618002Z","time spent":"1.020482599s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T05:59:51.637928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:50.894658Z","time spent":"743.258083ms","remote":"127.0.0.1:48494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-02-19T05:59:51.638718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.09025221s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T05:59:51.638797Z","caller":"traceutil/trace.go:171","msg":"trace[952807850] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:786; }","duration":"1.090373352s","start":"2026-02-19T05:59:50.548413Z","end":"2026-02-19T05:59:51.638786Z","steps":["trace[952807850] 'agreement among raft nodes before linearized reading' (duration: 1.090155338s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:51.638851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:50.548393Z","time spent":"1.090447014s","remote":"127.0.0.1:48404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":13,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-02-19T05:59:51.766055Z","caller":"traceutil/trace.go:171","msg":"trace[283405856] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"123.983518ms","start":"2026-02-19T05:59:51.642037Z","end":"2026-02-19T05:59:51.76602Z","steps":["trace[283405856] 'process raft request' (duration: 123.756293ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:51.947056Z","caller":"traceutil/trace.go:171","msg":"trace[824946158] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"303.821208ms","start":"2026-02-19T05:59:51.643187Z","end":"2026-02-19T05:59:51.947008Z","steps":["trace[824946158] 'process raft request' (duration: 303.408239ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T05:59:51.947052Z","caller":"traceutil/trace.go:171","msg":"trace[1041746189] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"303.803548ms","start":"2026-02-19T05:59:51.643216Z","end":"2026-02-19T05:59:51.947019Z","steps":["trace[1041746189] 'process raft request' (duration: 303.593774ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:51.94724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:51.643158Z","time spent":"303.983122ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T05:59:51.94725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:51.643182Z","time spent":"303.966771ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T05:59:51.947251Z","caller":"traceutil/trace.go:171","msg":"trace[1351425344] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"303.793238ms","start":"2026-02-19T05:59:51.643428Z","end":"2026-02-19T05:59:51.947221Z","steps":["trace[1351425344] 'process raft request' (duration: 303.538252ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T05:59:51.947393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T05:59:51.64342Z","time spent":"303.89299ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:04.463379Z","caller":"traceutil/trace.go:171","msg":"trace[376838639] linearizableReadLoop","detail":"{readStateIndex:905; appliedIndex:904; }","duration":"470.496863ms","start":"2026-02-19T06:00:03.99286Z","end":"2026-02-19T06:00:04.463357Z","steps":["trace[376838639] 'read index received' (duration: 470.33584ms)","trace[376838639] 'applied index is now lower than readState.Index' (duration: 159.913µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T06:00:04.463522Z","caller":"traceutil/trace.go:171","msg":"trace[1281056268] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"601.097675ms","start":"2026-02-19T06:00:03.862413Z","end":"2026-02-19T06:00:04.46351Z","steps":["trace[1281056268] 'process raft request' (duration: 600.804708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:04.463629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:03.862394Z","time spent":"601.161966ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:04.463784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.52755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T06:00:04.463862Z","caller":"traceutil/trace.go:171","msg":"trace[1375996750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:872; }","duration":"467.660563ms","start":"2026-02-19T06:00:03.996183Z","end":"2026-02-19T06:00:04.463844Z","steps":["trace[1375996750] 'agreement among raft nodes before linearized reading' (duration: 467.477009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:04.46391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:03.996157Z","time spent":"467.742615ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T06:00:04.464018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.131792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T06:00:04.464048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.192919ms","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-19T06:00:04.464084Z","caller":"traceutil/trace.go:171","msg":"trace[707503124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:872; }","duration":"223.264534ms","start":"2026-02-19T06:00:04.240805Z","end":"2026-02-19T06:00:04.464069Z","steps":["trace[707503124] 'agreement among raft nodes before linearized reading' (duration: 223.129792ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T06:00:04.464086Z","caller":"traceutil/trace.go:171","msg":"trace[1186768839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:872; }","duration":"471.274071ms","start":"2026-02-19T06:00:03.9928Z","end":"2026-02-19T06:00:04.464074Z","steps":["trace[1186768839] 'agreement among raft nodes before linearized reading' (duration: 471.146088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:04.464119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:03.992775Z","time spent":"471.335971ms","remote":"127.0.0.1:48358","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-19T06:00:04.464655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.644349ms","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-19T06:00:04.464843Z","caller":"traceutil/trace.go:171","msg":"trace[857702038] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:872; }","duration":"445.885764ms","start":"2026-02-19T06:00:04.018926Z","end":"2026-02-19T06:00:04.464812Z","steps":["trace[857702038] 'agreement among raft nodes before linearized reading' (duration: 445.109188ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:04.464924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:04.018905Z","time spent":"446.002886ms","remote":"127.0.0.1:48358","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-19T06:00:04.999193Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024807,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T06:00:05.027296Z","caller":"traceutil/trace.go:171","msg":"trace[1393781443] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"559.05627ms","start":"2026-02-19T06:00:04.468213Z","end":"2026-02-19T06:00:05.02727Z","steps":["trace[1393781443] 'process raft request' (duration: 538.132351ms)","trace[1393781443] 'compare' (duration: 20.269716ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:05.027442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:04.468199Z","time spent":"559.174843ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:05.029686Z","caller":"traceutil/trace.go:171","msg":"trace[1736444264] linearizableReadLoop","detail":"{readStateIndex:908; appliedIndex:905; }","duration":"530.588308ms","start":"2026-02-19T06:00:04.499083Z","end":"2026-02-19T06:00:05.029672Z","steps":["trace[1736444264] 'read index received' (duration: 507.242336ms)","trace[1736444264] 'applied index is now lower than readState.Index' (duration: 23.345342ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T06:00:05.029744Z","caller":"traceutil/trace.go:171","msg":"trace[31968060] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"560.852358ms","start":"2026-02-19T06:00:04.468851Z","end":"2026-02-19T06:00:05.029703Z","steps":["trace[31968060] 'process raft request' (duration: 560.721935ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T06:00:05.029765Z","caller":"traceutil/trace.go:171","msg":"trace[92025976] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"560.297177ms","start":"2026-02-19T06:00:04.469432Z","end":"2026-02-19T06:00:05.029729Z","steps":["trace[92025976] 'process raft request' (duration: 560.213175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:05.029822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.735201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-02-19T06:00:05.029833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.139383ms","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-19T06:00:05.029846Z","caller":"traceutil/trace.go:171","msg":"trace[2094001329] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:875; }","duration":"530.796843ms","start":"2026-02-19T06:00:04.499042Z","end":"2026-02-19T06:00:05.029839Z","steps":["trace[2094001329] 'agreement among raft nodes before linearized reading' (duration: 530.692801ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:05.029869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:04.499029Z","time spent":"530.835063ms","remote":"127.0.0.1:48118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.74\" "} {"level":"info","ts":"2026-02-19T06:00:05.029868Z","caller":"traceutil/trace.go:171","msg":"trace[1117414321] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:875; }","duration":"428.216234ms","start":"2026-02-19T06:00:04.601642Z","end":"2026-02-19T06:00:05.029858Z","steps":["trace[1117414321] 'agreement among raft nodes before linearized reading' (duration: 428.139873ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:05.02989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:04.601629Z","time spent":"428.255086ms","remote":"127.0.0.1:48464","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":"warn","ts":"2026-02-19T06:00:05.029926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:04.469424Z","time spent":"560.413519ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:05.029914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:04.46882Z","time spent":"561.007222ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:19.121675Z","caller":"traceutil/trace.go:171","msg":"trace[237454143] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"598.522018ms","start":"2026-02-19T06:00:18.523129Z","end":"2026-02-19T06:00:19.121651Z","steps":["trace[237454143] 'process raft request' (duration: 598.372675ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:19.121818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:18.523118Z","time spent":"598.627301ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:19.891165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.603807ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T06:00:19.891285Z","caller":"traceutil/trace.go:171","msg":"trace[1575463384] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"456.668086ms","start":"2026-02-19T06:00:19.434598Z","end":"2026-02-19T06:00:19.891266Z","steps":["trace[1575463384] 'process raft request' (duration: 176.843815ms)","trace[1575463384] 'compare' (duration: 279.473184ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:19.891542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:19.434581Z","time spent":"456.87966ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:23.742337Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024978,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T06:00:23.814114Z","caller":"traceutil/trace.go:171","msg":"trace[1663547419] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"598.082039ms","start":"2026-02-19T06:00:23.216014Z","end":"2026-02-19T06:00:23.814096Z","steps":["trace[1663547419] 'process raft request' (duration: 597.954306ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:23.814218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:23.21598Z","time spent":"598.185671ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:23.948134Z","caller":"traceutil/trace.go:171","msg":"trace[661785153] linearizableReadLoop","detail":"{readStateIndex:983; appliedIndex:980; }","duration":"706.647095ms","start":"2026-02-19T06:00:23.241462Z","end":"2026-02-19T06:00:23.948109Z","steps":["trace[661785153] 'read index received' (duration: 572.522569ms)","trace[661785153] 'applied index is now lower than readState.Index' (duration: 134.123576ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T06:00:23.948514Z","caller":"traceutil/trace.go:171","msg":"trace[234435267] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"731.93637ms","start":"2026-02-19T06:00:23.216565Z","end":"2026-02-19T06:00:23.948501Z","steps":["trace[234435267] 'process raft request' (duration: 665.142693ms)","trace[234435267] 'compare' (duration: 66.218955ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:23.948655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:23.216544Z","time spent":"732.008121ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:23.94878Z","caller":"traceutil/trace.go:171","msg":"trace[1999544145] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"731.447529ms","start":"2026-02-19T06:00:23.217322Z","end":"2026-02-19T06:00:23.94877Z","steps":["trace[1999544145] 'process raft request' (duration: 730.727104ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:23.948825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:23.217309Z","time spent":"731.49055ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:23.949228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.75922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T06:00:23.949322Z","caller":"traceutil/trace.go:171","msg":"trace[1839048138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:946; }","duration":"707.895563ms","start":"2026-02-19T06:00:23.24141Z","end":"2026-02-19T06:00:23.949306Z","steps":["trace[1839048138] 'agreement among raft nodes before linearized reading' (duration: 707.76788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:23.950016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:23.24139Z","time spent":"707.957644ms","remote":"127.0.0.1:48084","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-19T06:00:25.058862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:24.500824Z","time spent":"558.035239ms","remote":"127.0.0.1:48118","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-19T06:00:25.718072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024986,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T06:00:26.022257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.071654ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T06:00:26.022336Z","caller":"traceutil/trace.go:171","msg":"trace[802797322] linearizableReadLoop","detail":"{readStateIndex:986; appliedIndex:985; }","duration":"805.32771ms","start":"2026-02-19T06:00:25.216997Z","end":"2026-02-19T06:00:26.022325Z","steps":["trace[802797322] 'read index received' (duration: 684.047721ms)","trace[802797322] 'applied index is now lower than readState.Index' (duration: 121.279139ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T06:00:26.022401Z","caller":"traceutil/trace.go:171","msg":"trace[427914425] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"962.570833ms","start":"2026-02-19T06:00:25.059823Z","end":"2026-02-19T06:00:26.022394Z","steps":["trace[427914425] 'process raft request' (duration: 841.279254ms)","trace[427914425] 'compare' (duration: 120.733736ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:26.022438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:25.059798Z","time spent":"962.618944ms","remote":"127.0.0.1:48118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:26.022659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.299844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T06:00:26.02272Z","caller":"traceutil/trace.go:171","msg":"trace[551046764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:948; }","duration":"782.389546ms","start":"2026-02-19T06:00:25.240317Z","end":"2026-02-19T06:00:26.022707Z","steps":["trace[551046764] 'agreement among raft nodes before linearized reading' (duration: 782.230322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:26.022749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:25.240291Z","time spent":"782.452917ms","remote":"127.0.0.1:48084","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-19T06:00:26.022863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.873101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-19T06:00:26.022888Z","caller":"traceutil/trace.go:171","msg":"trace[1881107087] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:948; }","duration":"805.937032ms","start":"2026-02-19T06:00:25.216944Z","end":"2026-02-19T06:00:26.022881Z","steps":["trace[1881107087] 'agreement among raft nodes before linearized reading' (duration: 805.873651ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:26.022909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:25.216921Z","time spent":"805.981753ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T06:00:26.022974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.079633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-19T06:00:26.022996Z","caller":"traceutil/trace.go:171","msg":"trace[1533160671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:948; }","duration":"205.126714ms","start":"2026-02-19T06:00:25.817863Z","end":"2026-02-19T06:00:26.02299Z","steps":["trace[1533160671] 'agreement among raft nodes before linearized reading' (duration: 205.022141ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:26.023114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.138906ms","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-19T06:00:26.023138Z","caller":"traceutil/trace.go:171","msg":"trace[355814673] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:948; }","duration":"648.188879ms","start":"2026-02-19T06:00:25.374941Z","end":"2026-02-19T06:00:26.02313Z","steps":["trace[355814673] 'agreement among raft nodes before linearized reading' (duration: 648.155178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:26.023156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:25.374929Z","time spent":"648.221609ms","remote":"127.0.0.1:48614","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-19T06:00:26.528499Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770024994,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T06:00:26.954057Z","caller":"traceutil/trace.go:171","msg":"trace[80579863] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"925.936534ms","start":"2026-02-19T06:00:26.028075Z","end":"2026-02-19T06:00:26.954011Z","steps":["trace[80579863] 'process raft request' (duration: 886.120797ms)","trace[80579863] 'compare' (duration: 39.48877ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:26.954199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:26.028057Z","time spent":"926.074096ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:27.280051Z","caller":"traceutil/trace.go:171","msg":"trace[613033758] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"1.251836227s","start":"2026-02-19T06:00:26.028194Z","end":"2026-02-19T06:00:27.28003Z","steps":["trace[613033758] 'process raft request' (duration: 1.197589299s)","trace[613033758] 'compare' (duration: 54.112845ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:27.280173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:26.028179Z","time spent":"1.251938989s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:27.280333Z","caller":"traceutil/trace.go:171","msg":"trace[1208384944] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"1.252060251s","start":"2026-02-19T06:00:26.028249Z","end":"2026-02-19T06:00:27.280309Z","steps":["trace[1208384944] 'process raft request' (duration: 1.251752755s)"],"step_count":1} {"level":"info","ts":"2026-02-19T06:00:27.280412Z","caller":"traceutil/trace.go:171","msg":"trace[2055275446] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"1.252133723s","start":"2026-02-19T06:00:26.028269Z","end":"2026-02-19T06:00:27.280403Z","steps":["trace[2055275446] 'process raft request' (duration: 1.251920059s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:27.280453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:26.02826Z","time spent":"1.252171884s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:27.280458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:26.02824Z","time spent":"1.252141373s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:27.280339Z","caller":"traceutil/trace.go:171","msg":"trace[175057090] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:986; }","duration":"1.251898878s","start":"2026-02-19T06:00:26.028419Z","end":"2026-02-19T06:00:27.280318Z","steps":["trace[175057090] 'read index received' (duration: 885.771669ms)","trace[175057090] 'applied index is now lower than readState.Index' (duration: 366.125479ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:27.280577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.251371777s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-19T06:00:27.280603Z","caller":"traceutil/trace.go:171","msg":"trace[765129807] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:952; }","duration":"1.251396927s","start":"2026-02-19T06:00:26.0292Z","end":"2026-02-19T06:00:27.280597Z","steps":["trace[765129807] 'agreement among raft nodes before linearized reading' (duration: 1.251350906s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:27.28062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:26.029175Z","time spent":"1.251441509s","remote":"127.0.0.1:48364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-02-19T06:00:27.280612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252171764s","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-19T06:00:27.280677Z","caller":"traceutil/trace.go:171","msg":"trace[220621178] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:952; }","duration":"1.252259386s","start":"2026-02-19T06:00:26.028401Z","end":"2026-02-19T06:00:27.28066Z","steps":["trace[220621178] 'agreement among raft nodes before linearized reading' (duration: 1.252085332s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:27.28072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:26.028394Z","time spent":"1.252313637s","remote":"127.0.0.1:48358","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-19T06:00:27.964102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.152206ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T06:00:27.964294Z","caller":"traceutil/trace.go:171","msg":"trace[529390667] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"612.739094ms","start":"2026-02-19T06:00:27.351539Z","end":"2026-02-19T06:00:27.964278Z","steps":["trace[529390667] 'process raft request' (duration: 612.653183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:27.964363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:27.351515Z","time spent":"612.813987ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:27.964472Z","caller":"traceutil/trace.go:171","msg":"trace[999594153] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"679.976772ms","start":"2026-02-19T06:00:27.284318Z","end":"2026-02-19T06:00:27.964295Z","steps":["trace[999594153] 'process raft request' (duration: 150.55627ms)","trace[999594153] 'compare' (duration: 529.010063ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:27.964688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:27.284302Z","time spent":"680.293608ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:28.387262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.321813ms","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-19T06:00:28.387412Z","caller":"traceutil/trace.go:171","msg":"trace[406513554] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:954; }","duration":"294.486547ms","start":"2026-02-19T06:00:28.092906Z","end":"2026-02-19T06:00:28.387392Z","steps":["trace[406513554] 'range keys from in-memory index tree' (duration: 294.305913ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T06:00:29.113751Z","caller":"traceutil/trace.go:171","msg":"trace[2064471286] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"146.520472ms","start":"2026-02-19T06:00:28.967192Z","end":"2026-02-19T06:00:29.113713Z","steps":["trace[2064471286] 'process raft request' (duration: 146.343828ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:29.85411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.751308ms","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-19T06:00:29.85418Z","caller":"traceutil/trace.go:171","msg":"trace[190696860] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:955; }","duration":"568.909741ms","start":"2026-02-19T06:00:29.285252Z","end":"2026-02-19T06:00:29.854162Z","steps":["trace[190696860] 'range keys from in-memory index tree' (duration: 568.598745ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:29.854213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.285237Z","time spent":"568.968473ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T06:00:29.85421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.381943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T06:00:29.854292Z","caller":"traceutil/trace.go:171","msg":"trace[550571515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:955; }","duration":"616.502706ms","start":"2026-02-19T06:00:29.237766Z","end":"2026-02-19T06:00:29.854268Z","steps":["trace[550571515] 'range keys from in-memory index tree' (duration: 616.277411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:29.85434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.23775Z","time spent":"616.580917ms","remote":"127.0.0.1:48084","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-19T06:00:29.854401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.256768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-19T06:00:29.854429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.33424ms","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-19T06:00:29.854453Z","caller":"traceutil/trace.go:171","msg":"trace[661555332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:955; }","duration":"568.317279ms","start":"2026-02-19T06:00:29.286123Z","end":"2026-02-19T06:00:29.854441Z","steps":["trace[661555332] 'range keys from in-memory index tree' (duration: 568.143274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:29.85449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.286118Z","time spent":"568.36496ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-19T06:00:29.854484Z","caller":"traceutil/trace.go:171","msg":"trace[1804184389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:955; }","duration":"568.394251ms","start":"2026-02-19T06:00:29.286071Z","end":"2026-02-19T06:00:29.854465Z","steps":["trace[1804184389] 'range keys from in-memory index tree' (duration: 568.149175ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:29.854545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.286065Z","time spent":"568.465312ms","remote":"127.0.0.1:48358","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-19T06:00:30.356568Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770025010,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T06:00:30.668786Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.308526347s","expected-duration":"1s"} {"level":"info","ts":"2026-02-19T06:00:30.669202Z","caller":"traceutil/trace.go:171","msg":"trace[568476248] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"1.309046318s","start":"2026-02-19T06:00:29.360132Z","end":"2026-02-19T06:00:30.669179Z","steps":["trace[568476248] 'process raft request' (duration: 1.308897905s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:30.669371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.360108Z","time spent":"1.309191261s","remote":"127.0.0.1:48246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5204,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:31.30964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.5892ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T06:00:31.310459Z","caller":"traceutil/trace.go:171","msg":"trace[2005508007] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"1.451784689s","start":"2026-02-19T06:00:29.858658Z","end":"2026-02-19T06:00:31.310443Z","steps":["trace[2005508007] 'process raft request' (duration: 1.45136203s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:31.310538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.858647Z","time spent":"1.451856811s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:31.310691Z","caller":"traceutil/trace.go:171","msg":"trace[132346391] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"1.451289478s","start":"2026-02-19T06:00:29.859367Z","end":"2026-02-19T06:00:31.310656Z","steps":["trace[132346391] 'process raft request' (duration: 1.450744357s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:31.31091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.859351Z","time spent":"1.451419132s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:31.310654Z","caller":"traceutil/trace.go:171","msg":"trace[1542944546] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"1.452272129s","start":"2026-02-19T06:00:29.85825Z","end":"2026-02-19T06:00:31.310522Z","steps":["trace[1542944546] 'process raft request' (duration: 1.063727729s)","trace[1542944546] 'compare' (duration: 387.386686ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:31.311394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.858231Z","time spent":"1.453059257s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:31.72879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.628679ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-19T06:00:31.729071Z","caller":"traceutil/trace.go:171","msg":"trace[292497437] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:994; }","duration":"1.873402062s","start":"2026-02-19T06:00:29.855652Z","end":"2026-02-19T06:00:31.729054Z","steps":["trace[292497437] 'read index received' (duration: 813.586966ms)","trace[292497437] 'applied index is now lower than readState.Index' (duration: 1.059814186s)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:31.729086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.960746Z","time spent":"1.768323821s","remote":"127.0.0.1:48162","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-19T06:00:31.729097Z","caller":"traceutil/trace.go:171","msg":"trace[306702644] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"1.348331124s","start":"2026-02-19T06:00:30.380727Z","end":"2026-02-19T06:00:31.729058Z","steps":["trace[306702644] 'process raft request' (duration: 1.348218351s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:31.729248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.873582785s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T06:00:31.729238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:30.380704Z","time spent":"1.348464666s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:31.729328Z","caller":"traceutil/trace.go:171","msg":"trace[157936530] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:960; }","duration":"1.873699268s","start":"2026-02-19T06:00:29.855614Z","end":"2026-02-19T06:00:31.729314Z","steps":["trace[157936530] 'agreement among raft nodes before linearized reading' (duration: 1.873536805s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:31.729366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.855602Z","time spent":"1.873756479s","remote":"127.0.0.1:48098","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-19T06:00:31.729448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.75995204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-02-19T06:00:31.7295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.088312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T06:00:31.72953Z","caller":"traceutil/trace.go:171","msg":"trace[1436044415] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:960; }","duration":"1.760052212s","start":"2026-02-19T06:00:29.969448Z","end":"2026-02-19T06:00:31.7295Z","steps":["trace[1436044415] 'agreement among raft nodes before linearized reading' (duration: 1.759737026s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:31.729584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:29.969432Z","time spent":"1.760139594s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-19T06:00:31.72953Z","caller":"traceutil/trace.go:171","msg":"trace[1418982031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:960; }","duration":"112.142783ms","start":"2026-02-19T06:00:31.617378Z","end":"2026-02-19T06:00:31.729521Z","steps":["trace[1418982031] 'agreement among raft nodes before linearized reading' (duration: 112.096342ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:31.729738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.516958ms","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-19T06:00:31.72978Z","caller":"traceutil/trace.go:171","msg":"trace[146842189] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:960; }","duration":"611.59315ms","start":"2026-02-19T06:00:31.118177Z","end":"2026-02-19T06:00:31.72977Z","steps":["trace[146842189] 'agreement among raft nodes before linearized reading' (duration: 611.473617ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:31.729809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:31.118156Z","time spent":"611.646142ms","remote":"127.0.0.1:48358","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-19T06:00:32.240273Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770025020,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T06:00:32.604274Z","caller":"traceutil/trace.go:171","msg":"trace[630892829] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"872.856397ms","start":"2026-02-19T06:00:31.731397Z","end":"2026-02-19T06:00:32.604254Z","steps":["trace[630892829] 'process raft request' (duration: 872.742345ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:32.604393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:31.731279Z","time spent":"873.057641ms","remote":"127.0.0.1:48162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":872,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T06:00:33.271141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.393923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T06:00:33.271353Z","caller":"traceutil/trace.go:171","msg":"trace[272058647] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1000; }","duration":"1.531555954s","start":"2026-02-19T06:00:31.739776Z","end":"2026-02-19T06:00:33.271332Z","steps":["trace[272058647] 'read index received' (duration: 864.346563ms)","trace[272058647] 'applied index is now lower than readState.Index' (duration: 667.208491ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T06:00:33.271433Z","caller":"traceutil/trace.go:171","msg":"trace[1129110241] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"1.536754006s","start":"2026-02-19T06:00:31.734665Z","end":"2026-02-19T06:00:33.27142Z","steps":["trace[1129110241] 'process raft request' (duration: 955.992345ms)","trace[1129110241] 'compare' (duration: 580.24542ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:33.27151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:31.734644Z","time spent":"1.536822838s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:33.271823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.532006624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T06:00:33.273047Z","caller":"traceutil/trace.go:171","msg":"trace[999319367] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:963; }","duration":"1.533265692s","start":"2026-02-19T06:00:31.739759Z","end":"2026-02-19T06:00:33.273024Z","steps":["trace[999319367] 'agreement among raft nodes before linearized reading' (duration: 1.531971004s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:33.273368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:31.739751Z","time spent":"1.533605899s","remote":"127.0.0.1:48098","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-19T06:00:33.272305Z","caller":"traceutil/trace.go:171","msg":"trace[101122520] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"1.536701117s","start":"2026-02-19T06:00:31.735548Z","end":"2026-02-19T06:00:33.272249Z","steps":["trace[101122520] 'process raft request' (duration: 1.535681384s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:33.273552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:31.735506Z","time spent":"1.537985174s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:34.071046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.459005ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-19T06:00:34.071138Z","caller":"traceutil/trace.go:171","msg":"trace[1456800054] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1003; }","duration":"799.733432ms","start":"2026-02-19T06:00:33.271388Z","end":"2026-02-19T06:00:34.071122Z","steps":["trace[1456800054] 'read index received' (duration: 140.021411ms)","trace[1456800054] 'applied index is now lower than readState.Index' (duration: 659.708921ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T06:00:34.071149Z","caller":"traceutil/trace.go:171","msg":"trace[1366462071] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"1.119089271s","start":"2026-02-19T06:00:32.952041Z","end":"2026-02-19T06:00:34.07113Z","steps":["trace[1366462071] 'process raft request' (duration: 459.480263ms)","trace[1366462071] 'compare' (duration: 659.179899ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:34.071227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:32.952015Z","time spent":"1.119174243s","remote":"127.0.0.1:48162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T06:00:34.071303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.58023783s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T06:00:34.071332Z","caller":"traceutil/trace.go:171","msg":"trace[656174666] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:964; }","duration":"1.580323212s","start":"2026-02-19T06:00:32.491Z","end":"2026-02-19T06:00:34.071323Z","steps":["trace[656174666] 'agreement among raft nodes before linearized reading' (duration: 1.580192099s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:34.07136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:32.490984Z","time spent":"1.580368983s","remote":"127.0.0.1:48396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-02-19T06:00:34.071503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.661383168s","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-19T06:00:34.071528Z","caller":"traceutil/trace.go:171","msg":"trace[1750606112] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:964; }","duration":"1.661442798s","start":"2026-02-19T06:00:32.410079Z","end":"2026-02-19T06:00:34.071521Z","steps":["trace[1750606112] 'agreement among raft nodes before linearized reading' (duration: 1.661397567s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:34.071564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:32.410066Z","time spent":"1.661488609s","remote":"127.0.0.1:48562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-02-19T06:00:34.071647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.167855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T06:00:34.071725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.875078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-19T06:00:34.071723Z","caller":"traceutil/trace.go:171","msg":"trace[627153650] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:964; }","duration":"789.287587ms","start":"2026-02-19T06:00:33.282415Z","end":"2026-02-19T06:00:34.071703Z","steps":["trace[627153650] 'agreement among raft nodes before linearized reading' (duration: 789.138194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:34.071725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.745396ms","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-19T06:00:34.071764Z","caller":"traceutil/trace.go:171","msg":"trace[1209346017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:964; }","duration":"755.9449ms","start":"2026-02-19T06:00:33.315807Z","end":"2026-02-19T06:00:34.071752Z","steps":["trace[1209346017] 'agreement among raft nodes before linearized reading' (duration: 755.820078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:34.071768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.76075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T06:00:34.071776Z","caller":"traceutil/trace.go:171","msg":"trace[1770131493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:964; }","duration":"755.822288ms","start":"2026-02-19T06:00:33.315942Z","end":"2026-02-19T06:00:34.071764Z","steps":["trace[1770131493] 'agreement among raft nodes before linearized reading' (duration: 755.658284ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:34.071774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:33.282372Z","time spent":"789.39514ms","remote":"127.0.0.1:48084","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-19T06:00:34.071795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:33.315797Z","time spent":"755.990961ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T06:00:34.071805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:33.315911Z","time spent":"755.888269ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T06:00:34.071797Z","caller":"traceutil/trace.go:171","msg":"trace[1476687125] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:964; }","duration":"725.824922ms","start":"2026-02-19T06:00:33.345964Z","end":"2026-02-19T06:00:34.071788Z","steps":["trace[1476687125] 'agreement among raft nodes before linearized reading' (duration: 725.784091ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:34.071802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.94627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-19T06:00:34.071833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:33.345941Z","time spent":"725.885144ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-02-19T06:00:34.071848Z","caller":"traceutil/trace.go:171","msg":"trace[435098277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:964; }","duration":"756.033242ms","start":"2026-02-19T06:00:33.315802Z","end":"2026-02-19T06:00:34.071835Z","steps":["trace[435098277] 'agreement among raft nodes before linearized reading' (duration: 755.891699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:34.071874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:33.315778Z","time spent":"756.091693ms","remote":"127.0.0.1:48358","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-19T06:00:34.63653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.579584ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T06:00:34.63662Z","caller":"traceutil/trace.go:171","msg":"trace[146788026] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1004; }","duration":"560.841555ms","start":"2026-02-19T06:00:34.075763Z","end":"2026-02-19T06:00:34.636604Z","steps":["trace[146788026] 'read index received' (duration: 248.129848ms)","trace[146788026] 'applied index is now lower than readState.Index' (duration: 312.710667ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:34.636826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.038909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T06:00:34.63682Z","caller":"traceutil/trace.go:171","msg":"trace[2141497007] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"561.867847ms","start":"2026-02-19T06:00:34.074927Z","end":"2026-02-19T06:00:34.636795Z","steps":["trace[2141497007] 'process raft request' (duration: 248.949376ms)","trace[2141497007] 'compare' (duration: 312.40722ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T06:00:34.636882Z","caller":"traceutil/trace.go:171","msg":"trace[1583775337] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:965; }","duration":"561.127ms","start":"2026-02-19T06:00:34.075739Z","end":"2026-02-19T06:00:34.636866Z","steps":["trace[1583775337] 'agreement among raft nodes before linearized reading' (duration: 561.015088ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:34.636921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:34.075728Z","time spent":"561.180042ms","remote":"127.0.0.1:48172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-02-19T06:00:34.636942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:34.074912Z","time spent":"561.972359ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:35.206788Z","caller":"traceutil/trace.go:171","msg":"trace[41409678] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"1.13069259s","start":"2026-02-19T06:00:34.07608Z","end":"2026-02-19T06:00:35.206773Z","steps":["trace[41409678] 'process raft request' (duration: 1.130653249s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:35.206889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:34.076065Z","time spent":"1.130770481s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:35.20706Z","caller":"traceutil/trace.go:171","msg":"trace[1190942112] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"1.130988087s","start":"2026-02-19T06:00:34.076046Z","end":"2026-02-19T06:00:35.207034Z","steps":["trace[1190942112] 'process raft request' (duration: 1.056099566s)","trace[1190942112] 'compare' (duration: 74.131724ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:35.207182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:34.076034Z","time spent":"1.131077898s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:35.244373Z","caller":"traceutil/trace.go:171","msg":"trace[1769866499] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"713.232742ms","start":"2026-02-19T06:00:34.531103Z","end":"2026-02-19T06:00:35.244336Z","steps":["trace[1769866499] 'process raft request' (duration: 713.035386ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T06:00:35.244487Z","caller":"traceutil/trace.go:171","msg":"trace[1176481738] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"605.221937ms","start":"2026-02-19T06:00:34.639243Z","end":"2026-02-19T06:00:35.244465Z","steps":["trace[1176481738] 'process raft request' (duration: 605.047624ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:35.24453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:34.531073Z","time spent":"713.379355ms","remote":"127.0.0.1:48162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T06:00:35.244566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:34.639217Z","time spent":"605.30753ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T06:00:35.244592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.928518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-19T06:00:35.244671Z","caller":"traceutil/trace.go:171","msg":"trace[1375274373] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:1; response_revision:969; }","duration":"741.054519ms","start":"2026-02-19T06:00:34.503606Z","end":"2026-02-19T06:00:35.24466Z","steps":["trace[1375274373] 'agreement among raft nodes before linearized reading' (duration: 740.813474ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T06:00:35.24437Z","caller":"traceutil/trace.go:171","msg":"trace[780468121] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1005; }","duration":"607.693492ms","start":"2026-02-19T06:00:34.636644Z","end":"2026-02-19T06:00:35.244337Z","steps":["trace[780468121] 'read index received' (duration: 495.373765ms)","trace[780468121] 'applied index is now lower than readState.Index' (duration: 112.318747ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:35.244705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:34.503586Z","time spent":"741.111341ms","remote":"127.0.0.1:48118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.74\" "} {"level":"warn","ts":"2026-02-19T06:00:35.747716Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770025037,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T06:00:36.163915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.601669ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-02-19T06:00:36.163998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:35.246206Z","time spent":"917.788382ms","remote":"127.0.0.1:48118","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-19T06:00:36.186993Z","caller":"traceutil/trace.go:171","msg":"trace[2105630312] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1009; }","duration":"939.350095ms","start":"2026-02-19T06:00:35.247625Z","end":"2026-02-19T06:00:36.186976Z","steps":["trace[2105630312] 'read index received' (duration: 580.6771ms)","trace[2105630312] 'applied index is now lower than readState.Index' (duration: 358.672045ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T06:00:36.187034Z","caller":"traceutil/trace.go:171","msg":"trace[2046150770] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"938.072338ms","start":"2026-02-19T06:00:35.248939Z","end":"2026-02-19T06:00:36.187011Z","steps":["trace[2046150770] 'process raft request' (duration: 937.876874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:36.18713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:35.248918Z","time spent":"938.15955ms","remote":"127.0.0.1:48162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":816,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T06:00:36.187199Z","caller":"traceutil/trace.go:171","msg":"trace[1923127133] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"936.604856ms","start":"2026-02-19T06:00:35.250527Z","end":"2026-02-19T06:00:36.187132Z","steps":["trace[1923127133] 'process raft request' (duration: 936.416682ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:36.187213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.56808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-02-19T06:00:36.187326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:35.250514Z","time spent":"936.76198ms","remote":"127.0.0.1:48162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T06:00:36.187402Z","caller":"traceutil/trace.go:171","msg":"trace[1388238665] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:971; }","duration":"939.783105ms","start":"2026-02-19T06:00:35.247586Z","end":"2026-02-19T06:00:36.18737Z","steps":["trace[1388238665] 'agreement among raft nodes before linearized reading' (duration: 939.488258ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:36.187596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:35.24757Z","time spent":"939.998999ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-19T06:00:36.187775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.477006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-19T06:00:36.187809Z","caller":"traceutil/trace.go:171","msg":"trace[648487935] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:972; }","duration":"911.547877ms","start":"2026-02-19T06:00:35.276252Z","end":"2026-02-19T06:00:36.1878Z","steps":["trace[648487935] 'agreement among raft nodes before linearized reading' (duration: 911.438464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:36.187836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:35.276232Z","time spent":"911.596408ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T06:00:36.187944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.146618ms","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-19T06:00:36.18802Z","caller":"traceutil/trace.go:171","msg":"trace[1978911788] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:972; }","duration":"911.247981ms","start":"2026-02-19T06:00:35.276758Z","end":"2026-02-19T06:00:36.188006Z","steps":["trace[1978911788] 'agreement among raft nodes before linearized reading' (duration: 910.954745ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:36.188084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:35.276747Z","time spent":"911.324462ms","remote":"127.0.0.1:48358","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-19T06:00:37.711071Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530391483770025052,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T06:00:37.77224Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.125798106s","expected-duration":"1s"} {"level":"info","ts":"2026-02-19T06:00:37.772647Z","caller":"traceutil/trace.go:171","msg":"trace[191841474] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"1.126247735s","start":"2026-02-19T06:00:36.646381Z","end":"2026-02-19T06:00:37.772629Z","steps":["trace[191841474] 'process raft request' (duration: 1.126077041s)"],"step_count":1} {"level":"info","ts":"2026-02-19T06:00:37.772689Z","caller":"traceutil/trace.go:171","msg":"trace[396130176] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1017; }","duration":"562.186603ms","start":"2026-02-19T06:00:37.210473Z","end":"2026-02-19T06:00:37.77266Z","steps":["trace[396130176] 'read index received' (duration: 562.163002ms)","trace[396130176] 'applied index is now lower than readState.Index' (duration: 7.43µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:37.772805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:36.646371Z","time spent":"1.126328507s","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T06:00:37.772984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.444798ms","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-19T06:00:37.773029Z","caller":"traceutil/trace.go:171","msg":"trace[480849772] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:976; }","duration":"562.54933ms","start":"2026-02-19T06:00:37.210469Z","end":"2026-02-19T06:00:37.773018Z","steps":["trace[480849772] 'agreement among raft nodes before linearized reading' (duration: 562.325756ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:37.773067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:37.210449Z","time spent":"562.610401ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T06:00:37.773214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.996433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T06:00:37.773252Z","caller":"traceutil/trace.go:171","msg":"trace[954984498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:976; }","duration":"532.061505ms","start":"2026-02-19T06:00:37.24118Z","end":"2026-02-19T06:00:37.773241Z","steps":["trace[954984498] 'agreement among raft nodes before linearized reading' (duration: 532.011194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:37.773254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.770215ms","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-19T06:00:37.773313Z","caller":"traceutil/trace.go:171","msg":"trace[603897350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:976; }","duration":"562.878927ms","start":"2026-02-19T06:00:37.210423Z","end":"2026-02-19T06:00:37.773302Z","steps":["trace[603897350] 'agreement among raft nodes before linearized reading' (duration: 562.719924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:37.773307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:37.241167Z","time spent":"532.131826ms","remote":"127.0.0.1:48084","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-19T06:00:37.773337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:37.210403Z","time spent":"562.927028ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-19T06:00:38.161465Z","caller":"traceutil/trace.go:171","msg":"trace[1064000973] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"384.111812ms","start":"2026-02-19T06:00:37.777328Z","end":"2026-02-19T06:00:38.16144Z","steps":["trace[1064000973] 'process raft request' (duration: 358.4323ms)","trace[1064000973] 'compare' (duration: 25.437037ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T06:00:38.161601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:37.777315Z","time spent":"384.214675ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:00:38.167934Z","caller":"traceutil/trace.go:171","msg":"trace[450006064] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"390.393677ms","start":"2026-02-19T06:00:37.777526Z","end":"2026-02-19T06:00:38.16792Z","steps":["trace[450006064] 'process raft request' (duration: 390.224243ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:00:38.168029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T06:00:37.777517Z","time spent":"390.463868ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T06:03:23.043836Z","caller":"traceutil/trace.go:171","msg":"trace[2067312334] transaction","detail":"{read_only:false; response_revision:1677; number_of_response:1; }","duration":"101.627364ms","start":"2026-02-19T06:03:22.942179Z","end":"2026-02-19T06:03:23.043806Z","steps":["trace[2067312334] 'process raft request' (duration: 101.4464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T06:03:53.469545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.08174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-19T06:03:53.469596Z","caller":"traceutil/trace.go:171","msg":"trace[1713163132] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"121.10116ms","start":"2026-02-19T06:03:53.348472Z","end":"2026-02-19T06:03:53.469573Z","steps":["trace[1713163132] 'process raft request' (duration: 120.677121ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T06:03:53.469671Z","caller":"traceutil/trace.go:171","msg":"trace[1888010214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1832; }","duration":"121.241424ms","start":"2026-02-19T06:03:53.348406Z","end":"2026-02-19T06:03:53.469647Z","steps":["trace[1888010214] 'agreement among raft nodes before linearized reading' (duration: 120.908787ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T06:03:53.545855Z","caller":"traceutil/trace.go:171","msg":"trace[1043738419] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"113.028948ms","start":"2026-02-19T06:03:53.432798Z","end":"2026-02-19T06:03:53.545827Z","steps":["trace[1043738419] 'process raft request' (duration: 107.97692ms)"],"step_count":1}