{"level":"warn","ts":"2026-03-04T16:24:57.596634Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-04T16:24:57.596742Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-03-04T16:24:57.596818Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-04T16:24:57.596834Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]}
{"level":"info","ts":"2026-03-04T16:24:57.596855Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-04T16:24:57.597526Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]}
{"level":"info","ts":"2026-03-04T16:24:57.597639Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-03-04T16:24:57.601403Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.545364ms"}
{"level":"info","ts":"2026-03-04T16:24:57.612007Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"}
{"level":"info","ts":"2026-03-04T16:24:57.612136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-04T16:24:57.612177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"}
{"level":"info","ts":"2026-03-04T16:24:57.612198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-04T16:24:57.612216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"}
{"level":"info","ts":"2026-03-04T16:24:57.612362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"}
{"level":"warn","ts":"2026-03-04T16:24:57.619733Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-04T16:24:57.621314Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-04T16:24:57.622901Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-03-04T16:24:57.626022Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-04T16:24:57.626466Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-04T16:24:57.62673Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-04T16:24:57.626994Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-04T16:24:57.62707Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-03-04T16:24:57.627964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"}
{"level":"info","ts":"2026-03-04T16:24:57.628925Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]}
{"level":"info","ts":"2026-03-04T16:24:57.630664Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-03-04T16:24:57.630858Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"}
{"level":"info","ts":"2026-03-04T16:24:57.630925Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"}
{"level":"info","ts":"2026-03-04T16:24:57.630893Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-04T16:24:57.630977Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-04T16:24:57.813434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-04T16:24:57.81349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-04T16:24:57.813522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"}
{"level":"info","ts":"2026-03-04T16:24:57.813535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"}
{"level":"info","ts":"2026-03-04T16:24:57.81354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"}
{"level":"info","ts":"2026-03-04T16:24:57.813549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"}
{"level":"info","ts":"2026-03-04T16:24:57.813555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"}
{"level":"info","ts":"2026-03-04T16:24:57.816756Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-04T16:24:57.816862Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-04T16:24:57.81699Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-04T16:24:57.817186Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-04T16:24:57.817445Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-04T16:24:57.817457Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-04T16:24:57.818504Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-04T16:24:57.818668Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-04T16:24:57.818726Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-04T16:24:57.818947Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"}
{"level":"info","ts":"2026-03-04T16:24:57.820322Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-04T16:25:04.885872Z","caller":"traceutil/trace.go:171","msg":"trace[847520529] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"602.265948ms","start":"2026-03-04T16:25:04.283588Z","end":"2026-03-04T16:25:04.885854Z","steps":["trace[847520529] 'process raft request'  (duration: 602.157733ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:04.886212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:04.283559Z","time spent":"602.382153ms","remote":"127.0.0.1:47386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":176,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/token-cleaner\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/token-cleaner\" value_size:118 >> failure:<>"}
{"level":"info","ts":"2026-03-04T16:25:05.533209Z","caller":"traceutil/trace.go:171","msg":"trace[167636088] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"105.003212ms","start":"2026-03-04T16:25:05.428172Z","end":"2026-03-04T16:25:05.533176Z","steps":["trace[167636088] 'process raft request'  (duration: 65.500739ms)","trace[167636088] 'compare'  (duration: 39.295133ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T16:25:05.533546Z","caller":"traceutil/trace.go:171","msg":"trace[1780115741] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"105.346387ms","start":"2026-03-04T16:25:05.428183Z","end":"2026-03-04T16:25:05.53353Z","steps":["trace[1780115741] 'process raft request'  (duration: 104.935568ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:05.53355Z","caller":"traceutil/trace.go:171","msg":"trace[1317431260] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"100.719739ms","start":"2026-03-04T16:25:05.432807Z","end":"2026-03-04T16:25:05.533527Z","steps":["trace[1317431260] 'process raft request'  (duration: 100.599604ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:06.621315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.562593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-04T16:25:06.621392Z","caller":"traceutil/trace.go:171","msg":"trace[514717264] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:330; }","duration":"738.700608ms","start":"2026-03-04T16:25:05.882673Z","end":"2026-03-04T16:25:06.621374Z","steps":["trace[514717264] 'range keys from in-memory index tree'  (duration: 738.465398ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:06.621425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:05.882657Z","time spent":"738.760532ms","remote":"127.0.0.1:47306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-03-04T16:25:09.528637Z","caller":"traceutil/trace.go:171","msg":"trace[1849687220] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"126.977155ms","start":"2026-03-04T16:25:09.401639Z","end":"2026-03-04T16:25:09.528616Z","steps":["trace[1849687220] 'process raft request'  (duration: 126.814567ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:10.275485Z","caller":"traceutil/trace.go:171","msg":"trace[2100026649] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"105.88717ms","start":"2026-03-04T16:25:10.169578Z","end":"2026-03-04T16:25:10.275465Z","steps":["trace[2100026649] 'process raft request'  (duration: 105.632108ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:12.942638Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724695307292573,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-04T16:25:13.031553Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.187410486s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-04T16:25:13.031833Z","caller":"traceutil/trace.go:171","msg":"trace[134838945] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"589.6579ms","start":"2026-03-04T16:25:12.442158Z","end":"2026-03-04T16:25:13.031816Z","steps":["trace[134838945] 'read index received'  (duration: 589.509573ms)","trace[134838945] 'applied index is now lower than readState.Index'  (duration: 147.387µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T16:25:13.031909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.730685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T16:25:13.031931Z","caller":"traceutil/trace.go:171","msg":"trace[994352691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:411; }","duration":"589.801148ms","start":"2026-03-04T16:25:12.442123Z","end":"2026-03-04T16:25:13.031924Z","steps":["trace[994352691] 'agreement among raft nodes before linearized reading'  (duration: 589.732804ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:13.031955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:12.442109Z","time spent":"589.84079ms","remote":"127.0.0.1:47186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-04T16:25:13.032178Z","caller":"traceutil/trace.go:171","msg":"trace[1795043872] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"1.188129221s","start":"2026-03-04T16:25:11.844006Z","end":"2026-03-04T16:25:13.032135Z","steps":["trace[1795043872] 'process raft request'  (duration: 1.18770988s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:13.032612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:11.84398Z","time spent":"1.188283188s","remote":"127.0.0.1:47370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:316 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7230 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"warn","ts":"2026-03-04T16:25:13.942593Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724695307292576,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-04T16:25:14.443644Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724695307292576,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-04T16:25:14.944281Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724695307292576,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-04T16:25:15.100767Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.058697756s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-04T16:25:15.101112Z","caller":"traceutil/trace.go:171","msg":"trace[1656014990] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"2.059079543s","start":"2026-03-04T16:25:13.042003Z","end":"2026-03-04T16:25:15.101082Z","steps":["trace[1656014990] 'process raft request'  (duration: 2.058946907s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:15.101212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:13.041989Z","time spent":"2.059156977s","remote":"127.0.0.1:47370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:406 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:6673 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" > >"}
{"level":"warn","ts":"2026-03-04T16:25:15.441712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999862869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-03-04T16:25:15.441836Z","caller":"traceutil/trace.go:171","msg":"trace[1532009941] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000064409s","start":"2026-03-04T16:25:13.441748Z","end":"2026-03-04T16:25:15.441812Z","steps":["trace[1532009941] 'agreement among raft nodes before linearized reading'  (duration: 1.999898911s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:15.44189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:13.441725Z","time spent":"2.000154873s","remote":"127.0.0.1:47170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-04T16:25:17.089189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.865344ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T16:25:17.089398Z","caller":"traceutil/trace.go:171","msg":"trace[1290337253] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:412; }","duration":"259.097855ms","start":"2026-03-04T16:25:16.83028Z","end":"2026-03-04T16:25:17.089378Z","steps":["trace[1290337253] 'range keys from in-memory index tree'  (duration: 258.847213ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:17.089629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.944861212s","expected-duration":"100ms","prefix":"","request":"header:<ID:8471724695307292578 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:277 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-04T16:25:17.090059Z","caller":"traceutil/trace.go:171","msg":"trace[196491456] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"4.02844681s","start":"2026-03-04T16:25:13.061575Z","end":"2026-03-04T16:25:17.090022Z","steps":["trace[196491456] 'process raft request'  (duration: 2.082960988s)","trace[196491456] 'compare'  (duration: 1.944668743s)"],"step_count":2}
{"level":"info","ts":"2026-03-04T16:25:17.090045Z","caller":"traceutil/trace.go:171","msg":"trace[581144442] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:427; }","duration":"3.648201837s","start":"2026-03-04T16:25:13.441805Z","end":"2026-03-04T16:25:17.090006Z","steps":["trace[581144442] 'read index received'  (duration: 1.659197302s)","trace[581144442] 'applied index is now lower than readState.Index'  (duration: 1.989002525s)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T16:25:17.090179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:13.061556Z","time spent":"4.028574887s","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:277 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-04T16:25:17.10164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.997519253s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"}
{"level":"warn","ts":"2026-03-04T16:25:17.101689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.488333591s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-03-04T16:25:17.101683Z","caller":"traceutil/trace.go:171","msg":"trace[710819802] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:413; }","duration":"1.997599747s","start":"2026-03-04T16:25:15.104073Z","end":"2026-03-04T16:25:17.101673Z","steps":["trace[710819802] 'agreement among raft nodes before linearized reading'  (duration: 1.997520413s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:17.101731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.436292839s","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-03-04T16:25:17.101742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:15.104014Z","time spent":"1.997721143s","remote":"127.0.0.1:47370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7327,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "}
{"level":"info","ts":"2026-03-04T16:25:17.101737Z","caller":"traceutil/trace.go:171","msg":"trace[604697444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:413; }","duration":"3.488403015s","start":"2026-03-04T16:25:13.613313Z","end":"2026-03-04T16:25:17.101716Z","steps":["trace[604697444] 'agreement among raft nodes before linearized reading'  (duration: 3.488351783s)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:17.101763Z","caller":"traceutil/trace.go:171","msg":"trace[1103640724] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:413; }","duration":"3.43631859s","start":"2026-03-04T16:25:13.665433Z","end":"2026-03-04T16:25:17.101752Z","steps":["trace[1103640724] 'agreement among raft nodes before linearized reading'  (duration: 3.436279378s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:17.101795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:13.665395Z","time spent":"3.436394173s","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-04T16:25:17.101767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.6592304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T16:25:17.101852Z","caller":"traceutil/trace.go:171","msg":"trace[1617842354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:413; }","duration":"1.659373437s","start":"2026-03-04T16:25:15.442458Z","end":"2026-03-04T16:25:17.101832Z","steps":["trace[1617842354] 'agreement among raft nodes before linearized reading'  (duration: 1.659210209s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:17.101909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:15.442402Z","time spent":"1.659498353s","remote":"127.0.0.1:47186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-04T16:25:17.101687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.488255508s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-04T16:25:17.101969Z","caller":"traceutil/trace.go:171","msg":"trace[1603859588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:413; }","duration":"3.488561142s","start":"2026-03-04T16:25:13.613388Z","end":"2026-03-04T16:25:17.101949Z","steps":["trace[1603859588] 'agreement among raft nodes before linearized reading'  (duration: 3.488241007s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:17.102042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:13.61337Z","time spent":"3.488651917s","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-04T16:25:17.101797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:13.613294Z","time spent":"3.488490329s","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-03-04T16:25:17.101637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.561166907s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-04T16:25:17.102184Z","caller":"traceutil/trace.go:171","msg":"trace[216913905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:413; }","duration":"3.561761795s","start":"2026-03-04T16:25:13.540412Z","end":"2026-03-04T16:25:17.102174Z","steps":["trace[216913905] 'agreement among raft nodes before linearized reading'  (duration: 3.561175787s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:17.102221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:13.54039Z","time spent":"3.561823208s","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-04T16:25:21.24544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.945432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-04T16:25:21.245534Z","caller":"traceutil/trace.go:171","msg":"trace[335372834] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:455; }","duration":"289.050276ms","start":"2026-03-04T16:25:20.956461Z","end":"2026-03-04T16:25:21.245511Z","steps":["trace[335372834] 'range keys from in-memory index tree'  (duration: 288.833656ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:41.038189Z","caller":"traceutil/trace.go:171","msg":"trace[137737909] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"373.502322ms","start":"2026-03-04T16:25:40.664654Z","end":"2026-03-04T16:25:41.038157Z","steps":["trace[137737909] 'process raft request'  (duration: 373.338744ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:41.038384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:40.664638Z","time spent":"373.650611ms","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:478 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-04T16:25:41.620047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.398607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-03-04T16:25:41.620106Z","caller":"traceutil/trace.go:171","msg":"trace[41022504] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:563; }","duration":"253.531376ms","start":"2026-03-04T16:25:41.366559Z","end":"2026-03-04T16:25:41.62009Z","steps":["trace[41022504] 'range keys from in-memory index tree'  (duration: 253.190659ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:41.620124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.734329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hkqgz\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-03-04T16:25:41.620194Z","caller":"traceutil/trace.go:171","msg":"trace[1352551376] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hkqgz; range_end:; response_count:1; response_revision:563; }","duration":"474.815367ms","start":"2026-03-04T16:25:41.145363Z","end":"2026-03-04T16:25:41.620178Z","steps":["trace[1352551376] 'range keys from in-memory index tree'  (duration: 474.56547ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:41.620175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.543021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-04T16:25:41.620226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:41.145306Z","time spent":"474.913116ms","remote":"127.0.0.1:47370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-hkqgz\" "}
{"level":"info","ts":"2026-03-04T16:25:41.620241Z","caller":"traceutil/trace.go:171","msg":"trace[1433067663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:563; }","duration":"238.62026ms","start":"2026-03-04T16:25:41.381604Z","end":"2026-03-04T16:25:41.620224Z","steps":["trace[1433067663] 'range keys from in-memory index tree'  (duration: 238.446303ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:41.620265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.631205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T16:25:41.620285Z","caller":"traceutil/trace.go:171","msg":"trace[499180105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"177.696654ms","start":"2026-03-04T16:25:41.442582Z","end":"2026-03-04T16:25:41.620278Z","steps":["trace[499180105] 'range keys from in-memory index tree'  (duration: 177.510096ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:41.620515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.864226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-04T16:25:41.620552Z","caller":"traceutil/trace.go:171","msg":"trace[1297574308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:563; }","duration":"244.933246ms","start":"2026-03-04T16:25:41.375606Z","end":"2026-03-04T16:25:41.620539Z","steps":["trace[1297574308] 'range keys from in-memory index tree'  (duration: 244.737308ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:41.620692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.887148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-04T16:25:41.620851Z","caller":"traceutil/trace.go:171","msg":"trace[662047421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:563; }","duration":"240.087276ms","start":"2026-03-04T16:25:41.380733Z","end":"2026-03-04T16:25:41.62082Z","steps":["trace[662047421] 'range keys from in-memory index tree'  (duration: 239.655281ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:42.275256Z","caller":"traceutil/trace.go:171","msg":"trace[1485134170] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"650.62027ms","start":"2026-03-04T16:25:41.624603Z","end":"2026-03-04T16:25:42.275224Z","steps":["trace[1485134170] 'process raft request'  (duration: 650.307152ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:42.275518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:41.624574Z","time spent":"650.849827ms","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:558 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-04T16:25:42.275618Z","caller":"traceutil/trace.go:171","msg":"trace[1821121924] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"650.973426ms","start":"2026-03-04T16:25:41.624579Z","end":"2026-03-04T16:25:42.275552Z","steps":["trace[1821121924] 'process raft request'  (duration: 650.58994ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:42.275897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:41.624544Z","time spent":"651.238574ms","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:555 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-04T16:25:42.436173Z","caller":"traceutil/trace.go:171","msg":"trace[1425363579] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"809.511297ms","start":"2026-03-04T16:25:41.626638Z","end":"2026-03-04T16:25:42.436149Z","steps":["trace[1425363579] 'process raft request'  (duration: 807.285698ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:42.436321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:41.626616Z","time spent":"809.632056ms","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:557 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-04T16:25:42.436844Z","caller":"traceutil/trace.go:171","msg":"trace[118030821] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"799.994486ms","start":"2026-03-04T16:25:41.63684Z","end":"2026-03-04T16:25:42.436835Z","steps":["trace[118030821] 'process raft request'  (duration: 799.910137ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:42.436877Z","caller":"traceutil/trace.go:171","msg":"trace[1942088732] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"810.135451ms","start":"2026-03-04T16:25:41.626717Z","end":"2026-03-04T16:25:42.436852Z","steps":["trace[1942088732] 'process raft request'  (duration: 809.350359ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:42.437302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:41.63682Z","time spent":"800.375993ms","remote":"127.0.0.1:47370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-hkqgz\" mod_revision:515 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-hkqgz\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-hkqgz\" > >"}
{"level":"warn","ts":"2026-03-04T16:25:42.437365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:41.626691Z","time spent":"810.613967ms","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:556 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-04T16:25:43.738532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.310094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T16:25:43.738631Z","caller":"traceutil/trace.go:171","msg":"trace[1513607738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:568; }","duration":"296.452513ms","start":"2026-03-04T16:25:43.442155Z","end":"2026-03-04T16:25:43.738607Z","steps":["trace[1513607738] 'range keys from in-memory index tree'  (duration: 296.201675ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:44.677512Z","caller":"traceutil/trace.go:171","msg":"trace[62819106] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"393.727013ms","start":"2026-03-04T16:25:44.283763Z","end":"2026-03-04T16:25:44.67749Z","steps":["trace[62819106] 'process raft request'  (duration: 393.549904ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:44.677803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:44.283745Z","time spent":"393.939971ms","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:565 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-04T16:25:44.678007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.397002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T16:25:44.678058Z","caller":"traceutil/trace.go:171","msg":"trace[1790228206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"235.522462ms","start":"2026-03-04T16:25:44.442525Z","end":"2026-03-04T16:25:44.678047Z","steps":["trace[1790228206] 'agreement among raft nodes before linearized reading'  (duration: 235.355313ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:44.677832Z","caller":"traceutil/trace.go:171","msg":"trace[1911982342] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:590; }","duration":"235.217164ms","start":"2026-03-04T16:25:44.442589Z","end":"2026-03-04T16:25:44.677806Z","steps":["trace[1911982342] 'read index received'  (duration: 234.793847ms)","trace[1911982342] 'applied index is now lower than readState.Index'  (duration: 421.577µs)"],"step_count":2}
{"level":"info","ts":"2026-03-04T16:25:44.678262Z","caller":"traceutil/trace.go:171","msg":"trace[731488633] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"394.470306ms","start":"2026-03-04T16:25:44.283752Z","end":"2026-03-04T16:25:44.678223Z","steps":["trace[731488633] 'process raft request'  (duration: 393.700273ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:44.67842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T16:25:44.283709Z","time spent":"394.635735ms","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:564 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-04T16:25:44.678472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.64712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-03-04T16:25:44.678507Z","caller":"traceutil/trace.go:171","msg":"trace[809556194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:570; }","duration":"235.70226ms","start":"2026-03-04T16:25:44.442795Z","end":"2026-03-04T16:25:44.678497Z","steps":["trace[809556194] 'agreement among raft nodes before linearized reading'  (duration: 235.586001ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:44.678721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.961079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-04T16:25:44.678796Z","caller":"traceutil/trace.go:171","msg":"trace[1610013359] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:570; }","duration":"236.065308ms","start":"2026-03-04T16:25:44.442709Z","end":"2026-03-04T16:25:44.678775Z","steps":["trace[1610013359] 'agreement among raft nodes before linearized reading'  (duration: 235.521781ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:46.584141Z","caller":"traceutil/trace.go:171","msg":"trace[691128727] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"276.638262ms","start":"2026-03-04T16:25:46.30748Z","end":"2026-03-04T16:25:46.584118Z","steps":["trace[691128727] 'process raft request'  (duration: 276.369564ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:25:49.608453Z","caller":"traceutil/trace.go:171","msg":"trace[178688175] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"167.05175ms","start":"2026-03-04T16:25:49.441377Z","end":"2026-03-04T16:25:49.608428Z","steps":["trace[178688175] 'read index received'  (duration: 166.279834ms)","trace[178688175] 'applied index is now lower than readState.Index'  (duration: 770.856µs)"],"step_count":2}
{"level":"info","ts":"2026-03-04T16:25:49.608668Z","caller":"traceutil/trace.go:171","msg":"trace[1775519499] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"265.728005ms","start":"2026-03-04T16:25:49.342925Z","end":"2026-03-04T16:25:49.608653Z","steps":["trace[1775519499] 'process raft request'  (duration: 264.940699ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:49.608806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.376099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"}
{"level":"info","ts":"2026-03-04T16:25:49.608866Z","caller":"traceutil/trace.go:171","msg":"trace[1322206711] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:641; }","duration":"111.51425ms","start":"2026-03-04T16:25:49.497336Z","end":"2026-03-04T16:25:49.608851Z","steps":["trace[1322206711] 'agreement among raft nodes before linearized reading'  (duration: 111.29308ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:25:49.609239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.841737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T16:25:49.609301Z","caller":"traceutil/trace.go:171","msg":"trace[1103455709] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"167.940647ms","start":"2026-03-04T16:25:49.441343Z","end":"2026-03-04T16:25:49.609284Z","steps":["trace[1103455709] 'agreement among raft nodes before linearized reading'  (duration: 167.262829ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:27:01.266412Z","caller":"traceutil/trace.go:171","msg":"trace[1050428924] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"144.251332ms","start":"2026-03-04T16:27:01.122128Z","end":"2026-03-04T16:27:01.26638Z","steps":["trace[1050428924] 'process raft request'  (duration: 111.411074ms)","trace[1050428924] 'compare'  (duration: 32.724645ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T16:27:01.266702Z","caller":"traceutil/trace.go:171","msg":"trace[1493168283] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"144.235001ms","start":"2026-03-04T16:27:01.122455Z","end":"2026-03-04T16:27:01.26669Z","steps":["trace[1493168283] 'process raft request'  (duration: 144.18813ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T16:27:31.709424Z","caller":"traceutil/trace.go:171","msg":"trace[966987613] linearizableReadLoop","detail":"{readStateIndex:1108; appliedIndex:1107; }","duration":"128.014716ms","start":"2026-03-04T16:27:31.581386Z","end":"2026-03-04T16:27:31.709401Z","steps":["trace[966987613] 'read index received'  (duration: 109.891297ms)","trace[966987613] 'applied index is now lower than readState.Index'  (duration: 18.122249ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T16:27:31.709589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.173111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:1 size:363"}
{"level":"info","ts":"2026-03-04T16:27:31.709525Z","caller":"traceutil/trace.go:171","msg":"trace[265753199] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"133.884143ms","start":"2026-03-04T16:27:31.575601Z","end":"2026-03-04T16:27:31.709485Z","steps":["trace[265753199] 'process raft request'  (duration: 115.687212ms)","trace[265753199] 'compare'  (duration: 17.968793ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T16:27:31.709636Z","caller":"traceutil/trace.go:171","msg":"trace[924290425] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:1; response_revision:1060; }","duration":"128.260434ms","start":"2026-03-04T16:27:31.581352Z","end":"2026-03-04T16:27:31.709613Z","steps":["trace[924290425] 'agreement among raft nodes before linearized reading'  (duration: 128.163351ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T16:27:31.709736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.155177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-public\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-04T16:27:31.70981Z","caller":"traceutil/trace.go:171","msg":"trace[237716905] range","detail":"{range_begin:/registry/namespaces/kube-public; range_end:; response_count:1; response_revision:1060; }","duration":"116.272101ms","start":"2026-03-04T16:27:31.593514Z","end":"2026-03-04T16:27:31.709786Z","steps":["trace[237716905] 'agreement among raft nodes before linearized reading'  (duration: 116.144047ms)"],"step_count":1}